[18:13:02.452] New invocation is queued and will start shortly
[18:13:03.522] Starting the invocation (attempt 1)
[18:13:03.548] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/112bdc9c5061172c4395823aa056b40b2986cec0"
[18:13:03.548] Popped gitiles commit info from properties and tags
[18:13:03.548] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:13:03.548] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:13:03.549] Buildbucket request:
{
"requestId": "8882839868948112528",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-lto"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882839868948112528",
"job": "fuchsia/global.ci-core.arm64-lto-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd81445e47ef35957e842f988c5f4bcdb8972136"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd81445e47ef35957e842f988c5f4bcdb8972136",
"title": "bd81445e47ef35957e842f988c5f4bcdb8972136",
"url": "https://fuchsia.googlesource.com/integration/+/bd81445e47ef35957e842f988c5f4bcdb8972136"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e6e7bad6a6c5dd10acc2c7d7d61c4bf1006402a3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e6e7bad6a6c5dd10acc2c7d7d61c4bf1006402a3",
"title": "e6e7bad6a6c5dd10acc2c7d7d61c4bf1006402a3",
"url": "https://fuchsia.googlesource.com/integration/+/e6e7bad6a6c5dd10acc2c7d7d61c4bf1006402a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f4f361a831504a7f5ec4817172a1ffc28e22eb5c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f4f361a831504a7f5ec4817172a1ffc28e22eb5c",
"title": "f4f361a831504a7f5ec4817172a1ffc28e22eb5c",
"url": "https://fuchsia.googlesource.com/integration/+/f4f361a831504a7f5ec4817172a1ffc28e22eb5c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e95c416f0a5e594ad13bfe52c89cc8a74078f359"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e95c416f0a5e594ad13bfe52c89cc8a74078f359",
"title": "e95c416f0a5e594ad13bfe52c89cc8a74078f359",
"url": "https://fuchsia.googlesource.com/integration/+/e95c416f0a5e594ad13bfe52c89cc8a74078f359"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "999cfa057c94ff38c52bf4b9613e10e1008e137a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@999cfa057c94ff38c52bf4b9613e10e1008e137a",
"title": "999cfa057c94ff38c52bf4b9613e10e1008e137a",
"url": "https://fuchsia.googlesource.com/integration/+/999cfa057c94ff38c52bf4b9613e10e1008e137a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2a94900798efa09d9b013afcb11a8e287439e376"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2a94900798efa09d9b013afcb11a8e287439e376",
"title": "2a94900798efa09d9b013afcb11a8e287439e376",
"url": "https://fuchsia.googlesource.com/integration/+/2a94900798efa09d9b013afcb11a8e287439e376"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d863099e6a8ddb9d26fe36f6944ac550cacc5ca3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d863099e6a8ddb9d26fe36f6944ac550cacc5ca3",
"title": "d863099e6a8ddb9d26fe36f6944ac550cacc5ca3",
"url": "https://fuchsia.googlesource.com/integration/+/d863099e6a8ddb9d26fe36f6944ac550cacc5ca3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e064054adac107504865b51acae97f02af4cb760"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e064054adac107504865b51acae97f02af4cb760",
"title": "e064054adac107504865b51acae97f02af4cb760",
"url": "https://fuchsia.googlesource.com/integration/+/e064054adac107504865b51acae97f02af4cb760"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "112bdc9c5061172c4395823aa056b40b2986cec0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@112bdc9c5061172c4395823aa056b40b2986cec0",
"title": "112bdc9c5061172c4395823aa056b40b2986cec0",
"url": "https://fuchsia.googlesource.com/integration/+/112bdc9c5061172c4395823aa056b40b2986cec0"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "112bdc9c5061172c4395823aa056b40b2986cec0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882839868948112528"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.arm64-lto-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:13:03.968] Scheduled build:
{
"id": "8717409807085733025",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-lto"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-16T18:13:03.602386852Z",
"updateTime": "2025-04-16T18:13:03.602386852Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "112bdc9c5061172c4395823aa056b40b2986cec0",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:13:03.968] Task URL: https://cr-buildbucket.appspot.com/build/8717409807085733025
[18:13:03.968] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:2:0) after 8m37s
[18:13:04.028] Received PubSub notification, asking Buildbucket for the build status
[18:13:04.050] Build status: SCHEDULED
[18:13:07.968] Received PubSub notification, asking Buildbucket for the build status
[18:13:07.999] Build status: STARTED
[18:21:41.042] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:2:0)
[18:21:41.071] Build status: STARTED
[18:21:41.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:5:0) after 5m3s
[18:26:44.093] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:5:0)
[18:26:44.122] Build status: STARTED
[18:26:44.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:6:0) after 4m6s
[18:30:50.183] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:6:0)
[18:30:50.211] Build status: STARTED
[18:30:50.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:7:0) after 7m55s
[18:38:45.256] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:7:0)
[18:38:45.275] Build status: STARTED
[18:38:45.275] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:8:0) after 6m11s
[18:44:56.357] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:8:0)
[18:44:56.374] Build status: STARTED
[18:44:56.374] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:9:0) after 5m27s
[18:50:23.448] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:9:0)
[18:50:23.478] Build status: STARTED
[18:50:23.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:10:0) after 9m26s
[18:59:49.545] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:10:0)
[18:59:49.561] Build status: STARTED
[18:59:49.561] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:11:0) after 3m38s
[19:03:27.555] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:11:0)
[19:03:27.578] Build status: STARTED
[19:03:27.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:12:0) after 4m0s
[19:07:27.650] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:12:0)
[19:07:27.672] Build status: STARTED
[19:07:27.672] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:13:0) after 6m11s
[19:13:38.748] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:13:0)
[19:13:38.768] Build status: STARTED
[19:13:38.768] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:14:0) after 4m32s
[19:18:10.841] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:14:0)
[19:18:10.891] Build status: STARTED
[19:18:10.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:15:0) after 8m5s
[19:26:15.915] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:15:0)
[19:26:15.935] Build status: STARTED
[19:26:15.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:16:0) after 4m46s
[19:31:01.983] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:16:0)
[19:31:01.999] Build status: STARTED
[19:31:01.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-lto-e5a0ec7f:8882839868948112528:17:0) after 9m34s
[19:32:05.057] Received PubSub notification, asking Buildbucket for the build status
[19:32:05.080] Build:
{
"id": "8717409807085733025",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-lto"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-16T18:13:03.602386852Z",
"startTime": "2025-04-16T18:13:07.775371119Z",
"endTime": "2025-04-16T19:32:04.554610417Z",
"updateTime": "2025-04-16T19:32:04.554610417Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "112bdc9c5061172c4395823aa056b40b2986cec0",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:32:05.080] Invocation finished in 1h19m2.63802032s with status SUCCEEDED