[15:13:22.664] New invocation is queued and will start shortly
[15:13:23.730] Starting the invocation (attempt 1)
[15:13:23.770] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/3e7514670db841a7f0d7656f3b13b1c8b2c11599"
[15:13:23.771] Popped gitiles commit info from properties and tags
[15:13:23.771] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:13:23.771] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:13:23.771] Buildbucket request:
{
"requestId": "8983685595983915808",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "975162d1bef80bfb642ef4069c72a30b1e9d2923"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@975162d1bef80bfb642ef4069c72a30b1e9d2923",
"title": "975162d1bef80bfb642ef4069c72a30b1e9d2923",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/975162d1bef80bfb642ef4069c72a30b1e9d2923"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "4558a125b6108f3c080e88d7746e1d422b969bef"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@4558a125b6108f3c080e88d7746e1d422b969bef",
"title": "4558a125b6108f3c080e88d7746e1d422b969bef",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/4558a125b6108f3c080e88d7746e1d422b969bef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "bef6f3e895beede5bfd5ba4bb12898615c156d59"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@bef6f3e895beede5bfd5ba4bb12898615c156d59",
"title": "bef6f3e895beede5bfd5ba4bb12898615c156d59",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/bef6f3e895beede5bfd5ba4bb12898615c156d59"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "983c12f7f6a51c10d41c825921e962b0b74e4bca"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@983c12f7f6a51c10d41c825921e962b0b74e4bca",
"title": "983c12f7f6a51c10d41c825921e962b0b74e4bca",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/983c12f7f6a51c10d41c825921e962b0b74e4bca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "afbecc0f68c4dcfc4878ba5bcb1ac942544a1bdc"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@afbecc0f68c4dcfc4878ba5bcb1ac942544a1bdc",
"title": "afbecc0f68c4dcfc4878ba5bcb1ac942544a1bdc",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/afbecc0f68c4dcfc4878ba5bcb1ac942544a1bdc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "0d0d9cd718b22e4db049bb5df14c9f29869ed5be"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@0d0d9cd718b22e4db049bb5df14c9f29869ed5be",
"title": "0d0d9cd718b22e4db049bb5df14c9f29869ed5be",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/0d0d9cd718b22e4db049bb5df14c9f29869ed5be"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "36a3ebde96b49832fe9b0f683d13348abc1cc503"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@36a3ebde96b49832fe9b0f683d13348abc1cc503",
"title": "36a3ebde96b49832fe9b0f683d13348abc1cc503",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/36a3ebde96b49832fe9b0f683d13348abc1cc503"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "260f17eafde04efeab63ceb0e83891a94fb710ad"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@260f17eafde04efeab63ceb0e83891a94fb710ad",
"title": "260f17eafde04efeab63ceb0e83891a94fb710ad",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/260f17eafde04efeab63ceb0e83891a94fb710ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a6153e8218e70e70f3c5d61adcb78d87d0e89152"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a6153e8218e70e70f3c5d61adcb78d87d0e89152",
"title": "a6153e8218e70e70f3c5d61adcb78d87d0e89152",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a6153e8218e70e70f3c5d61adcb78d87d0e89152"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "ee62514b16b610870e001b14f15e7e71b15e54e7"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@ee62514b16b610870e001b14f15e7e71b15e54e7",
"title": "ee62514b16b610870e001b14f15e7e71b15e54e7",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/ee62514b16b610870e001b14f15e7e71b15e54e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "00cf7af44aaecb5b91f58ec8f1737f6623f910d3"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@00cf7af44aaecb5b91f58ec8f1737f6623f910d3",
"title": "00cf7af44aaecb5b91f58ec8f1737f6623f910d3",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/00cf7af44aaecb5b91f58ec8f1737f6623f910d3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "01d4e835c1c7f7035efe6c187a0137dd2432c2c3"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@01d4e835c1c7f7035efe6c187a0137dd2432c2c3",
"title": "01d4e835c1c7f7035efe6c187a0137dd2432c2c3",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/01d4e835c1c7f7035efe6c187a0137dd2432c2c3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "46340f20497fd9f30e08d5c30413f6f45164da89"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@46340f20497fd9f30e08d5c30413f6f45164da89",
"title": "46340f20497fd9f30e08d5c30413f6f45164da89",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/46340f20497fd9f30e08d5c30413f6f45164da89"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "3e7514670db841a7f0d7656f3b13b1c8b2c11599"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@3e7514670db841a7f0d7656f3b13b1c8b2c11599",
"title": "3e7514670db841a7f0d7656f3b13b1c8b2c11599",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/3e7514670db841a7f0d7656f3b13b1c8b2c11599"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "3e7514670db841a7f0d7656f3b13b1c8b2c11599",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8983685595983915808"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-rust_test-x64-linux-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:13:24.239] Scheduled build:
{
"id": "8818255534088566193",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2022-03-30T15:13:23.840669554Z",
"updateTime": "2022-03-30T15:13:23.840669554Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "3e7514670db841a7f0d7656f3b13b1c8b2c11599",
"ref": "refs/heads/main"
}
}
}
[15:13:24.239] Task URL: https://cr-buildbucket.appspot.com/build/8818255534088566193
[15:13:24.239] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:2:0) after 8m43s
[15:13:30.332] Received PubSub notification, asking Buildbucket for the build status
[15:13:30.354] Build status: STARTED
[15:22:07.438] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:2:0)
[15:22:07.479] Build status: STARTED
[15:22:07.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:4:0) after 2m41s
[15:24:48.602] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:4:0)
[15:24:48.636] Build status: STARTED
[15:24:48.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:5:0) after 5m29s
[15:30:18.010] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:5:0)
[15:30:18.039] Build status: STARTED
[15:30:18.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:6:0) after 1m18s
[15:31:36.105] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:6:0)
[15:31:36.136] Build status: STARTED
[15:31:36.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:7:0) after 4m10s
[15:35:46.174] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:7:0)
[15:35:46.219] Build status: STARTED
[15:35:46.219] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:8:0) after 3m36s
[15:39:22.265] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:8:0)
[15:39:22.319] Build status: STARTED
[15:39:22.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:9:0) after 9m39s
[15:49:01.336] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:9:0)
[15:49:01.371] Build status: STARTED
[15:49:01.371] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:10:0) after 6m11s
[15:55:12.392] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:10:0)
[15:55:12.462] Build status: STARTED
[15:55:12.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:11:0) after 9m24s
[16:04:36.528] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:11:0)
[16:04:36.548] Build status: STARTED
[16:04:36.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:12:0) after 4m31s
[16:09:08.494] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:12:0)
[16:09:08.549] Build status: STARTED
[16:09:08.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:13:0) after 2m30s
[16:11:38.981] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:13:0)
[16:11:39.164] Build status: STARTED
[16:11:39.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:14:0) after 7m18s
[16:18:57.209] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:14:0)
[16:18:57.242] Build status: STARTED
[16:18:57.242] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:15:0) after 8m52s
[16:27:49.471] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:15:0)
[16:27:49.573] Build status: STARTED
[16:27:49.573] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:16:0) after 6m28s
[16:34:17.645] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:16:0)
[16:34:17.684] Build status: STARTED
[16:34:17.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:17:0) after 9m46s
[16:44:03.985] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:17:0)
[16:44:04.036] Build status: STARTED
[16:44:04.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8983685595983915808:18:0) after 8m0s
[16:51:45.667] Received PubSub notification, asking Buildbucket for the build status
[16:51:45.697] Build:
{
"id": "8818255534088566193",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2022-03-30T15:13:23.840669554Z",
"startTime": "2022-03-30T15:13:28.623992Z",
"endTime": "2022-03-30T16:51:45.265249272Z",
"updateTime": "2022-03-30T16:51:45.265249272Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "3e7514670db841a7f0d7656f3b13b1c8b2c11599",
"ref": "refs/heads/main"
}
}
}
[16:51:45.697] Invocation finished in 1h38m23.047415657s with status SUCCEEDED