[04:18:03.112] New invocation is queued and will start shortly
[04:18:04.166] Starting the invocation (attempt 1)
[04:18:04.194] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/3c0f72271b0fcc9ebfed79e1004ea4d5693f1a34"
[04:18:04.194] Popped gitiles commit info from properties and tags
[04:18:04.194] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:18:04.194] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:18:04.194] Buildbucket request:
{
"requestId": "8884341953375965760",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8884341953375965760",
"job": "fuchsia/toolchain.ci-rust-linux-x64-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "fbe5e555214c079d82985c40b44a3b992d695fab"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@fbe5e555214c079d82985c40b44a3b992d695fab",
"title": "fbe5e555214c079d82985c40b44a3b992d695fab",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/fbe5e555214c079d82985c40b44a3b992d695fab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "02899f86f5b6d3aa87e9809fa3ee0d91fa3df574"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@02899f86f5b6d3aa87e9809fa3ee0d91fa3df574",
"title": "02899f86f5b6d3aa87e9809fa3ee0d91fa3df574",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/02899f86f5b6d3aa87e9809fa3ee0d91fa3df574"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "2dfd2a2a242e920b7378328b87f901652d9d81be"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@2dfd2a2a242e920b7378328b87f901652d9d81be",
"title": "2dfd2a2a242e920b7378328b87f901652d9d81be",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/2dfd2a2a242e920b7378328b87f901652d9d81be"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d035ca7db384e125d1a5110cefb3872386fa692f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d035ca7db384e125d1a5110cefb3872386fa692f",
"title": "d035ca7db384e125d1a5110cefb3872386fa692f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d035ca7db384e125d1a5110cefb3872386fa692f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b1bc7255bb16f2500d5bdcbc17c06c2acd91c7f0"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b1bc7255bb16f2500d5bdcbc17c06c2acd91c7f0",
"title": "b1bc7255bb16f2500d5bdcbc17c06c2acd91c7f0",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b1bc7255bb16f2500d5bdcbc17c06c2acd91c7f0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "41bee761bb81888c09c0567377abdcacf564f6b9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@41bee761bb81888c09c0567377abdcacf564f6b9",
"title": "41bee761bb81888c09c0567377abdcacf564f6b9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/41bee761bb81888c09c0567377abdcacf564f6b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "4cfcafd5009df84defcf0335ead1f855a4a94aee"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@4cfcafd5009df84defcf0335ead1f855a4a94aee",
"title": "4cfcafd5009df84defcf0335ead1f855a4a94aee",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/4cfcafd5009df84defcf0335ead1f855a4a94aee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "1296a23bb4eeba423254d4c9f3f99f948616a11d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@1296a23bb4eeba423254d4c9f3f99f948616a11d",
"title": "1296a23bb4eeba423254d4c9f3f99f948616a11d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/1296a23bb4eeba423254d4c9f3f99f948616a11d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "eb424222582784ddf5d5aceb408980d4d3401e4d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@eb424222582784ddf5d5aceb408980d4d3401e4d",
"title": "eb424222582784ddf5d5aceb408980d4d3401e4d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/eb424222582784ddf5d5aceb408980d4d3401e4d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "f07a0d117faf37a4bfd6bc6ba91602b456b6b344"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@f07a0d117faf37a4bfd6bc6ba91602b456b6b344",
"title": "f07a0d117faf37a4bfd6bc6ba91602b456b6b344",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/f07a0d117faf37a4bfd6bc6ba91602b456b6b344"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a99b5339f4639615cc0f0cd60a6c1e75c17b1c03"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a99b5339f4639615cc0f0cd60a6c1e75c17b1c03",
"title": "a99b5339f4639615cc0f0cd60a6c1e75c17b1c03",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a99b5339f4639615cc0f0cd60a6c1e75c17b1c03"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "3c0f72271b0fcc9ebfed79e1004ea4d5693f1a34"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@3c0f72271b0fcc9ebfed79e1004ea4d5693f1a34",
"title": "3c0f72271b0fcc9ebfed79e1004ea4d5693f1a34",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/3c0f72271b0fcc9ebfed79e1004ea4d5693f1a34"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "3c0f72271b0fcc9ebfed79e1004ea4d5693f1a34",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8884341953375965760"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-rust-linux-x64-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:18:04.549] Scheduled build:
{
"id": "8718911891520231553",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-31T04:18:04.256610077Z",
"updateTime": "2025-03-31T04:18:04.256610077Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "3c0f72271b0fcc9ebfed79e1004ea4d5693f1a34",
"ref": "refs/heads/main"
}
},
"canary": true
}
[04:18:04.549] Task URL: https://cr-buildbucket.appspot.com/build/8718911891520231553
[04:18:04.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:2:0) after 2m57s
[04:18:06.844] Received PubSub notification, asking Buildbucket for the build status
[04:18:06.866] Build status: SCHEDULED
[04:18:09.612] Received PubSub notification, asking Buildbucket for the build status
[04:18:09.656] Build status: STARTED
[04:21:01.876] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:2:0)
[04:21:01.979] Build status: STARTED
[04:21:01.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:5:0) after 6m12s
[04:27:14.166] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:5:0)
[04:27:14.183] Build status: STARTED
[04:27:14.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:6:0) after 7m39s
[04:34:53.344] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:6:0)
[04:34:53.372] Build status: STARTED
[04:34:53.372] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:7:0) after 3m18s
[04:38:11.443] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:7:0)
[04:38:11.465] Build status: STARTED
[04:38:11.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:8:0) after 1m20s
[04:39:31.547] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:8:0)
[04:39:31.576] Build status: STARTED
[04:39:31.576] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:9:0) after 2m21s
[04:41:53.180] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:9:0)
[04:41:53.201] Build status: STARTED
[04:41:53.201] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:10:0) after 1m32s
[04:43:25.291] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:10:0)
[04:43:25.314] Build status: STARTED
[04:43:25.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:11:0) after 9m12s
[04:52:37.448] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:11:0)
[04:52:37.624] Build status: STARTED
[04:52:37.624] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:12:0) after 1m28s
[04:54:05.641] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:12:0)
[04:54:05.661] Build status: STARTED
[04:54:05.661] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:13:0) after 7m57s
[05:02:02.687] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:13:0)
[05:02:02.705] Build status: STARTED
[05:02:02.705] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:14:0) after 4m24s
[05:06:26.818] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:14:0)
[05:06:26.835] Build status: STARTED
[05:06:26.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust-linux-x64-49def413:8884341953375965760:15:0) after 4m19s
[05:08:59.907] Received PubSub notification, asking Buildbucket for the build status
[05:08:59.937] Build:
{
"id": "8718911891520231553",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-linux-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-31T04:18:04.256610077Z",
"startTime": "2025-03-31T04:18:08.120294569Z",
"endTime": "2025-03-31T05:08:59.617959587Z",
"updateTime": "2025-03-31T05:08:59.617959587Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "3c0f72271b0fcc9ebfed79e1004ea4d5693f1a34",
"ref": "refs/heads/main"
}
},
"canary": true
}
[05:08:59.937] Invocation finished in 50m56.835024399s with status SUCCEEDED