cli icon indicating copy to clipboard operation
cli copied to clipboard
verified publisher icon supabase

[CLI] supabase wont start

Open rosmur opened this issue 2 months ago • 6 comments

Describe the bug supabase start erroring out always

To Reproduce Steps to reproduce the behavior:

  1. run supabase start
  2. See error:
Starting database...
Initialising schema...
Stopping containers...
error running container: exit 1

with --debug flag:

 InternalError: (e, message) => new import_storage_error.StorageBackendError({
                                 ^

StorageBackendError: Migration iceberg-catalog-ids not found
    at Object.InternalError (/app/dist/internal/errors/codes.js:248:34)
    at /app/dist/internal/database/migrations/migrate.js:425:36
    at async /app/dist/internal/database/migrations/migrate.js:553:14
    at async connectAndMigrate (/app/dist/internal/database/migrations/migrate.js:383:5)
    at async runMigrationsOnTenant (/app/dist/internal/database/migrations/migrate.js:273:3)
    at async /app/dist/scripts/migrate-call.js:30:3 {
  metadata: {},
  code: 'InternalError',
  httpStatusCode: 500,
  userStatusCode: 500,
  originalError: undefined,
  resource: undefined,
  error: undefined
}

Expected behavior Supabase starts up normally.

Crash ID:

System information Rerun the failing command with --create-ticket flag.

  • Ticket ID: [e.g. 5acbb1defe45429d854d3d1c1f2d370c]
  • Version of OS: Debian 12 bookworm
  • Version of CLI: 2.59.2
  • Version of Docker: 28.5.1-1
  • Versions of services:
SERVICE IMAGE LOCAL LINKED
supabase/postgres 17.6.1.048 17.6.1.048
supabase/gotrue v2.182.1 v2.182.1
postgrest/postgrest v13.0.5 v13.0.5
supabase/realtime v2.63.3 -
supabase/storage-api v1.30.0 -
supabase/edge-runtime v1.69.24 -
supabase/studio 2025.11.10-sha-5291fe3 -
supabase/postgres-meta v0.93.1 -
supabase/logflare 1.26.4 -
supabase/supavisor 2.7.4 -

Additional context

  • Running in devcontainer: uses python:3-bookworm base image, supabase-cli feature along with docker-in-docker feature

rosmur avatar Nov 18 '25 06:11 rosmur

rebuilding the container didnt resolve issue

rosmur avatar Nov 18 '25 06:11 rosmur

@rosmur seems identical to https://github.com/supabase/cli/issues/4466 . see that issue for possible fixes.

pkabra avatar Nov 18 '25 18:11 pkabra

Didnt change anything.. but its working today:

First time i tried supabase start (same devcontainer env as stated above), i got:

failed to display json stream: failed to register layer: write /nix/store/vmlljnps7wn0wrd97icjmaqa1mdrg9pg-wrappers-0.4.4/lib/wrappers-0.4.4.so: no space left on device

then i tried manually deleting old images from Docker Desktop (though it said there was plenty of space available) and ran supabase start --debug, it worked.

I did remove remoteEnv key (with TZ value set to LA) - not sure if this was the issue ?

rosmur avatar Nov 18 '25 21:11 rosmur

Seeing this same error when running supabase db pull --debug for the first time on an existing project:

Logs 
↪ npx supabase db pull --debug
open supabase/.temp/profile: no such file or directory
Loading project ref from file: supabase/.temp/project-ref
Using connection pooler: postgresql://postgres.enpzxyaepftqzfbljwqk@aws-1-us-east-2.pooler.supabase.com:5432/postgres
Initialising login role...
Using access token for profile: supabase
Supabase CLI 2.58.5
Using profile: supabase (supabase.co)
Connecting to remote database...
2025/11/21 11:58:32 PG Send: {"Type":"StartupMessage","ProtocolVersion":196608,"Parameters":{"database":"postgres","user":"cli_login_postgres.enpzxyaepftqzfbljwqk"}}
2025/11/21 11:58:32 PG Recv: {"Type":"AuthenticationSASL","AuthMechanisms":["SCRAM-SHA-256"]}
2025/11/21 11:58:32 PG Send: {"Type":"SASLInitialResponse","AuthMechanism":"SCRAM-SHA-256","Data":"n,,n=,r=SHzD/1Sm7s9EXokSRQI66Di7"}
2025/11/21 11:58:32 PG Recv: {"Type":"AuthenticationSASLContinue","Data":"r===,i=4096"}
2025/11/21 11:58:32 PG Send: {"Type":"SASLResponse","Data":"c=biws,r=="}
2025/11/21 11:58:33 PG Recv: {"Type":"AuthenticationSASLFinal","Data":"v=NTLFPnzLCY5zOcgN5OcpW2EiH/zUCwp2tMwu7ko09EM="}
2025/11/21 11:58:33 PG Recv: {"Type":"AuthenticationOK"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"DateStyle","Value":"ISO, MDY"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"IntervalStyle","Value":"postgres"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"TimeZone","Value":"UTC"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"application_name","Value":"Supavisor"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"client_encoding","Value":"UTF8"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"default_transaction_read_only","Value":"off"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"in_hot_standby","Value":"off"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"integer_datetimes","Value":"on"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"is_superuser","Value":"off"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"scram_iterations","Value":"4096"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"server_encoding","Value":"UTF8"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"server_version","Value":"17.6"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"session_authorization","Value":"cli_login_postgres"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterStatus","Name":"standard_conforming_strings","Value":"on"}
2025/11/21 11:58:33 PG Recv: {"Type":"BackendKeyData","ProcessID":257310435,"SecretKey":671087017}
2025/11/21 11:58:33 PG Recv: {"Type":"ReadyForQuery","TxStatus":"I"}
2025/11/21 11:58:33 PG Send: {"Type":"Query","String":"SET SESSION ROLE postgres"}
2025/11/21 11:58:33 PG Recv: {"Type":"CommandComplete","CommandTag":"SET"}
2025/11/21 11:58:33 PG Recv: {"Type":"ReadyForQuery","TxStatus":"I"}
2025/11/21 11:58:33 PG Send: {"Type":"Parse","Name":"lrupsc_1_0","Query":"SELECT version FROM supabase_migrations.schema_migrations ORDER BY version","ParameterOIDs":null}
2025/11/21 11:58:33 PG Send: {"Type":"Describe","ObjectType":"S","Name":"lrupsc_1_0"}
2025/11/21 11:58:33 PG Send: {"Type":"Sync"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParseComplete"}
2025/11/21 11:58:33 PG Recv: {"Type":"ParameterDescription","ParameterOIDs":[]}
2025/11/21 11:58:33 PG Recv: {"Type":"RowDescription","Fields":[{"Name":"version","TableOID":45701,"TableAttributeNumber":1,"DataTypeOID":25,"DataTypeSize":-1,"TypeModifier":-1,"Format":0}]}
2025/11/21 11:58:33 PG Recv: {"Type":"ReadyForQuery","TxStatus":"I"}
2025/11/21 11:58:33 PG Send: {"Type":"Bind","DestinationPortal":"","PreparedStatement":"lrupsc_1_0","ParameterFormatCodes":null,"Parameters":[],"ResultFormatCodes":[0]}
2025/11/21 11:58:33 PG Send: {"Type":"Describe","ObjectType":"P","Name":""}
2025/11/21 11:58:33 PG Send: {"Type":"Execute","Portal":"","MaxRows":0}
2025/11/21 11:58:33 PG Send: {"Type":"Sync"}
2025/11/21 11:58:33 PG Recv: {"Type":"BindComplete"}
2025/11/21 11:58:33 PG Recv: {"Type":"RowDescription","Fields":[{"Name":"version","TableOID":45701,"TableAttributeNumber":1,"DataTypeOID":25,"DataTypeSize":-1,"TypeModifier":-1,"Format":0}]}
2025/11/21 11:58:33 PG Recv: {"Type":"CommandComplete","CommandTag":"SELECT 0"}
2025/11/21 11:58:33 PG Recv: {"Type":"ReadyForQuery","TxStatus":"I"}
Dumping schema from remote database...
Creating shadow database...
2025/11/21 11:58:58 PG Send: {"Type":"StartupMessage","ProtocolVersion":196608,"Parameters":{"database":"postgres","user":"postgres"}}
2025/11/21 11:58:58 PG Recv: {"Type":"AuthenticationSASL","AuthMechanisms":["SCRAM-SHA-256"]}
2025/11/21 11:58:58 PG Send: {"Type":"SASLInitialResponse","AuthMechanism":"SCRAM-SHA-256","Data":"n,,n=,r=wz00enPyrBPbhCW18Q5NgL/+"}
2025/11/21 11:58:58 PG Recv: {"Type":"AuthenticationSASLContinue","Data":"r=wz00enPyrBPbhCW18Q5NgL/+TvbdOUh84bymY0vGCUF8f3dy,s=g4+kF/UOI5xMyM3gau7rfQ==,i=4096"}
2025/11/21 11:58:58 PG Send: {"Type":"SASLResponse","Data":"c=biws,r=wz00enPyrBPbhCW18Q5NgL/+TvbdOUh84bymY0vGCUF8f3dy,p=31Di4ulLMVUQcNQlgnoXhaHKvu4fuAEdpkfvk0jyrg0="}
2025/11/21 11:58:58 PG Recv: {"Type":"AuthenticationSASLFinal","Data":"v=y8d+JplN/G4QO2BeGoho9vcm91E4TaLIX6QcK3a0tB0="}
2025/11/21 11:58:58 PG Recv: {"Type":"AuthenticationOK"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"in_hot_standby","Value":"off"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"integer_datetimes","Value":"on"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"TimeZone","Value":"UTC"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"IntervalStyle","Value":"postgres"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"is_superuser","Value":"off"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"application_name","Value":""}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"default_transaction_read_only","Value":"off"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"scram_iterations","Value":"4096"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"DateStyle","Value":"ISO, MDY"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"standard_conforming_strings","Value":"on"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"session_authorization","Value":"postgres"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"client_encoding","Value":"UTF8"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"server_version","Value":"17.6"}
2025/11/21 11:58:58 PG Recv: {"Type":"ParameterStatus","Name":"server_encoding","Value":"UTF8"}
2025/11/21 11:58:58 PG Recv: {"Type":"BackendKeyData","ProcessID":207,"SecretKey":724627765}
2025/11/21 11:58:58 PG Recv: {"Type":"ReadyForQuery","TxStatus":"I"}
Initialising schema...
+ ulimit -n
+ '[' '!' -z '' ']'
+ export ERL_CRASH_DUMP=/tmp/erl_crash.dump
+ ERL_CRASH_DUMP=/tmp/erl_crash.dump
+ '[' false = true ']'
+ [[ -n '' ]]
+ echo 'Running migrations'
+ sudo -E -u nobody /app/bin/migrate
+ '[' true = true ']'
+ echo 'Seeding selfhosted Realtime'
+ sudo -E -u nobody /app/bin/realtime eval 'Realtime.Release.seeds(Realtime.Repo)'
[os_mon] memory supervisor port (memsup): Erlang has closed
[os_mon] cpu supervisor port (cpu_sup): Erlang has closed
+ echo 'Starting Realtime'
+ ulimit -n
+ exec /app/bin/realtime eval '{:ok, _} = Application.ensure_all_started(:realtime)
{:ok, _} = Realtime.Tenants.health_check("realtime-dev")'
[os_mon] memory supervisor port (memsup): Erlang has closed
[os_mon] cpu supervisor port (cpu_sup): Erlang has closed
/app/dist/internal/errors/codes.js:242
  InternalError: (e, message) => new import_storage_error.StorageBackendError({
                                 ^

StorageBackendError: Migration iceberg-catalog-ids not found
    at Object.InternalError (/app/dist/internal/errors/codes.js:242:34)
    at /app/dist/internal/database/migrations/migrate.js:425:36
    at async /app/dist/internal/database/migrations/migrate.js:553:14
    at async connectAndMigrate (/app/dist/internal/database/migrations/migrate.js:383:5)
    at async runMigrationsOnTenant (/app/dist/internal/database/migrations/migrate.js:273:3)
    at async /app/dist/scripts/migrate-call.js:30:3 {
  metadata: {},
  code: 'InternalError',
  httpStatusCode: 500,
  userStatusCode: 500,
  originalError: undefined,
  resource: undefined,
  error: undefined
}

Node.js v22.21.1
2025/11/21 11:59:02 PG Send: {"Type":"Terminate"}
error running container: exit 1
2025/11/21 11:59:02 PG Send: {"Type":"Terminate"}

apexskier avatar Nov 21 '25 19:11 apexskier

got a similar error., was able to reset the whole instance and volumes and got this error:

2025/11/24 00:14:52 PG Recv: {"Type":"BackendKeyData","ProcessID":241,"SecretKey":3657001513}
2025/11/24 00:14:52 PG Recv: {"Type":"ReadyForQuery","TxStatus":"I"}
Initialising schema...
+ ulimit -n
+ '[' '!' -z '' ']'
+ export ERL_CRASH_DUMP=/tmp/erl_crash.dump
+ ERL_CRASH_DUMP=/tmp/erl_crash.dump
+ '[' false = true ']'
+ [[ -n '' ]]
+ echo 'Running migrations'
+ sudo -E -u nobody /app/bin/migrate
+ '[' true = true ']'
+ echo 'Seeding selfhosted Realtime'
+ sudo -E -u nobody /app/bin/realtime eval 'Realtime.Release.seeds(Realtime.Repo)'
[os_mon] memory supervisor port (memsup): Erlang has closed
[os_mon] cpu supervisor port (cpu_sup): Erlang has closed
+ echo 'Starting Realtime'
+ ulimit -n
+ exec /app/bin/realtime eval '{:ok, _} = Application.ensure_all_started(:realtime)
{:ok, _} = Realtime.Tenants.health_check("realtime-dev")'
[os_mon] memory supervisor port (memsup): Erlang has closed
[os_mon] cpu supervisor port (cpu_sup): Erlang has closed
/app/dist/internal/errors/codes.js:242
  InternalError: (e, message) => new import_storage_error.StorageBackendError({
                                 ^

StorageBackendError: Migration iceberg-catalog-ids not found
    at Object.InternalError (/app/dist/internal/errors/codes.js:242:34)
    at /app/dist/internal/database/migrations/migrate.js:425:36
    at async /app/dist/internal/database/migrations/migrate.js:553:14
    at async connectAndMigrate (/app/dist/internal/database/migrations/migrate.js:383:5)
    at async runMigrationsOnTenant (/app/dist/internal/database/migrations/migrate.js:273:3)
    at async /app/dist/scripts/migrate-call.js:30:3 {
  metadata: {},
  code: 'InternalError',
  httpStatusCode: 500,
  userStatusCode: 500,
  originalError: undefined,
  resource: undefined,
  error: undefined
}

Node.js v22.21.1
error running container: exit 1

error after executing command:

supabase db reset

psycotrompus avatar Nov 23 '25 17:11 psycotrompus

supabase beta version (2.60.4) works. just did a full reset of db and images.

psycotrompus avatar Nov 23 '25 17:11 psycotrompus