[17:09:18.635] New invocation is queued and will start shortly
[17:09:19.793] Starting the invocation (attempt 1)
[17:09:19.839] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/1cc4da2c4ab7c1f625c6ad4c01c71e2c1bebe974"
[17:09:19.839] Popped gitiles commit info from properties and tags
[17:09:19.839] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:09:19.839] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:09:19.839] Buildbucket request:
{
"requestId": "8883931042106597744",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-mac"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8883931042106597744",
"job": "fuchsia/global.ci-sdk-core-mac-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd3db4140d09600f8ac52d734eb5235249f18723"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd3db4140d09600f8ac52d734eb5235249f18723",
"title": "bd3db4140d09600f8ac52d734eb5235249f18723",
"url": "https://fuchsia.googlesource.com/integration/+/bd3db4140d09600f8ac52d734eb5235249f18723"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "363cebcc169cfa57471bf41c72ecc2e8a299e840"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@363cebcc169cfa57471bf41c72ecc2e8a299e840",
"title": "363cebcc169cfa57471bf41c72ecc2e8a299e840",
"url": "https://fuchsia.googlesource.com/integration/+/363cebcc169cfa57471bf41c72ecc2e8a299e840"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4de458aaabaac0ff46379481c4215aa7203e1d94"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4de458aaabaac0ff46379481c4215aa7203e1d94",
"title": "4de458aaabaac0ff46379481c4215aa7203e1d94",
"url": "https://fuchsia.googlesource.com/integration/+/4de458aaabaac0ff46379481c4215aa7203e1d94"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e1cf5e134582243ff66ca26ea2a8014e88e43d0d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e1cf5e134582243ff66ca26ea2a8014e88e43d0d",
"title": "e1cf5e134582243ff66ca26ea2a8014e88e43d0d",
"url": "https://fuchsia.googlesource.com/integration/+/e1cf5e134582243ff66ca26ea2a8014e88e43d0d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d5a87b053844c0dd88b4d4c7c4302dd23b605dd4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d5a87b053844c0dd88b4d4c7c4302dd23b605dd4",
"title": "d5a87b053844c0dd88b4d4c7c4302dd23b605dd4",
"url": "https://fuchsia.googlesource.com/integration/+/d5a87b053844c0dd88b4d4c7c4302dd23b605dd4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ab695b2308a58d793c3d85578a1901c4447a59b1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ab695b2308a58d793c3d85578a1901c4447a59b1",
"title": "ab695b2308a58d793c3d85578a1901c4447a59b1",
"url": "https://fuchsia.googlesource.com/integration/+/ab695b2308a58d793c3d85578a1901c4447a59b1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a9758bbb69697c11ce42cf1abdd13412879a5526"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a9758bbb69697c11ce42cf1abdd13412879a5526",
"title": "a9758bbb69697c11ce42cf1abdd13412879a5526",
"url": "https://fuchsia.googlesource.com/integration/+/a9758bbb69697c11ce42cf1abdd13412879a5526"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9451d09b8664e05ba1f6c377e9dd42538553bf57"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9451d09b8664e05ba1f6c377e9dd42538553bf57",
"title": "9451d09b8664e05ba1f6c377e9dd42538553bf57",
"url": "https://fuchsia.googlesource.com/integration/+/9451d09b8664e05ba1f6c377e9dd42538553bf57"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b8805321106eb0ce138ca6f46a102422143615fe"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b8805321106eb0ce138ca6f46a102422143615fe",
"title": "b8805321106eb0ce138ca6f46a102422143615fe",
"url": "https://fuchsia.googlesource.com/integration/+/b8805321106eb0ce138ca6f46a102422143615fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1cc4da2c4ab7c1f625c6ad4c01c71e2c1bebe974"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1cc4da2c4ab7c1f625c6ad4c01c71e2c1bebe974",
"title": "1cc4da2c4ab7c1f625c6ad4c01c71e2c1bebe974",
"url": "https://fuchsia.googlesource.com/integration/+/1cc4da2c4ab7c1f625c6ad4c01c71e2c1bebe974"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1cc4da2c4ab7c1f625c6ad4c01c71e2c1bebe974",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8883931042106597744"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-sdk-core-mac-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:09:20.340] Scheduled build:
{
"id": "8718500979995229265",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-mac"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-04T17:09:20.023277671Z",
"updateTime": "2025-04-04T17:09:20.023277671Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1cc4da2c4ab7c1f625c6ad4c01c71e2c1bebe974",
"ref": "refs/heads/main"
}
}
}
[17:09:20.340] Task URL: https://cr-buildbucket.appspot.com/build/8718500979995229265
[17:09:20.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:2:0) after 6m11s
[17:09:21.376] Received PubSub notification, asking Buildbucket for the build status
[17:09:21.414] Build status: SCHEDULED
[17:09:25.026] Received PubSub notification, asking Buildbucket for the build status
[17:09:25.042] Build status: STARTED
[17:15:31.378] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:2:0)
[17:15:31.401] Build status: STARTED
[17:15:31.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:5:0) after 4m14s
[17:19:45.414] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:5:0)
[17:19:45.443] Build status: STARTED
[17:19:45.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:6:0) after 5m33s
[17:25:18.457] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:6:0)
[17:25:18.481] Build status: STARTED
[17:25:18.481] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:7:0) after 7m13s
[17:32:31.546] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:7:0)
[17:32:31.599] Build status: STARTED
[17:32:31.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:8:0) after 1m51s
[17:34:22.613] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:8:0)
[17:34:22.640] Build status: STARTED
[17:34:22.640] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:9:0) after 7m34s
[17:41:56.666] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:9:0)
[17:41:56.707] Build status: STARTED
[17:41:56.707] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:10:0) after 9m31s
[17:51:27.802] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:10:0)
[17:51:27.868] Build status: STARTED
[17:51:27.868] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:11:0) after 5m28s
[17:56:55.934] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:11:0)
[17:56:55.956] Build status: STARTED
[17:56:55.956] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:12:0) after 4m5s
[18:01:01.034] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:12:0)
[18:01:01.060] Build status: STARTED
[18:01:01.060] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:13:0) after 6m8s
[18:07:09.192] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:13:0)
[18:07:09.207] Build status: STARTED
[18:07:09.207] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:14:0) after 7m19s
[18:14:28.242] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:14:0)
[18:14:28.260] Build status: STARTED
[18:14:28.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:15:0) after 1m27s
[18:15:55.278] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:15:0)
[18:15:55.295] Build status: STARTED
[18:15:55.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:16:0) after 8m8s
[18:24:03.309] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:16:0)
[18:24:03.333] Build status: STARTED
[18:24:03.333] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:17:0) after 4m40s
[18:28:43.350] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:17:0)
[18:28:43.375] Build status: STARTED
[18:28:43.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:18:0) after 7m20s
[18:36:03.469] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:18:0)
[18:36:03.491] Build status: STARTED
[18:36:03.491] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:19:0) after 7m47s
[18:43:50.525] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:19:0)
[18:43:50.542] Build status: STARTED
[18:43:50.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:20:0) after 4m0s
[18:47:50.574] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:20:0)
[18:47:50.647] Build status: STARTED
[18:47:50.647] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:21:0) after 3m37s
[18:51:27.680] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:21:0)
[18:51:27.698] Build status: STARTED
[18:51:27.698] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:22:0) after 7m58s
[18:59:25.719] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:22:0)
[18:59:25.735] Build status: STARTED
[18:59:25.735] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:23:0) after 4m17s
[19:03:42.753] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:23:0)
[19:03:42.814] Build status: STARTED
[19:03:42.814] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:24:0) after 5m27s
[19:09:09.954] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:24:0)
[19:09:09.975] Build status: STARTED
[19:09:09.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:25:0) after 5m52s
[19:15:02.018] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:25:0)
[19:15:02.036] Build status: STARTED
[19:15:02.049] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:26:0) after 1m17s
[19:16:19.078] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:26:0)
[19:16:19.095] Build status: STARTED
[19:16:19.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:27:0) after 6m3s
[19:22:22.128] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:27:0)
[19:22:22.146] Build status: STARTED
[19:22:22.146] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-sdk-core-mac-e5a0ec7f:8883931042106597744:28:0) after 7m57s
[19:25:46.445] Received PubSub notification, asking Buildbucket for the build status
[19:25:46.464] Build:
{
"id": "8718500979995229265",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-mac"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-04T17:09:20.023277671Z",
"startTime": "2025-04-04T17:09:24.757845616Z",
"endTime": "2025-04-04T19:25:46.141380980Z",
"updateTime": "2025-04-04T19:25:46.141380980Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1cc4da2c4ab7c1f625c6ad4c01c71e2c1bebe974",
"ref": "refs/heads/main"
}
}
}
[19:25:46.464] Invocation finished in 2h16m27.838477817s with status SUCCEEDED