[05:27:38.791] New invocation is queued and will start shortly
[05:27:40.073] Starting the invocation (attempt 1)
[05:27:40.096] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/366dab13f711df90a6891411458544199d159cbc"
[05:27:40.096] Popped gitiles commit info from properties and tags
[05:27:40.096] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:27:40.096] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:27:40.097] Buildbucket request:
{
"requestId": "8935615457840657424",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8935615457840657424",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "897a65804d7891c2d4518d6c6061e7baedaa745b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@897a65804d7891c2d4518d6c6061e7baedaa745b",
"title": "897a65804d7891c2d4518d6c6061e7baedaa745b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/897a65804d7891c2d4518d6c6061e7baedaa745b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "f993ddc079112bc0b630b1fb38e141239b36cca6"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@f993ddc079112bc0b630b1fb38e141239b36cca6",
"title": "f993ddc079112bc0b630b1fb38e141239b36cca6",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/f993ddc079112bc0b630b1fb38e141239b36cca6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b5bab2b1cc731302fe515fa434cd30f8d0a18a17"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b5bab2b1cc731302fe515fa434cd30f8d0a18a17",
"title": "b5bab2b1cc731302fe515fa434cd30f8d0a18a17",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b5bab2b1cc731302fe515fa434cd30f8d0a18a17"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a38a3bfc6dcc01de2b6e54f28a766997a1fda304"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a38a3bfc6dcc01de2b6e54f28a766997a1fda304",
"title": "a38a3bfc6dcc01de2b6e54f28a766997a1fda304",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a38a3bfc6dcc01de2b6e54f28a766997a1fda304"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "4999000da1a315ac85246d1218809820b12520c6"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@4999000da1a315ac85246d1218809820b12520c6",
"title": "4999000da1a315ac85246d1218809820b12520c6",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/4999000da1a315ac85246d1218809820b12520c6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "e00120906e6a00408c45d941b34f20c5e3277d95"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@e00120906e6a00408c45d941b34f20c5e3277d95",
"title": "e00120906e6a00408c45d941b34f20c5e3277d95",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/e00120906e6a00408c45d941b34f20c5e3277d95"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "e68e9d4a14a487bd109ec654ee3e2da1432edbd0"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@e68e9d4a14a487bd109ec654ee3e2da1432edbd0",
"title": "e68e9d4a14a487bd109ec654ee3e2da1432edbd0",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/e68e9d4a14a487bd109ec654ee3e2da1432edbd0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "366dab13f711df90a6891411458544199d159cbc"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@366dab13f711df90a6891411458544199d159cbc",
"title": "366dab13f711df90a6891411458544199d159cbc",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/366dab13f711df90a6891411458544199d159cbc"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "366dab13f711df90a6891411458544199d159cbc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8935615457840657424"
},
{
"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"
}
}
[05:27:40.522] Scheduled build:
{
"id": "8770185395746552833",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-12T05:27:40.163890470Z",
"updateTime": "2023-09-12T05:27:40.163890470Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "366dab13f711df90a6891411458544199d159cbc",
"ref": "refs/heads/main"
}
}
}
[05:27:40.522] Task URL: https://cr-buildbucket.appspot.com/build/8770185395746552833
[05:27:40.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:2:0) after 3m26s
[05:27:41.492] Received PubSub notification, asking Buildbucket for the build status
[05:27:41.526] Build status: SCHEDULED
[05:27:58.262] Received PubSub notification, asking Buildbucket for the build status
[05:27:58.282] Build status: STARTED
[05:31:06.548] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:2:0)
[05:31:06.584] Build status: STARTED
[05:31:06.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:5:0) after 2m6s
[05:33:12.851] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:5:0)
[05:33:12.879] Build status: STARTED
[05:33:12.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:6:0) after 4m4s
[05:37:17.028] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:6:0)
[05:37:17.074] Build status: STARTED
[05:37:17.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:7:0) after 8m58s
[05:46:15.089] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:7:0)
[05:46:15.110] Build status: STARTED
[05:46:15.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:8:0) after 8m20s
[05:54:35.436] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:8:0)
[05:54:35.499] Build status: STARTED
[05:54:35.499] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:9:0) after 3m56s
[05:58:31.590] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:9:0)
[05:58:31.608] Build status: STARTED
[05:58:31.608] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:10:0) after 3m38s
[06:02:09.721] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:10:0)
[06:02:09.742] Build status: STARTED
[06:02:09.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8935615457840657424:11:0) after 2m36s
[06:03:25.202] Received PubSub notification, asking Buildbucket for the build status
[06:03:25.231] Build:
{
"id": "8770185395746552833",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-12T05:27:40.163890470Z",
"startTime": "2023-09-12T05:27:58.061311950Z",
"endTime": "2023-09-12T06:03:24.938896487Z",
"updateTime": "2023-09-12T06:03:24.938896487Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "366dab13f711df90a6891411458544199d159cbc",
"ref": "refs/heads/main"
}
}
}
[06:03:25.231] Invocation finished in 35m46.448746861s with status SUCCEEDED