[00:47:18.660] New invocation is queued and will start shortly
[00:47:19.952] Starting the invocation (attempt 1)
[00:47:19.979] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/e0a282b816918ce2b1b291d5150e0ccb6bf18fae"
[00:47:19.979] Popped gitiles commit info from properties and tags
[00:47:19.979] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:47:19.980] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:47:19.980] Buildbucket request:
{
"requestId": "8907004453647006944",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-cxx20"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8907004453647006944",
"job": "fuchsia/core.arm64-cxx20-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "71e5466241ed70f901bfec648ca29ccfdce14afc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@71e5466241ed70f901bfec648ca29ccfdce14afc",
"title": "71e5466241ed70f901bfec648ca29ccfdce14afc",
"url": "https://fuchsia.googlesource.com/integration/+/71e5466241ed70f901bfec648ca29ccfdce14afc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "56a488389e4aad3fae8de8c00948e89ca623524d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@56a488389e4aad3fae8de8c00948e89ca623524d",
"title": "56a488389e4aad3fae8de8c00948e89ca623524d",
"url": "https://fuchsia.googlesource.com/integration/+/56a488389e4aad3fae8de8c00948e89ca623524d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b26d03ddfd0e24b81c658ee7011f9d2e6b81512f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b26d03ddfd0e24b81c658ee7011f9d2e6b81512f",
"title": "b26d03ddfd0e24b81c658ee7011f9d2e6b81512f",
"url": "https://fuchsia.googlesource.com/integration/+/b26d03ddfd0e24b81c658ee7011f9d2e6b81512f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "519fb40a566e9bee876e0a0b460e06c05c8e8f9b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@519fb40a566e9bee876e0a0b460e06c05c8e8f9b",
"title": "519fb40a566e9bee876e0a0b460e06c05c8e8f9b",
"url": "https://fuchsia.googlesource.com/integration/+/519fb40a566e9bee876e0a0b460e06c05c8e8f9b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6ae33196907d121efec7a27b6a4c288cf1cdee45"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6ae33196907d121efec7a27b6a4c288cf1cdee45",
"title": "6ae33196907d121efec7a27b6a4c288cf1cdee45",
"url": "https://fuchsia.googlesource.com/integration/+/6ae33196907d121efec7a27b6a4c288cf1cdee45"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "26b97f831b1b047d3ede9a761e8b3bb22fb8e22f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@26b97f831b1b047d3ede9a761e8b3bb22fb8e22f",
"title": "26b97f831b1b047d3ede9a761e8b3bb22fb8e22f",
"url": "https://fuchsia.googlesource.com/integration/+/26b97f831b1b047d3ede9a761e8b3bb22fb8e22f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7166742780f635606c50234e4a47e16d2cd65756"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7166742780f635606c50234e4a47e16d2cd65756",
"title": "7166742780f635606c50234e4a47e16d2cd65756",
"url": "https://fuchsia.googlesource.com/integration/+/7166742780f635606c50234e4a47e16d2cd65756"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bfd5c48fbe0a5aafd0cd90f574461153f14e9443"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bfd5c48fbe0a5aafd0cd90f574461153f14e9443",
"title": "bfd5c48fbe0a5aafd0cd90f574461153f14e9443",
"url": "https://fuchsia.googlesource.com/integration/+/bfd5c48fbe0a5aafd0cd90f574461153f14e9443"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ad3d3ad6d529fb5bb6e99b1a5c7f6dd779d325ce"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ad3d3ad6d529fb5bb6e99b1a5c7f6dd779d325ce",
"title": "ad3d3ad6d529fb5bb6e99b1a5c7f6dd779d325ce",
"url": "https://fuchsia.googlesource.com/integration/+/ad3d3ad6d529fb5bb6e99b1a5c7f6dd779d325ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "78d3b6856d26908166d48cd32f5a522bc69fed15"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@78d3b6856d26908166d48cd32f5a522bc69fed15",
"title": "78d3b6856d26908166d48cd32f5a522bc69fed15",
"url": "https://fuchsia.googlesource.com/integration/+/78d3b6856d26908166d48cd32f5a522bc69fed15"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "97bf4ede76f804248f727bc385c01bf1edbbb649"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@97bf4ede76f804248f727bc385c01bf1edbbb649",
"title": "97bf4ede76f804248f727bc385c01bf1edbbb649",
"url": "https://fuchsia.googlesource.com/integration/+/97bf4ede76f804248f727bc385c01bf1edbbb649"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1e6713ae6edfc0f340a2730937c2ecab124015a4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1e6713ae6edfc0f340a2730937c2ecab124015a4",
"title": "1e6713ae6edfc0f340a2730937c2ecab124015a4",
"url": "https://fuchsia.googlesource.com/integration/+/1e6713ae6edfc0f340a2730937c2ecab124015a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "23901b0f08549214913cb968afa5939f87a0680f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@23901b0f08549214913cb968afa5939f87a0680f",
"title": "23901b0f08549214913cb968afa5939f87a0680f",
"url": "https://fuchsia.googlesource.com/integration/+/23901b0f08549214913cb968afa5939f87a0680f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e0a282b816918ce2b1b291d5150e0ccb6bf18fae"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e0a282b816918ce2b1b291d5150e0ccb6bf18fae",
"title": "e0a282b816918ce2b1b291d5150e0ccb6bf18fae",
"url": "https://fuchsia.googlesource.com/integration/+/e0a282b816918ce2b1b291d5150e0ccb6bf18fae"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e0a282b816918ce2b1b291d5150e0ccb6bf18fae",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907004453647006944"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.arm64-cxx20-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:47:20.416] Scheduled build:
{
"id": "8741574391537710641",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-cxx20"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-24T00:47:20.043317079Z",
"updateTime": "2024-07-24T00:47:20.043317079Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e0a282b816918ce2b1b291d5150e0ccb6bf18fae",
"ref": "refs/heads/main"
}
}
}
[00:47:20.416] Task URL: https://cr-buildbucket.appspot.com/build/8741574391537710641
[00:47:20.416] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:2:0) after 6m2s
[00:47:21.463] Received PubSub notification, asking Buildbucket for the build status
[00:47:21.547] Build status: SCHEDULED
[00:47:25.869] Received PubSub notification, asking Buildbucket for the build status
[00:47:25.889] Build status: STARTED
[00:53:22.473] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:2:0)
[00:53:22.539] Build status: STARTED
[00:53:22.539] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:5:0) after 5m15s
[00:58:37.606] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:5:0)
[00:58:37.630] Build status: STARTED
[00:58:37.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:6:0) after 2m42s
[01:01:19.710] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:6:0)
[01:01:19.737] Build status: STARTED
[01:01:19.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:7:0) after 5m18s
[01:06:37.841] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:7:0)
[01:06:37.858] Build status: STARTED
[01:06:37.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:8:0) after 8m10s
[01:14:47.879] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:8:0)
[01:14:47.904] Build status: STARTED
[01:14:47.904] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:9:0) after 5m36s
[01:20:23.933] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:9:0)
[01:20:23.952] Build status: STARTED
[01:20:23.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:10:0) after 8m28s
[01:28:51.971] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:10:0)
[01:28:51.995] Build status: STARTED
[01:28:51.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:11:0) after 7m14s
[01:36:06.116] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:11:0)
[01:36:06.209] Build status: STARTED
[01:36:06.209] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:12:0) after 5m28s
[01:41:34.244] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:12:0)
[01:41:34.282] Build status: STARTED
[01:41:34.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:13:0) after 9m58s
[01:51:32.301] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:13:0)
[01:51:32.361] Build status: STARTED
[01:51:32.361] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:14:0) after 3m2s
[01:54:34.392] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:14:0)
[01:54:34.412] Build status: STARTED
[01:54:34.412] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:15:0) after 5m55s
[02:00:29.433] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:15:0)
[02:00:29.452] Build status: STARTED
[02:00:29.452] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:16:0) after 5m58s
[02:06:28.086] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:16:0)
[02:06:28.103] Build status: STARTED
[02:06:28.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-cxx20-e5a0ec7f:8907004453647006944:17:0) after 6m41s
[02:11:50.628] Received PubSub notification, asking Buildbucket for the build status
[02:11:50.708] Build:
{
"id": "8741574391537710641",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-cxx20"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-24T00:47:20.043317079Z",
"startTime": "2024-07-24T00:47:25.634820856Z",
"endTime": "2024-07-24T02:11:50.295954140Z",
"updateTime": "2024-07-24T02:11:50.295954140Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e0a282b816918ce2b1b291d5150e0ccb6bf18fae",
"ref": "refs/heads/main"
}
}
}
[02:11:50.708] Invocation finished in 1h24m32.060468154s with status SUCCEEDED