[18:05:10.436] New invocation is queued and will start shortly
[18:05:11.629] Starting the invocation (attempt 1)
[18:05:11.661] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/55ba6dd643545c3a20db8b14098d3b7da55735e9"
[18:05:11.661] Popped gitiles commit info from properties and tags
[18:05:11.661] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:05:11.661] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:05:11.661] Buildbucket request:
{
"requestId": "8887098421319429792",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8887098421319429792",
"job": "fuchsia/core.arm64-asan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e2928e2aa611dfbe8ba09fe5160565b051a371cb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e2928e2aa611dfbe8ba09fe5160565b051a371cb",
"title": "e2928e2aa611dfbe8ba09fe5160565b051a371cb",
"url": "https://fuchsia.googlesource.com/integration/+/e2928e2aa611dfbe8ba09fe5160565b051a371cb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ee832ec2f13d41da3c2cb099a9cc70ec4b69d257"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ee832ec2f13d41da3c2cb099a9cc70ec4b69d257",
"title": "ee832ec2f13d41da3c2cb099a9cc70ec4b69d257",
"url": "https://fuchsia.googlesource.com/integration/+/ee832ec2f13d41da3c2cb099a9cc70ec4b69d257"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "35a1351d88305190e420031347a03b5dfcac4fb5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@35a1351d88305190e420031347a03b5dfcac4fb5",
"title": "35a1351d88305190e420031347a03b5dfcac4fb5",
"url": "https://fuchsia.googlesource.com/integration/+/35a1351d88305190e420031347a03b5dfcac4fb5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b9b67625f0112a972cad35d2f38d2c109dabc85b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b9b67625f0112a972cad35d2f38d2c109dabc85b",
"title": "b9b67625f0112a972cad35d2f38d2c109dabc85b",
"url": "https://fuchsia.googlesource.com/integration/+/b9b67625f0112a972cad35d2f38d2c109dabc85b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "da17c8e805c4ef1d5a1775b3e2393f877f079beb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@da17c8e805c4ef1d5a1775b3e2393f877f079beb",
"title": "da17c8e805c4ef1d5a1775b3e2393f877f079beb",
"url": "https://fuchsia.googlesource.com/integration/+/da17c8e805c4ef1d5a1775b3e2393f877f079beb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2514e3e9dea521c6b365fd3cfd5c585c763ec3bd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2514e3e9dea521c6b365fd3cfd5c585c763ec3bd",
"title": "2514e3e9dea521c6b365fd3cfd5c585c763ec3bd",
"url": "https://fuchsia.googlesource.com/integration/+/2514e3e9dea521c6b365fd3cfd5c585c763ec3bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "35d4d54a70bf6cb787cb360bd2fecf20e724e345"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@35d4d54a70bf6cb787cb360bd2fecf20e724e345",
"title": "35d4d54a70bf6cb787cb360bd2fecf20e724e345",
"url": "https://fuchsia.googlesource.com/integration/+/35d4d54a70bf6cb787cb360bd2fecf20e724e345"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d3e00c6d5834806c1315b8f5a5f43f4bf121f515"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d3e00c6d5834806c1315b8f5a5f43f4bf121f515",
"title": "d3e00c6d5834806c1315b8f5a5f43f4bf121f515",
"url": "https://fuchsia.googlesource.com/integration/+/d3e00c6d5834806c1315b8f5a5f43f4bf121f515"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "40e7bef337249bc005a08ab49b5aa489dd4a848e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@40e7bef337249bc005a08ab49b5aa489dd4a848e",
"title": "40e7bef337249bc005a08ab49b5aa489dd4a848e",
"url": "https://fuchsia.googlesource.com/integration/+/40e7bef337249bc005a08ab49b5aa489dd4a848e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a931a9112134c562a90399826f9852c935d795c7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a931a9112134c562a90399826f9852c935d795c7",
"title": "a931a9112134c562a90399826f9852c935d795c7",
"url": "https://fuchsia.googlesource.com/integration/+/a931a9112134c562a90399826f9852c935d795c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "55ba6dd643545c3a20db8b14098d3b7da55735e9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@55ba6dd643545c3a20db8b14098d3b7da55735e9",
"title": "55ba6dd643545c3a20db8b14098d3b7da55735e9",
"url": "https://fuchsia.googlesource.com/integration/+/55ba6dd643545c3a20db8b14098d3b7da55735e9"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "55ba6dd643545c3a20db8b14098d3b7da55735e9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887098421319429792"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.arm64-asan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:05:12.080] Scheduled build:
{
"id": "8721668359286436401",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-28T18:05:11.743141155Z",
"updateTime": "2025-02-28T18:05:11.743141155Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "55ba6dd643545c3a20db8b14098d3b7da55735e9",
"ref": "refs/heads/main"
}
}
}
[18:05:12.081] Task URL: https://cr-buildbucket.appspot.com/build/8721668359286436401
[18:05:12.081] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:2:0) after 5m0s
[18:05:13.167] Received PubSub notification, asking Buildbucket for the build status
[18:05:13.206] Build status: SCHEDULED
[18:05:18.689] Received PubSub notification, asking Buildbucket for the build status
[18:05:18.716] Build status: STARTED
[18:10:12.134] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:2:0)
[18:10:12.155] Build status: STARTED
[18:10:12.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:5:0) after 7m5s
[18:17:17.223] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:5:0)
[18:17:17.327] Build status: STARTED
[18:17:17.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:6:0) after 8m35s
[18:25:52.395] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:6:0)
[18:25:52.413] Build status: STARTED
[18:25:52.413] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:7:0) after 3m21s
[18:29:13.465] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:7:0)
[18:29:13.506] Build status: STARTED
[18:29:13.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:8:0) after 9m57s
[18:39:10.526] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:8:0)
[18:39:10.551] Build status: STARTED
[18:39:10.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:9:0) after 9m35s
[18:48:45.580] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:9:0)
[18:48:45.606] Build status: STARTED
[18:48:45.606] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:10:0) after 9m34s
[18:58:19.615] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:10:0)
[18:58:19.638] Build status: STARTED
[18:58:19.638] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:11:0) after 6m50s
[19:05:09.702] Handling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:11:0)
[19:05:09.718] Build status: STARTED
[19:05:09.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.arm64-asan-e5a0ec7f:8887098421319429792:12:0) after 4m16s
[19:05:12.353] Received PubSub notification, asking Buildbucket for the build status
[19:05:12.377] Build:
{
"id": "8721668359286436401",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-28T18:05:11.743141155Z",
"startTime": "2025-02-28T18:05:18.076085420Z",
"endTime": "2025-02-28T19:05:11.967713002Z",
"updateTime": "2025-02-28T19:05:11.967713002Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "55ba6dd643545c3a20db8b14098d3b7da55735e9",
"ref": "refs/heads/main"
}
}
}
[19:05:12.377] Invocation finished in 1h0m1.956356983s with status SUCCEEDED