[01:38:13.033] New invocation is queued and will start shortly
[01:38:14.477] Starting the invocation (attempt 1)
[01:38:14.505] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/8700ba1c2cbafd99ac6bd13a3dad61dd2f2912fb"
[01:38:14.506] Popped gitiles commit info from properties and tags
[01:38:14.506] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:38:14.506] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:38:14.506] Buildbucket request:
{
"requestId": "8893502302912017776",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8893502302912017776",
"job": "fuchsia/rust_test-x64-linux-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "dbf5ae3a864f555cfe6770896a23f7dea77fb6fb"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@dbf5ae3a864f555cfe6770896a23f7dea77fb6fb",
"title": "dbf5ae3a864f555cfe6770896a23f7dea77fb6fb",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/dbf5ae3a864f555cfe6770896a23f7dea77fb6fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d416cead5a92d6a054d0e4d18a4b3a965f35334d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d416cead5a92d6a054d0e4d18a4b3a965f35334d",
"title": "d416cead5a92d6a054d0e4d18a4b3a965f35334d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d416cead5a92d6a054d0e4d18a4b3a965f35334d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c3780e1d227d7544209e2cd722ac4fa35ac61b56"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c3780e1d227d7544209e2cd722ac4fa35ac61b56",
"title": "c3780e1d227d7544209e2cd722ac4fa35ac61b56",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c3780e1d227d7544209e2cd722ac4fa35ac61b56"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "34ed51cb837d1dd755b9b97798a41c8cd0358ca6"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@34ed51cb837d1dd755b9b97798a41c8cd0358ca6",
"title": "34ed51cb837d1dd755b9b97798a41c8cd0358ca6",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/34ed51cb837d1dd755b9b97798a41c8cd0358ca6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "837a25dd41a1cc58cee093159a01f73719f330e8"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@837a25dd41a1cc58cee093159a01f73719f330e8",
"title": "837a25dd41a1cc58cee093159a01f73719f330e8",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/837a25dd41a1cc58cee093159a01f73719f330e8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c28e3e36b5ba9813be8d9d2968d63d3479717c16"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c28e3e36b5ba9813be8d9d2968d63d3479717c16",
"title": "c28e3e36b5ba9813be8d9d2968d63d3479717c16",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c28e3e36b5ba9813be8d9d2968d63d3479717c16"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "987656f5096c89377d4b58cda5e659f21437001f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@987656f5096c89377d4b58cda5e659f21437001f",
"title": "987656f5096c89377d4b58cda5e659f21437001f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/987656f5096c89377d4b58cda5e659f21437001f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "aced4dcf1047aab08b769b34fae9d4ba7de87f04"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@aced4dcf1047aab08b769b34fae9d4ba7de87f04",
"title": "aced4dcf1047aab08b769b34fae9d4ba7de87f04",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/aced4dcf1047aab08b769b34fae9d4ba7de87f04"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "aaca9fa482739cc097a7e77bf6a5ee87e8aa6254"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@aaca9fa482739cc097a7e77bf6a5ee87e8aa6254",
"title": "aaca9fa482739cc097a7e77bf6a5ee87e8aa6254",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/aaca9fa482739cc097a7e77bf6a5ee87e8aa6254"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "5415f067bd4565fe49c77de426e2f99625311fc6"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@5415f067bd4565fe49c77de426e2f99625311fc6",
"title": "5415f067bd4565fe49c77de426e2f99625311fc6",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/5415f067bd4565fe49c77de426e2f99625311fc6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b9784988f797e1dcd3ae1c47549f4697ca36f156"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b9784988f797e1dcd3ae1c47549f4697ca36f156",
"title": "b9784988f797e1dcd3ae1c47549f4697ca36f156",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b9784988f797e1dcd3ae1c47549f4697ca36f156"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "fc11b5a0f41ebae6ad9020dc893d52d1233b5fb8"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@fc11b5a0f41ebae6ad9020dc893d52d1233b5fb8",
"title": "fc11b5a0f41ebae6ad9020dc893d52d1233b5fb8",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/fc11b5a0f41ebae6ad9020dc893d52d1233b5fb8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "57cbd078f2748d9af7ef76694becc7c9096140b9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@57cbd078f2748d9af7ef76694becc7c9096140b9",
"title": "57cbd078f2748d9af7ef76694becc7c9096140b9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/57cbd078f2748d9af7ef76694becc7c9096140b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "bfbe72ed02afa7ae4e3ab820f9139b12323bb30d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@bfbe72ed02afa7ae4e3ab820f9139b12323bb30d",
"title": "bfbe72ed02afa7ae4e3ab820f9139b12323bb30d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/bfbe72ed02afa7ae4e3ab820f9139b12323bb30d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "4f053b18f53c019f36f79f429bbc01ec5c53e8dc"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@4f053b18f53c019f36f79f429bbc01ec5c53e8dc",
"title": "4f053b18f53c019f36f79f429bbc01ec5c53e8dc",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/4f053b18f53c019f36f79f429bbc01ec5c53e8dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8700ba1c2cbafd99ac6bd13a3dad61dd2f2912fb"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8700ba1c2cbafd99ac6bd13a3dad61dd2f2912fb",
"title": "8700ba1c2cbafd99ac6bd13a3dad61dd2f2912fb",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8700ba1c2cbafd99ac6bd13a3dad61dd2f2912fb"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "8700ba1c2cbafd99ac6bd13a3dad61dd2f2912fb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8893502302912017776"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_test-x64-linux-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:38:14.905] Scheduled build:
{
"id": "8728072240628240993",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-20T01:38:14.582189856Z",
"updateTime": "2024-12-20T01:38:14.582189856Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "8700ba1c2cbafd99ac6bd13a3dad61dd2f2912fb",
"ref": "refs/heads/main"
}
},
"canary": true
}
[01:38:14.905] Task URL: https://cr-buildbucket.appspot.com/build/8728072240628240993
[01:38:14.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:2:0) after 4m28s
[01:38:15.870] Received PubSub notification, asking Buildbucket for the build status
[01:38:15.932] Build status: SCHEDULED
[01:38:18.929] Received PubSub notification, asking Buildbucket for the build status
[01:38:18.980] Build status: STARTED
[01:42:42.966] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:2:0)
[01:42:42.996] Build status: STARTED
[01:42:42.996] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:5:0) after 3m39s
[01:46:22.012] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:5:0)
[01:46:22.060] Build status: STARTED
[01:46:22.060] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:6:0) after 4m45s
[01:51:07.178] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:6:0)
[01:51:07.217] Build status: STARTED
[01:51:07.217] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:7:0) after 3m18s
[01:54:26.329] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:7:0)
[01:54:26.344] Build status: STARTED
[01:54:26.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:8:0) after 6m41s
[02:01:07.539] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:8:0)
[02:01:07.570] Build status: STARTED
[02:01:07.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:9:0) after 6m22s
[02:07:29.899] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:9:0)
[02:07:29.917] Build status: STARTED
[02:07:29.917] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:10:0) after 7m44s
[02:15:14.020] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:10:0)
[02:15:14.062] Build status: STARTED
[02:15:14.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:11:0) after 1m1s
[02:16:15.229] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:11:0)
[02:16:15.264] Build status: STARTED
[02:16:15.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:12:0) after 9m56s
[02:26:11.267] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:12:0)
[02:26:11.293] Build status: STARTED
[02:26:11.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:13:0) after 5m17s
[02:31:28.787] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:13:0)
[02:31:28.810] Build status: STARTED
[02:31:28.810] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:14:0) after 6m8s
[02:37:37.068] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:14:0)
[02:37:37.135] Build status: STARTED
[02:37:37.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:15:0) after 6m51s
[02:44:28.177] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:15:0)
[02:44:28.195] Build status: STARTED
[02:44:28.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:16:0) after 7m19s
[02:51:47.415] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:16:0)
[02:51:47.508] Build status: STARTED
[02:51:47.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8893502302912017776:17:0) after 9m7s
[02:52:22.531] Received PubSub notification, asking Buildbucket for the build status
[02:52:22.572] Build:
{
"id": "8728072240628240993",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-20T01:38:14.582189856Z",
"startTime": "2024-12-20T01:38:18.746485128Z",
"endTime": "2024-12-20T02:52:22.282559206Z",
"updateTime": "2024-12-20T02:52:22.282559206Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "8700ba1c2cbafd99ac6bd13a3dad61dd2f2912fb",
"ref": "refs/heads/main"
}
},
"canary": true
}
[02:52:22.572] Invocation finished in 1h14m9.5518203s with status FAILED