[20:59:16.711] New invocation is queued and will start shortly
[20:59:18.182] Starting the invocation (attempt 1)
[20:59:18.208] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/5df06cfe49b402d263444f298adcf30b04f6cd17"
[20:59:18.208] Popped gitiles commit info from properties and tags
[20:59:18.208] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:59:18.208] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:59:18.209] Buildbucket request:
{
"requestId": "8868877477354087280",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-cxx_consistency-build_only"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868877477354087280",
"job": "fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0df62ac36cd2f54f2a34dc7bc29c244c23cd0122"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0df62ac36cd2f54f2a34dc7bc29c244c23cd0122",
"title": "0df62ac36cd2f54f2a34dc7bc29c244c23cd0122",
"url": "https://fuchsia.googlesource.com/integration/+/0df62ac36cd2f54f2a34dc7bc29c244c23cd0122"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6a621cae740fdae1aad41af2f4b5b16d10ce8862"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6a621cae740fdae1aad41af2f4b5b16d10ce8862",
"title": "6a621cae740fdae1aad41af2f4b5b16d10ce8862",
"url": "https://fuchsia.googlesource.com/integration/+/6a621cae740fdae1aad41af2f4b5b16d10ce8862"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "13a110bca30c5d5f25bbcff8d1070bb6c6a0cacc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@13a110bca30c5d5f25bbcff8d1070bb6c6a0cacc",
"title": "13a110bca30c5d5f25bbcff8d1070bb6c6a0cacc",
"url": "https://fuchsia.googlesource.com/integration/+/13a110bca30c5d5f25bbcff8d1070bb6c6a0cacc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e43acd401d1e8e4b4eea1957a33c147b26ca1d1f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e43acd401d1e8e4b4eea1957a33c147b26ca1d1f",
"title": "e43acd401d1e8e4b4eea1957a33c147b26ca1d1f",
"url": "https://fuchsia.googlesource.com/integration/+/e43acd401d1e8e4b4eea1957a33c147b26ca1d1f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6b2e52cbcb788cf8153dc502b8bfb928cbd7b10c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6b2e52cbcb788cf8153dc502b8bfb928cbd7b10c",
"title": "6b2e52cbcb788cf8153dc502b8bfb928cbd7b10c",
"url": "https://fuchsia.googlesource.com/integration/+/6b2e52cbcb788cf8153dc502b8bfb928cbd7b10c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "52121b684c94e90d4c8748a53886369554815c01"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@52121b684c94e90d4c8748a53886369554815c01",
"title": "52121b684c94e90d4c8748a53886369554815c01",
"url": "https://fuchsia.googlesource.com/integration/+/52121b684c94e90d4c8748a53886369554815c01"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "07ae226739ff5392a0a102de56703b26a73cd49a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@07ae226739ff5392a0a102de56703b26a73cd49a",
"title": "07ae226739ff5392a0a102de56703b26a73cd49a",
"url": "https://fuchsia.googlesource.com/integration/+/07ae226739ff5392a0a102de56703b26a73cd49a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5df06cfe49b402d263444f298adcf30b04f6cd17"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5df06cfe49b402d263444f298adcf30b04f6cd17",
"title": "5df06cfe49b402d263444f298adcf30b04f6cd17",
"url": "https://fuchsia.googlesource.com/integration/+/5df06cfe49b402d263444f298adcf30b04f6cd17"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5df06cfe49b402d263444f298adcf30b04f6cd17",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868877477354087280"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:59:18.719] Scheduled build:
{
"id": "8703447415046506625",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-cxx_consistency-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-17T20:59:18.285438927Z",
"updateTime": "2025-09-17T20:59:18.285438927Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5df06cfe49b402d263444f298adcf30b04f6cd17",
"ref": "refs/heads/main"
}
}
}
[20:59:18.719] Task URL: https://cr-buildbucket.appspot.com/build/8703447415046506625
[20:59:18.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:2:0) after 6m47s
[20:59:19.629] Received PubSub notification, asking Buildbucket for the build status
[20:59:19.701] Build status: SCHEDULED
[20:59:28.090] Received PubSub notification, asking Buildbucket for the build status
[20:59:28.131] Build status: STARTED
[21:06:05.734] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:2:0)
[21:06:05.756] Build status: STARTED
[21:06:05.756] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:5:0) after 4m14s
[21:10:19.783] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:5:0)
[21:10:19.820] Build status: STARTED
[21:10:19.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:6:0) after 8m57s
[21:19:16.865] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:6:0)
[21:19:16.882] Build status: STARTED
[21:19:16.882] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:7:0) after 8m15s
[21:27:31.941] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:7:0)
[21:27:31.968] Build status: STARTED
[21:27:31.968] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:8:0) after 2m31s
[21:30:03.036] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:8:0)
[21:30:03.056] Build status: STARTED
[21:30:03.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:9:0) after 2m23s
[21:32:26.056] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:9:0)
[21:32:26.074] Build status: STARTED
[21:32:26.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:10:0) after 1m1s
[21:33:27.145] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:10:0)
[21:33:27.163] Build status: STARTED
[21:33:27.163] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:11:0) after 7m50s
[21:41:17.184] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:11:0)
[21:41:17.204] Build status: STARTED
[21:41:17.204] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:12:0) after 4m57s
[21:46:14.227] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:12:0)
[21:46:14.254] Build status: STARTED
[21:46:14.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:13:0) after 3m50s
[21:50:04.272] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:13:0)
[21:50:04.290] Build status: STARTED
[21:50:04.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:14:0) after 6m53s
[21:56:57.411] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:14:0)
[21:56:57.439] Build status: STARTED
[21:56:57.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:15:0) after 3m58s
[22:00:55.460] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:15:0)
[22:00:55.479] Build status: STARTED
[22:00:55.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:16:0) after 7m28s
[22:08:23.547] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:16:0)
[22:08:23.563] Build status: STARTED
[22:08:23.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:17:0) after 5m14s
[22:13:37.561] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:17:0)
[22:13:37.579] Build status: STARTED
[22:13:37.579] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:18:0) after 6m5s
[22:19:42.635] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:18:0)
[22:19:42.664] Build status: STARTED
[22:19:42.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:19:0) after 7m5s
[22:26:47.810] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:19:0)
[22:26:47.828] Build status: STARTED
[22:26:47.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-cxx_consistency-build_only-e5a0ec7f:8868877477354087280:20:0) after 2m43s
[22:28:21.585] Received PubSub notification, asking Buildbucket for the build status
[22:28:21.601] Build:
{
"id": "8703447415046506625",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-cxx_consistency-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-17T20:59:18.285438927Z",
"startTime": "2025-09-17T20:59:27.950524403Z",
"endTime": "2025-09-17T22:28:21.320157236Z",
"updateTime": "2025-09-17T22:28:21.320157236Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5df06cfe49b402d263444f298adcf30b04f6cd17",
"ref": "refs/heads/main"
}
}
}
[22:28:21.601] Invocation finished in 1h29m4.900079127s with status SUCCEEDED