[02:17:44.316] New invocation is queued and will start shortly
[02:17:45.632] Starting the invocation (attempt 1)
[02:17:45.666] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/56ee65aeb6d1fad67d903d5ee1359abcf7b94231"
[02:17:45.666] Popped gitiles commit info from properties and tags
[02:17:45.666] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:17:45.666] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:17:45.667] Buildbucket request:
{
"requestId": "8957642468660097920",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8957642468660097920",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "33ebe04183c569b219d6ec379727646bba78e744"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@33ebe04183c569b219d6ec379727646bba78e744",
"title": "33ebe04183c569b219d6ec379727646bba78e744",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/33ebe04183c569b219d6ec379727646bba78e744"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "52d534ef63294d93d3b3f711297e962396d5e0e4"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@52d534ef63294d93d3b3f711297e962396d5e0e4",
"title": "52d534ef63294d93d3b3f711297e962396d5e0e4",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/52d534ef63294d93d3b3f711297e962396d5e0e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "531193853142a2564f1c667c9e8ca96c524a380b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@531193853142a2564f1c667c9e8ca96c524a380b",
"title": "531193853142a2564f1c667c9e8ca96c524a380b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/531193853142a2564f1c667c9e8ca96c524a380b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "104ec48c649987685e385b7f64a19921403ece63"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@104ec48c649987685e385b7f64a19921403ece63",
"title": "104ec48c649987685e385b7f64a19921403ece63",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/104ec48c649987685e385b7f64a19921403ece63"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "ebd33522d701c03f816f49d2e1a05d1d1078ded9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@ebd33522d701c03f816f49d2e1a05d1d1078ded9",
"title": "ebd33522d701c03f816f49d2e1a05d1d1078ded9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/ebd33522d701c03f816f49d2e1a05d1d1078ded9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9a39d7e441fb5f879a25d326d6f1546b34d4c531"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9a39d7e441fb5f879a25d326d6f1546b34d4c531",
"title": "9a39d7e441fb5f879a25d326d6f1546b34d4c531",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9a39d7e441fb5f879a25d326d6f1546b34d4c531"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "7ee3fd2edce794a452f9b91dd2cb8fe8f5bc151a"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@7ee3fd2edce794a452f9b91dd2cb8fe8f5bc151a",
"title": "7ee3fd2edce794a452f9b91dd2cb8fe8f5bc151a",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/7ee3fd2edce794a452f9b91dd2cb8fe8f5bc151a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "88765b0f59d6d5ebc0698d1971fa291f5c712b6c"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@88765b0f59d6d5ebc0698d1971fa291f5c712b6c",
"title": "88765b0f59d6d5ebc0698d1971fa291f5c712b6c",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/88765b0f59d6d5ebc0698d1971fa291f5c712b6c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "90f9c681d44b91ed41425284dd748604268cdc4e"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@90f9c681d44b91ed41425284dd748604268cdc4e",
"title": "90f9c681d44b91ed41425284dd748604268cdc4e",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/90f9c681d44b91ed41425284dd748604268cdc4e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "865d83e87ab489f2915802e70a5c4a3f2424ff67"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@865d83e87ab489f2915802e70a5c4a3f2424ff67",
"title": "865d83e87ab489f2915802e70a5c4a3f2424ff67",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/865d83e87ab489f2915802e70a5c4a3f2424ff67"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "dce5e29edcd3f97017b67296972d18fc0423599a"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@dce5e29edcd3f97017b67296972d18fc0423599a",
"title": "dce5e29edcd3f97017b67296972d18fc0423599a",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/dce5e29edcd3f97017b67296972d18fc0423599a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "106df9ec98012c6fbeb0ffe636f5f566333cfaa1"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@106df9ec98012c6fbeb0ffe636f5f566333cfaa1",
"title": "106df9ec98012c6fbeb0ffe636f5f566333cfaa1",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/106df9ec98012c6fbeb0ffe636f5f566333cfaa1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "56ee65aeb6d1fad67d903d5ee1359abcf7b94231"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@56ee65aeb6d1fad67d903d5ee1359abcf7b94231",
"title": "56ee65aeb6d1fad67d903d5ee1359abcf7b94231",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/56ee65aeb6d1fad67d903d5ee1359abcf7b94231"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "56ee65aeb6d1fad67d903d5ee1359abcf7b94231",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8957642468660097920"
},
{
"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"
}
}
[02:17:46.024] Scheduled build:
{
"id": "8792212406499618657",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-12T02:17:45.740014008Z",
"updateTime": "2023-01-12T02:17:45.740014008Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "56ee65aeb6d1fad67d903d5ee1359abcf7b94231",
"ref": "refs/heads/main"
}
}
}
[02:17:46.025] Task URL: https://cr-buildbucket.appspot.com/build/8792212406499618657
[02:17:46.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:2:0) after 9m59s
[02:17:50.689] Received PubSub notification, asking Buildbucket for the build status
[02:17:50.710] Build status: STARTED
[02:27:45.097] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:2:0)
[02:27:45.147] Build status: STARTED
[02:27:45.147] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:4:0) after 5m7s
[02:32:52.265] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:4:0)
[02:32:52.290] Build status: STARTED
[02:32:52.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:5:0) after 6m20s
[02:39:12.804] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:5:0)
[02:39:12.833] Build status: STARTED
[02:39:12.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:6:0) after 5m22s
[02:44:34.854] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:6:0)
[02:44:34.875] Build status: STARTED
[02:44:34.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:7:0) after 4m40s
[02:49:15.287] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:7:0)
[02:49:15.315] Build status: STARTED
[02:49:15.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:8:0) after 8m14s
[02:57:29.352] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:8:0)
[02:57:29.375] Build status: STARTED
[02:57:29.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8957642468660097920:9:0) after 5m37s
[02:58:17.737] Received PubSub notification, asking Buildbucket for the build status
[02:58:17.761] Build:
{
"id": "8792212406499618657",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-12T02:17:45.740014008Z",
"startTime": "2023-01-12T02:17:49.834177Z",
"endTime": "2023-01-12T02:58:17.542733067Z",
"updateTime": "2023-01-12T02:58:17.542733067Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "56ee65aeb6d1fad67d903d5ee1359abcf7b94231",
"ref": "refs/heads/main"
}
}
}
[02:58:17.761] Invocation finished in 40m33.465078849s with status SUCCEEDED