[00:38:03.105] New invocation is queued and will start shortly
[00:38:05.549] Starting the invocation (attempt 1)
[00:38:05.602] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/36c8e291a617ae6bd4b8ff13c54c82862eaf0eec"
[00:38:05.602] Popped gitiles commit info from properties and tags
[00:38:05.602] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:38:05.602] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:38:05.602] Buildbucket request:
{
"requestId": "8966074258292253648",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8966074258292253648",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6add6a1e1e5681d8d80f48326795b734c7966518"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6add6a1e1e5681d8d80f48326795b734c7966518",
"title": "6add6a1e1e5681d8d80f48326795b734c7966518",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6add6a1e1e5681d8d80f48326795b734c7966518"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c23ed655eb1244cf0fb5d51d7bdb4e473b540e15"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c23ed655eb1244cf0fb5d51d7bdb4e473b540e15",
"title": "c23ed655eb1244cf0fb5d51d7bdb4e473b540e15",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c23ed655eb1244cf0fb5d51d7bdb4e473b540e15"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d9570e0510c87d4e7ba938005e506eb5cc7fc91b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d9570e0510c87d4e7ba938005e506eb5cc7fc91b",
"title": "d9570e0510c87d4e7ba938005e506eb5cc7fc91b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d9570e0510c87d4e7ba938005e506eb5cc7fc91b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "3416fa1882a9ea5b4d7c32b62afccbe9d01fb79a"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@3416fa1882a9ea5b4d7c32b62afccbe9d01fb79a",
"title": "3416fa1882a9ea5b4d7c32b62afccbe9d01fb79a",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/3416fa1882a9ea5b4d7c32b62afccbe9d01fb79a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "adc24d1b5efb768a8e81ec5a26133f2351c4dd3f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@adc24d1b5efb768a8e81ec5a26133f2351c4dd3f",
"title": "adc24d1b5efb768a8e81ec5a26133f2351c4dd3f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/adc24d1b5efb768a8e81ec5a26133f2351c4dd3f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "14de94aec59bcd535f690e255a950ca76fcf2d5a"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@14de94aec59bcd535f690e255a950ca76fcf2d5a",
"title": "14de94aec59bcd535f690e255a950ca76fcf2d5a",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/14de94aec59bcd535f690e255a950ca76fcf2d5a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d565200270d425ab2d72b06109314c786676f593"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d565200270d425ab2d72b06109314c786676f593",
"title": "d565200270d425ab2d72b06109314c786676f593",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d565200270d425ab2d72b06109314c786676f593"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "36c8e291a617ae6bd4b8ff13c54c82862eaf0eec"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@36c8e291a617ae6bd4b8ff13c54c82862eaf0eec",
"title": "36c8e291a617ae6bd4b8ff13c54c82862eaf0eec",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/36c8e291a617ae6bd4b8ff13c54c82862eaf0eec"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "36c8e291a617ae6bd4b8ff13c54c82862eaf0eec",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8966074258292253648"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust-x64-windows-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:38:05.971] Scheduled build:
{
"id": "8800644194918997953",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2022-10-11T00:38:05.683446775Z",
"updateTime": "2022-10-11T00:38:05.683446775Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "36c8e291a617ae6bd4b8ff13c54c82862eaf0eec",
"ref": "refs/heads/main"
}
}
}
[00:38:05.971] Task URL: https://cr-buildbucket.appspot.com/build/8800644194918997953
[00:38:05.971] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:2:0) after 4m55s
[00:38:20.407] Received PubSub notification, asking Buildbucket for the build status
[00:38:20.431] Build status: STARTED
[00:43:01.282] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:2:0)
[00:43:01.309] Build status: STARTED
[00:43:01.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:4:0) after 1m4s
[00:44:05.428] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:4:0)
[00:44:05.458] Build status: STARTED
[00:44:05.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:5:0) after 6m6s
[00:50:11.480] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:5:0)
[00:50:11.525] Build status: STARTED
[00:50:11.525] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:6:0) after 3m12s
[00:53:23.549] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:6:0)
[00:53:23.584] Build status: STARTED
[00:53:23.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:7:0) after 2m34s
[00:55:57.741] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:7:0)
[00:55:57.776] Build status: STARTED
[00:55:57.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:8:0) after 8m37s
[01:04:35.088] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:8:0)
[01:04:35.110] Build status: STARTED
[01:04:35.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:9:0) after 5m38s
[01:10:13.276] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:9:0)
[01:10:13.302] Build status: STARTED
[01:10:13.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8966074258292253648:10:0) after 8m16s
[01:16:57.796] Received PubSub notification, asking Buildbucket for the build status
[01:16:57.825] Build:
{
"id": "8800644194918997953",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2022-10-11T00:38:05.683446775Z",
"startTime": "2022-10-11T00:38:19.690364Z",
"endTime": "2022-10-11T01:16:57.294358612Z",
"updateTime": "2022-10-11T01:16:57.294358612Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "36c8e291a617ae6bd4b8ff13c54c82862eaf0eec",
"ref": "refs/heads/main"
}
}
}
[01:16:57.825] Invocation finished in 38m54.742026112s with status SUCCEEDED