[14:34:43.193] New invocation is queued and will start shortly
[14:34:44.281] Starting the invocation (attempt 1)
[14:34:44.330] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/ff2c56344c764af598ad33027e9c7a48881808ef"
[14:34:44.330] Popped gitiles commit info from properties and tags
[14:34:44.330] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:34:44.335] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:34:44.336] Buildbucket request:
{
"requestId": "8927427311989761360",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8927427311989761360",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "f481596ee4e761182f20eaf1b67d4431cd2d5556"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@f481596ee4e761182f20eaf1b67d4431cd2d5556",
"title": "f481596ee4e761182f20eaf1b67d4431cd2d5556",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/f481596ee4e761182f20eaf1b67d4431cd2d5556"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "af8dfde7f952ac35192bfcea0c665d669237cd97"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@af8dfde7f952ac35192bfcea0c665d669237cd97",
"title": "af8dfde7f952ac35192bfcea0c665d669237cd97",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/af8dfde7f952ac35192bfcea0c665d669237cd97"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "92b84f849a63af6454845452ee8a5567d6956302"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@92b84f849a63af6454845452ee8a5567d6956302",
"title": "92b84f849a63af6454845452ee8a5567d6956302",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/92b84f849a63af6454845452ee8a5567d6956302"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "7162cb95500a066da51bc8ba7929809ec02bc835"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@7162cb95500a066da51bc8ba7929809ec02bc835",
"title": "7162cb95500a066da51bc8ba7929809ec02bc835",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/7162cb95500a066da51bc8ba7929809ec02bc835"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "54d6bded3015e778481dd2889e2cf5e190433b28"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@54d6bded3015e778481dd2889e2cf5e190433b28",
"title": "54d6bded3015e778481dd2889e2cf5e190433b28",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/54d6bded3015e778481dd2889e2cf5e190433b28"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "f712d7310800dd258e4776cab0b9fb9767e693dc"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@f712d7310800dd258e4776cab0b9fb9767e693dc",
"title": "f712d7310800dd258e4776cab0b9fb9767e693dc",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/f712d7310800dd258e4776cab0b9fb9767e693dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c89672e1483be98b97a5532f0aca78d5470869f1"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c89672e1483be98b97a5532f0aca78d5470869f1",
"title": "c89672e1483be98b97a5532f0aca78d5470869f1",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c89672e1483be98b97a5532f0aca78d5470869f1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "ff2c56344c764af598ad33027e9c7a48881808ef"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@ff2c56344c764af598ad33027e9c7a48881808ef",
"title": "ff2c56344c764af598ad33027e9c7a48881808ef",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/ff2c56344c764af598ad33027e9c7a48881808ef"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "ff2c56344c764af598ad33027e9c7a48881808ef",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8927427311989761360"
},
{
"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"
}
}
[14:34:44.899] Scheduled build:
{
"id": "8761997249959769937",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-11T14:34:44.499100113Z",
"updateTime": "2023-12-11T14:34:44.499100113Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "ff2c56344c764af598ad33027e9c7a48881808ef",
"ref": "refs/heads/main"
}
}
}
[14:34:44.899] Task URL: https://cr-buildbucket.appspot.com/build/8761997249959769937
[14:34:44.899] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:2:0) after 2m11s
[14:34:45.891] Received PubSub notification, asking Buildbucket for the build status
[14:34:45.940] Build status: SCHEDULED
[14:34:50.661] Received PubSub notification, asking Buildbucket for the build status
[14:34:50.689] Build status: STARTED
[14:36:56.218] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:2:0)
[14:36:56.262] Build status: STARTED
[14:36:56.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:5:0) after 7m50s
[14:44:46.284] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:5:0)
[14:44:46.311] Build status: STARTED
[14:44:46.311] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:6:0) after 4m9s
[14:48:55.324] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:6:0)
[14:48:55.340] Build status: STARTED
[14:48:55.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:7:0) after 2m53s
[14:51:48.377] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:7:0)
[14:51:48.404] Build status: STARTED
[14:51:48.404] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:8:0) after 8m54s
[15:00:42.542] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:8:0)
[15:00:42.646] Build status: STARTED
[15:00:42.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:9:0) after 3m36s
[15:04:18.952] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:9:0)
[15:04:18.974] Build status: STARTED
[15:04:18.974] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:10:0) after 5m54s
[15:10:13.135] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:10:0)
[15:10:13.185] Build status: STARTED
[15:10:13.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927427311989761360:11:0) after 7m0s
[15:13:07.704] Received PubSub notification, asking Buildbucket for the build status
[15:13:07.727] Build:
{
"id": "8761997249959769937",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-11T14:34:44.499100113Z",
"startTime": "2023-12-11T14:34:46.220630Z",
"endTime": "2023-12-11T15:13:06.308841Z",
"updateTime": "2023-12-11T15:13:06.308841Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "ff2c56344c764af598ad33027e9c7a48881808ef",
"ref": "refs/heads/main"
}
}
}
[15:13:07.727] Invocation finished in 38m24.547313186s with status SUCCEEDED