vm-test-run-collation-refresh
checks.aarch64-linux.ext-collation-refresh
· build #461
· raw
1Machine state will be reset. To keep it, pass --keep-vm-state2start all VLans3start vlan4running vlan (pid 7; ctl /build/vde1.ctl)5(finished: start all VLans, in 0.00 seconds)6Test will time out and terminate in 3600 seconds7run the VM test script8additionally exposed symbols:9 server,10 vlan1,11 start_all, test_script, machines, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, Machine, t, debug12start all VMs13server: starting vm14mke2fs 1.47.3 (8-Jul-2025)15qemu-system-aarch64: Could not access KVM kernel module: No such file or directory16qemu-system-aarch64: failed to initialize kvm: No such file or directory17qemu-system-aarch64: falling back to tcg18server # Disk image does not exist, creating the virtualisation disk image...19server # Formatting '/build/vm-state-server/tmp.yBPO3Avrg9', fmt=raw size=107374182420server # Discarding device blocks: 0/262144 done21server # Creating filesystem with 262144 4k blocks and 65536 inodes22server # Filesystem UUID: 632388a0-6e5c-45ae-8039-6439a25c16a923server # Superblock backups stored on blocks:24server # 32768, 98304, 163840, 22937625server: QEMU running (pid 9)26server # 27server # Allocating group tables: 0/8 done28server # Writing inode tables: 0/8 done29server # Creating journal (8192 blocks): done30server # Writing superblocks and filesystem accounting information: 0/8 done31server # 32server # Virtualisation disk image created.33(finished: start all VMs, in 0.14 seconds)34server: waiting for unit supabase-db-init.service35server: waiting for the VM to finish booting36server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]37server # [ 0.000000] Linux version 6.12.63 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP Thu Dec 18 12:55:23 UTC 202538server # [ 0.000000] KASLR enabled39server # [ 0.000000] random: crng init done40server # [ 0.000000] Machine model: linux,dummy-virt41server # [ 0.000000] efi: UEFI not found.42server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT43server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]44server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f602200-0x13f60593f]45server # [ 0.000000] Zone ranges:46server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff]47server # [ 0.000000] DMA32 empty48server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff]49server # [ 0.000000] Device empty50server # [ 0.000000] Movable zone start for each node51server # [ 0.000000] Early memory node ranges52server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff]53server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]54server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -155server # [ 0.000000] psci: probing for conduit method from DT.56server # [ 0.000000] psci: PSCIv1.1 detected in firmware.57server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs58server # [ 0.000000] psci: Trusted OS migration not required59server # [ 0.000000] psci: SMC Calling Convention v1.060server # [ 0.000000] percpu: Embedded 88 pages/cpu s180056 r65536 d114856 u36044861server # [ 0.000000] Detected PIPT I-cache on CPU062server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)63server # [ 0.000000] CPU features: detected: GIC system register CPU interface64server # [ 0.000000] CPU features: detected: HCRX_EL2 register65server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2)66server # [ 0.000000] CPU features: detected: Spectre-v467server # [ 0.000000] alternatives: applying boot alternatives68server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/xh73y8sxr412g1sghc7vva42r7jgrzjb-nixos-system-server-test/init regInfo=/nix/store/glj3bnhszdkpcahq0gjp18ldyz0b1wnz-closure-info/registration console=ttyAMA0,115200n8 console=tty069server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/glj3bnhszdkpcahq0gjp18ldyz0b1wnz-closure-info/registration", will be passed to user space.70server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)71server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)72server # [ 0.000000] Fallback order for Node 0: 073server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 104857674server # [ 0.000000] Policy zone: Normal75server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off76server # [ 0.000000] software IO TLB: area num 2.77server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)78server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=179server # [ 0.000000] allocated 8388608 bytes of page_ext80server # [ 0.000000] ftrace: allocating 72257 entries in 283 pages81server # [ 0.000000] ftrace: allocated 283 pages with 5 groups82server # [ 0.000000] rcu: Hierarchical RCU implementation.83server # [ 0.000000] rcu: RCU event tracing is enabled.84server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2.85server # [ 0.000000] Rude variant of Tasks RCU enabled.86server # [ 0.000000] Tracing variant of Tasks RCU enabled.87server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.88server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=289server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.90server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.91server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 092server # [ 0.000000] GICv3: 256 SPIs implemented93server # [ 0.000000] GICv3: 0 Extended SPIs implemented94server # [ 0.000000] Root IRQ handler: gic_handle_irq95server # [ 0.000000] GICv3: GICv3 features: 16 PPIs96server # [ 0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=097server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a000098server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]99server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100ae0000 (indirect, esz 8, psz 64K, shr 1)100server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100af0000 (flat, esz 8, psz 64K, shr 1)101server # [ 0.000000] GICv3: using LPI property table @0x0000000100b10000102server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b20000103server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.104server # [ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (virt).105server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns106server # [ 0.000038] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns107server # [ 0.004560] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)108server # [ 0.015862] Console: colour dummy device 80x25109server # [ 0.017580] printk: legacy console [tty0] enabled110server # [ 0.023173] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)111server # [ 0.023580] pid_max: default: 32768 minimum: 301112server # [ 0.025924] LSM: initializing lsm=capability,landlock,yama,bpf113server # [ 0.027503] landlock: Up and running.114server # [ 0.027563] Yama: becoming mindful.115server # [ 0.030425] LSM support for eBPF active116server # [ 0.033565] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)117server # [ 0.033750] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)118server # [ 0.063697] cacheinfo: Unable to detect cache hierarchy for CPU 0119server # [ 0.075753] rcu: Hierarchical SRCU implementation.120server # [ 0.075854] rcu: Max phase no-delay instances is 1000.121server # [ 0.077220] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level122server # [ 0.084908] fsl-mc MSI: its@8080000 domain created123server # [ 0.086836] EFI services will not be available.124server # [ 0.088773] smp: Bringing up secondary CPUs ...125server # [ 0.093101] Detected PIPT I-cache on CPU1126server # [ 0.094319] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000127server # [ 0.095008] GICv3: CPU1: using allocated LPI pending table @0x0000000100b30000128server # [ 0.096549] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]129server # [ 0.100029] smp: Brought up 1 node, 2 CPUs130server # [ 0.100178] SMP: Total of 2 processors activated.131server # [ 0.100220] CPU: All CPU(s) started at EL1132server # [ 0.100377] CPU features: detected: Branch Target Identification133server # [ 0.100423] CPU features: detected: 32-bit EL0 Support134server # [ 0.100454] CPU features: detected: 32-bit EL1 Support135server # [ 0.100479] CPU features: detected: ARMv8.4 Translation Table Level136server # [ 0.100514] CPU features: detected: Instruction cache invalidation not required for I/D coherence137server # [ 0.100556] CPU features: detected: Data cache clean to the PoU not required for I/D coherence138server # [ 0.100622] CPU features: detected: Common not Private translations139server # [ 0.100651] CPU features: detected: CRC32 instructions140server # [ 0.100676] CPU features: detected: Data cache clean to Point of Deep Persistence141server # [ 0.100707] CPU features: detected: Data cache clean to Point of Persistence142server # [ 0.100734] CPU features: detected: Data independent timing control (DIT)143server # [ 0.100761] CPU features: detected: E0PD144server # [ 0.100783] CPU features: detected: Enhanced Counter Virtualization145server # [ 0.100809] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)146server # [ 0.100836] CPU features: detected: Enhanced Privileged Access Never147server # [ 0.100863] CPU features: detected: Enhanced Virtualization Traps148server # [ 0.100888] CPU features: detected: Fine Grained Traps149server # [ 0.101092] CPU features: detected: Generic authentication (IMP DEF algorithm)150server # [ 0.101261] CPU features: detected: RCpc load-acquire (LDAPR)151server # [ 0.101310] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)152server # [ 0.101342] CPU features: detected: LSE atomic instructions153server # [ 0.101366] CPU features: detected: Memory Copy and Memory Set instructions154server # [ 0.101390] CPU features: detected: Privileged Access Never155server # [ 0.101416] CPU features: detected: RAS Extension Support156server # [ 0.101438] CPU features: detected: Random Number Generator157server # [ 0.101462] CPU features: detected: Speculation barrier (SB)158server # [ 0.101485] CPU features: detected: Stage-2 Force Write-Back159server # [ 0.101508] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality160server # [ 0.101539] CPU features: detected: TLB range maintenance instructions161server # [ 0.101567] CPU features: detected: WFx with timeout162server # [ 0.101614] CPU features: detected: Speculative Store Bypassing Safe (SSBS)163server # [ 0.101644] CPU features: detected: Scalable Vector Extension164server # [ 0.106623] alternatives: applying system-wide alternatives165server # [ 0.125589] CPU features: detected: Hardware dirty bit management on CPU0-1166server # [ 0.126231] SVE: maximum available vector length 256 bytes per vector167server # [ 0.126325] SVE: default vector length 64 bytes per vector168server # [ 0.138050] Memory: 3922820K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved)169server # [ 0.160651] devtmpfs: initialized170server # [ 0.188534] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns171server # [ 0.189053] futex hash table entries: 512 (order: 3, 32768 bytes, linear)172server # [ 0.191800] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL173server # [ 0.191878] 0 pages in range for non-PLT usage174server # [ 0.191921] 509248 pages in range for PLT usage175server # [ 0.194247] pinctrl core: initialized pinctrl subsystem176server # [ 0.205617] DMI not present or invalid.177server # [ 0.224831] NET: Registered PF_NETLINK/PF_ROUTE protocol family178server # [ 0.236815] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations179server # [ 0.238090] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations180server # [ 0.239200] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations181server # [ 0.239589] audit: initializing netlink subsys (disabled)182server # [ 0.241630] audit: type=2000 audit(0.188:1): state=initialized audit_enabled=0 res=1183server # [ 0.247546] thermal_sys: Registered thermal governor 'fair_share'184server # [ 0.247598] thermal_sys: Registered thermal governor 'bang_bang'185server # [ 0.247652] thermal_sys: Registered thermal governor 'step_wise'186server # [ 0.247678] thermal_sys: Registered thermal governor 'user_space'187server # [ 0.247704] thermal_sys: Registered thermal governor 'power_allocator'188server # [ 0.248490] cpuidle: using governor ladder189server # [ 0.248918] cpuidle: using governor menu190server # [ 0.250729] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.191server # [ 0.251750] ASID allocator initialised with 65536 entries192server # [ 0.258801] Serial: AMBA PL011 UART driver193server # [ 0.307877] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1194server # [ 0.309447] printk: legacy console [ttyAMA0] enabled195server # [ 0.344709] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages196server # [ 0.344894] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page197server # [ 0.345931] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages198server # [ 0.346339] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page199server # [ 0.346438] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages200server # [ 0.346543] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page201server # [ 0.346646] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages202server # [ 0.346741] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page203server # [ 0.366134] fbcon: Taking over console204server # [ 0.366754] ACPI: Interpreter disabled.205server # [ 0.374189] iommu: Default domain type: Translated206server # [ 0.374389] iommu: DMA domain TLB invalidation policy: strict mode207server # [ 0.378703] SCSI subsystem initialized208server # [ 0.381582] usbcore: registered new interface driver usbfs209server # [ 0.381902] usbcore: registered new interface driver hub210server # [ 0.382125] usbcore: registered new device driver usb211server # [ 0.386027] pps_core: LinuxPPS API ver. 1 registered212server # [ 0.386148] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>213server # [ 0.386324] PTP clock support registered214server # [ 0.387484] EDAC MC: Ver: 3.0.0215server # [ 0.390009] scmi_core: SCMI protocol bus registered216server # [ 0.393787] FPGA manager framework217server # [ 0.395444] Advanced Linux Sound Architecture Driver Initialized.218server # [ 0.405322] vgaarb: loaded219server # [ 0.408839] clocksource: Switched to clocksource arch_sys_counter220server # [ 0.411793] VFS: Disk quotas dquot_6.6.0221server # [ 0.411981] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)222server # [ 0.415751] netfs: FS-Cache loaded223server # [ 0.417002] pnp: PnP ACPI: disabled224server # [ 0.440394] NET: Registered PF_INET protocol family225server # [ 0.441837] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)226server # [ 0.553807] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)227server # [ 0.554253] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)228server # [ 0.556247] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)229server # [ 0.558570] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)230server # [ 0.559694] TCP: Hash tables configured (established 32768 bind 32768)231server # [ 0.561341] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)232server # [ 0.561866] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)233server # [ 0.562464] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)234server # [ 0.564173] NET: Registered PF_UNIX/PF_LOCAL protocol family235server # [ 0.564675] NET: Registered PF_XDP protocol family236server # [ 0.564891] PCI: CLS 0 bytes, default 64237server # [ 0.568542] Trying to unpack rootfs image as initramfs...238server # [ 0.570565] kvm [1]: HYP mode not available239server # [ 0.683059] Initialise system trusted keyrings240server # [ 0.684769] workingset: timestamp_bits=42 max_order=20 bucket_order=0241server # [ 0.689794] squashfs: version 4.0 (2009/01/31) Phillip Lougher242server # [ 0.690532] 9p: Installing v9fs 9p2000 file system support243server # [ 0.753785] Key type asymmetric registered244server # [ 0.754069] Asymmetric key parser 'x509' registered245server # [ 0.754808] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244)246server # [ 0.755997] io scheduler mq-deadline registered247server # [ 0.756162] io scheduler kyber registered248server # [ 0.785690] pl061_gpio 9030000.pl061: PL061 GPIO chip registered249server # [ 0.790550] ledtrig-cpu: registered to indicate activity on CPUs250server # [ 0.795126] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:251server # [ 0.795821] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000252server # [ 0.797219] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000253server # [ 0.797539] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000254server # [ 0.798771] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits255server # [ 0.799631] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]256server # [ 0.801265] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00257server # [ 0.802130] pci_bus 0000:00: root bus resource [bus 00-ff]258server # [ 0.802527] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]259server # [ 0.802672] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]260server # [ 0.802791] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]261server # [ 0.804657] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint262server # [ 0.808360] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint263server # [ 0.809846] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]264server # [ 0.810019] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]265server # [ 0.810174] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]266server # [ 0.810632] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]267server # [ 0.811749] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint268server # [ 0.811937] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]269server # [ 0.812043] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]270server # [ 0.812190] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271server # [ 0.813857] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint272server # [ 0.814187] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]273server # [ 0.814312] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]274server # [ 0.814433] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275server # [ 0.815287] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint276server # [ 0.815452] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]277server # [ 0.815556] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]278server # [ 0.815676] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279server # [ 0.816163] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint280server # [ 0.816326] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]281server # [ 0.816633] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]282server # [ 0.817845] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]283server # [ 0.818608] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint284server # [ 0.819376] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]285server # [ 0.819602] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]286server # [ 0.819873] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]287server # [ 0.820755] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint288server # [ 0.820924] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]289server # [ 0.821031] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]290server # [ 0.822138] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]291server # [ 0.822758] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]292server # [ 0.823998] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint293server # [ 0.824176] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]294server # [ 0.824346] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]295server # [ 0.826022] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint296server # [ 0.826372] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]297server # [ 0.827378] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298server # [ 0.828545] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint299server # [ 0.828717] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]300server # [ 0.829746] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint301server # [ 0.830054] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]302server # [ 0.830332] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]303server # [ 0.830667] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]304server # [ 0.831957] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint305server # [ 0.832528] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]306server # [ 0.832644] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]307server # [ 0.832853] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]308server # [ 0.836255] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned309server # [ 0.836570] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned310server # [ 0.837115] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned311server # [ 0.838044] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned312server # [ 0.838471] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned313server # [ 0.838625] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned314server # [ 0.838774] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned315server # [ 0.838915] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned316server # [ 0.839331] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned317server # [ 0.839480] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned318server # [ 0.839651] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned319server # [ 0.840117] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned320server # [ 0.840632] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned321server # [ 0.841595] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned322server # [ 0.841791] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned323server # [ 0.841910] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned324server # [ 0.842026] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned325server # [ 0.842148] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned326server # [ 0.842538] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned327server # [ 0.842657] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned328server # [ 0.842770] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned329server # [ 0.843330] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned330server # [ 0.843457] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned331server # [ 0.843571] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned332server # [ 0.843687] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned333server # [ 0.843811] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned334server # [ 0.844378] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned335server # [ 0.844510] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned336server # [ 0.845111] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned337server # [ 0.845559] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned338server # [ 0.845669] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned339server # [ 0.846018] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned340server # [ 0.846130] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned341server # [ 0.846236] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned342server # [ 0.846528] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]343server # [ 0.846645] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]344server # [ 0.846749] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]345server # [ 0.847769] pci 0000:00:0a.0: enabling device (0000 -> 0002)346server # [ 0.910903] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)347server # [ 0.915379] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)348server # [ 0.917755] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)349server # [ 0.919920] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)350server # [ 0.922557] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)351server # [ 0.925956] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)352server # [ 0.928194] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)353server # [ 0.930615] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)354server # [ 0.932613] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)355server # [ 0.934957] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)356server # [ 0.937765] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)357server # [ 0.953656] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled358server # [ 0.962904] msm_serial: driver initialized359server # [ 0.963978] SuperH (H)SCI(F) driver initialized360server # [ 0.964437] STM32 USART driver initialized361server # [ 1.014072] loop: module loaded362server # [ 1.014644] virtio_blk virtio5: 2/0/0 default/read/poll queues363server # [ 1.018197] Freeing initrd memory: 10684K364server # [ 1.018764] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)365server # [ 1.031438] megasas: 07.727.03.00-rc1366server # [ 1.036661] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]367server # [ 1.039748] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000368server # [ 1.040399] Intel/Sharp Extended Query Table at 0x0031369server # [ 1.042586] Using buffer write method370server # [ 1.043262] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]371server # [ 1.044596] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000372server # [ 1.044851] Intel/Sharp Extended Query Table at 0x0031373server # [ 1.046284] Using buffer write method374server # [ 1.046666] Concatenating MTD devices:375server # [ 1.046790] (0): "0.flash"376server # [ 1.046861] (1): "0.flash"377server # [ 1.046921] into device "0.flash"378server # [ 1.070960] tun: Universal TUN/TAP device driver, 1.6379server # [ 1.083296] thunder_xcv, ver 1.0380server # [ 1.083537] thunder_bgx, ver 1.0381server # [ 1.083715] nicpf, ver 1.0382server # [ 1.086600] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version383server # [ 1.086741] hns3: Copyright (c) 2017 Huawei Corporation.384server # [ 1.087086] hclge is initializing385server # [ 1.087325] e1000: Intel(R) PRO/1000 Network Driver386server # [ 1.087411] e1000: Copyright (c) 1999-2006 Intel Corporation.387server # [ 1.087611] e1000e: Intel(R) PRO/1000 Network Driver388server # [ 1.087697] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.389server # [ 1.087891] igb: Intel(R) Gigabit Ethernet Network Driver390server # [ 1.088118] igb: Copyright (c) 2007-2014 Intel Corporation.391server # [ 1.088405] igbvf: Intel(R) Gigabit Virtual Function Network Driver392server # [ 1.088510] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.393server # [ 1.089716] sky2: driver version 1.30394server # [ 1.098838] ehci-pci 0000:00:0a.0: EHCI Host Controller395server # [ 1.098918] usbcore: registered new interface driver usb-storage396server # [ 1.099745] usbcore: registered new interface driver usbserial_generic397server # [ 1.099787] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1398server # [ 1.100406] usbserial: USB Serial support registered for generic399server # [ 1.103402] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000400server # [ 1.111930] rtc-pl031 9010000.pl031: registered as rtc0401server # [ 1.112582] rtc-pl031 9010000.pl031: setting system clock to 2026-10-26T12:30:39 UTC (1793017839)402server # [ 1.114202] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00403server # [ 1.115564] i2c_dev: i2c /dev entries driver404server # [ 1.122372] hub 1-0:1.0: USB hub found405server # [ 1.123296] hub 1-0:1.0: 6 ports detected406server # [ 1.129732] sdhci: Secure Digital Host Controller Interface driver407server # [ 1.129881] sdhci: Copyright(c) Pierre Ossman408server # [ 1.131747] Synopsys Designware Multimedia Card Interface Driver409server # [ 1.134012] sdhci-pltfm: SDHCI platform and OF driver helper410server # [ 1.140667] hid: raw HID events driver (C) Jiri Kosina411server # [ 1.143594] usbcore: registered new interface driver usbhid412server # [ 1.143739] usbhid: USB HID core driver413server # [ 1.152659] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available414server # [ 1.167750] drop_monitor: Initializing network drop monitor service415server # [ 1.169932] NET: Registered PF_INET6 protocol family416server # [ 1.186404] Segment Routing with IPv6417server # [ 1.187277] In-situ OAM (IOAM) with IPv6418server # [ 1.188204] NET: Registered PF_PACKET protocol family419server # [ 1.190286] 9pnet: Installing 9P2000 support420server # [ 1.194719] Key type dns_resolver registered421server # [ 1.232312] registered taskstats version 1422server # [ 1.234903] Loading compiled-in X.509 certificates423server # [ 1.292583] Demotion targets for Node 0: null424server # [ 1.297411] Key type .fscrypt registered425server # [ 1.297577] Key type fscrypt-provisioning registered426server # [ 1.306898] input: gpio-keys as /devices/platform/gpio-keys/input/input0427server # [ 1.352273] clk: Disabling unused clocks428server # [ 1.352577] PM: genpd: Disabling unused power domains429server # [ 1.353744] ALSA device list:430server # [ 1.354030] No soundcards found.431server # [ 1.373283] usb 1-1: new high-speed USB device number 2 using ehci-pci432server # [ 1.443037] Freeing unused kernel memory: 4416K433server # [ 1.444161] Run /init as init process434server # [ 1.560501] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1435server # [ 1.692801] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0436server # [ 1.825869] usb 1-2: new high-speed USB device number 3 using ehci-pci437server # [ 2.000476] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2438server # [ 2.004433] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0439server # [ 2.045527] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev440server # [ 2.172234] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0441server # [ 2.173863] [drm] features: -virgl +edid -resource_blob -host_visible442server # [ 2.173894] [drm] features: -context_init443server # [ 2.176330] [drm] number of scanouts: 1444server # [ 2.176463] [drm] number of cap sets: 0445server # [ 2.187117] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0446server # [ 2.220459] Console: switching to colour frame buffer device 160x50447server # [ 2.233035] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device448server # [ 5.222510] EXT4-fs (vda): mounted filesystem 632388a0-6e5c-45ae-8039-6439a25c16a9 r/w with ordered data mode. Quota mode: none.449server # [ 7.725997] EXT4-fs (vda): re-mounted 632388a0-6e5c-45ae-8039-6439a25c16a9.450server # [ 7.744819] booting system configuration /nix/store/xh73y8sxr412g1sghc7vva42r7jgrzjb-nixos-system-server-test451server # [ 19.786099] systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN -IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE)452server # [ 19.795562] systemd[1]: Detected virtualization qemu.453server # [ 19.799911] systemd[1]: Detected architecture arm64.454server # [ 19.804546] systemd[1]: Detected first boot.455server # [ 19.831010] systemd[1]: Initializing machine ID from random generator.456server # [ 19.860314] systemd[1]: Hostname set to <server>.457server # [ 21.045424] systemd[1]: bpf-restrict-fs: LSM BPF program attached458server # [ 22.459410] systemd[1]: Applying preset policy.459server # [ 26.125694] systemd[1]: Populated /etc with preset unit settings.460server: Guest root shell did not produce any data yet...461server: To debug, enter the VM and run 'systemctl status backdoor.service'.462server # [ 29.143394] systemd[1]: Queued start job for default target Multi-User System.463server # [ 29.362986] systemd[1]: Created slice Slice /system/getty.464server # [ 29.377439] systemd[1]: Created slice Slice /system/modprobe.465server # [ 29.389938] systemd[1]: Created slice User and Session Slice.466server # [ 29.397726] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.467server # [ 29.402689] systemd[1]: Started Forward Password Requests to Wall Directory Watch.468server # [ 29.407917] systemd[1]: Expecting device /dev/hvc0...469server # [ 29.412502] systemd[1]: Expecting device /dev/ttyAMA0...470server # [ 29.417454] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1...471server # [ 29.421957] systemd[1]: Reached target Local Encrypted Volumes.472server # [ 29.426130] systemd[1]: Reached target Virtual Machines and Containers.473server # [ 29.430923] systemd[1]: Reached target Path Units.474server # [ 29.436033] systemd[1]: Reached target Remote File Systems.475server # [ 29.440547] systemd[1]: Reached target Slice Units.476server # [ 29.445192] systemd[1]: Reached target Swaps.477server # [ 29.478443] systemd[1]: Listening on Process Core Dump Socket.478server # [ 29.500106] systemd[1]: Listening on Credential Encryption/Decryption.479server # [ 29.510291] systemd[1]: Listening on Journal Audit Socket.480server # [ 29.516694] systemd[1]: Listening on Journal Socket (/dev/log).481server # [ 29.523156] systemd[1]: Listening on Journal Sockets.482server # [ 29.531011] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.483server # [ 29.536127] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki).484server # [ 29.542289] systemd[1]: Listening on udev Control Socket.485server # [ 29.547419] systemd[1]: Listening on udev Kernel Socket.486server # [ 29.594385] systemd[1]: Mounting Huge Pages File System...487server # [ 29.630759] systemd[1]: Mounting POSIX Message Queue File System...488server # [ 29.680611] systemd[1]: Mounting Kernel Debug File System...489server # [ 29.727467] systemd[1]: Mounting Kernel Trace File System...490server # [ 29.890832] systemd[1]: Starting Create List of Static Device Nodes...491server # [ 30.008645] systemd[1]: Starting Load Kernel Module 9pnet_virtio...492server # [ 30.024051] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs).493server # [ 30.147880] systemd[1]: Mounting Kernel Configuration File System...494server # [ 30.173294] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm).495server # [ 30.184600] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore).496server # [ 30.259416] systemd[1]: Starting Load Kernel Module fuse...497server # [ 30.270401] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).498server # [ 30.278726] systemd[1]: Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67).499server # [ 30.388491] systemd[1]: Starting Journal Service...500server # [ 30.492424] systemd[1]: Starting Load Kernel Modules...501server # [ 30.557840] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...502server # [ 30.618989] systemd[1]: Starting Remount Root and Kernel File Systems...503server # [ 30.626296] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).504server # [ 30.684299] systemd[1]: Starting Coldplug All udev Devices...505server # [ 30.766828] systemd[1]: Mounted Huge Pages File System.506server # [ 30.775916] systemd[1]: Mounted POSIX Message Queue File System.507server # [ 30.790154] systemd[1]: Mounted Kernel Debug File System.508server # [ 30.798703] systemd[1]: Mounted Kernel Trace File System.509server # [ 30.821562] systemd[1]: Finished Create List of Static Device Nodes.510server # [ 30.842202] systemd[1]: Mounted Kernel Configuration File System.511server # [ 30.908638] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...512server # [ 31.251429] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.513server # [ 31.270186] systemd[1]: Finished Load Kernel Module 9pnet_virtio.514server # [ 31.642181] systemd[1]: Finished Load Kernel Modules.515server # [ 31.695336] fuse: init (API version 7.41)516server # [ 31.706965] systemd[1]: Starting Firewall...517server # [ 31.772035] systemd[1]: Starting Apply Kernel Variables...518server # [ 31.774409] EXT4-fs (vda): re-mounted 632388a0-6e5c-45ae-8039-6439a25c16a9.519server # [ 31.846048] systemd[1]: modprobe@fuse.service: Deactivated successfully.520server # [ 31.862364] systemd[1]: Finished Load Kernel Module fuse.521server # [ 31.915240] systemd[1]: Mounting FUSE Control File System...522server # [ 31.949725] systemd[1]: Finished Remount Root and Kernel File Systems.523server # [ 31.973648] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).524server # [ 32.059539] systemd[1]: Starting Load/Save OS Random Seed...525server # [ 32.075942] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).526server # [ 32.130718] systemd-journald[398]: Collecting audit messages is enabled.527server # [ 32.246039] systemd[1]: Mounted FUSE Control File System.528server # [ 33.092723] systemd[1]: Finished Load/Save OS Random Seed.529server # [ 33.103812] systemd[1]: Reached target First Boot Complete.530server # [ 33.221066] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.531server # [ 33.355722] systemd[1]: Starting Create Static Device Nodes in /dev...532server # [ 33.371677] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.533server # [ 33.575929] systemd[1]: Finished Apply Kernel Variables.534server # [ 34.404094] systemd[1]: Finished Create Static Device Nodes in /dev.535server # [ 34.415895] systemd[1]: Reached target Preparation for Local File Systems.536server # [ 34.460276] systemd[1]: Mounting /run/wrappers...537server # [ 34.502331] systemd[1]: Starting Rule-based Manager for Device Events and Files...538server # [ 34.821110] systemd[1]: Mounted /run/wrappers.539server # [ 34.831194] systemd[1]: Reached target Local File Systems.540server # [ 34.852555] systemd[1]: Listening on Boot Entries Service Socket.541server # [ 34.914266] systemd[1]: Starting Create SUID/SGID Wrappers...542server # [ 34.920105] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met.543server # [ 34.954806] systemd[1]: Starting Save Transient machine-id to Disk...544server # [ 35.047424] systemd[1]: Started Journal Service.545server # [ 34.988563] systemd-modules-load[399]: Module 'atkbd' is built in546server # [ 35.012049] systemd-modules-load[399]: Module 'loop' is built in547server # [ 35.091042] systemd-oomd[400]: No swap; memory pressure usage will be degraded548server # [ 35.127980] systemd[1]: Starting Flush Journal to Persistent Storage...549server # [ 35.986850] systemd-journald[398]: Received client request to flush runtime journal.550server # [ 36.515168] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.551server # [ 36.524319] systemd[1]: Finished Save Transient machine-id to Disk.552server # [ 36.596163] systemd-udevd[427]: Using default interface naming scheme 'v258'.553server # [ 36.639241] systemd[1]: Finished Flush Journal to Persistent Storage.554server # [ 36.659686] systemd[1]: Starting Create System Files and Directories...555server # [ 38.520163] systemd[1]: Finished Create System Files and Directories.556server # [ 38.559092] systemd[1]: Starting Rebuild Journal Catalog...557server # [ 38.585715] systemd[1]: Starting Record System Boot/Shutdown in UTMP...558server # [ 38.735901] systemd[1]: Started Rule-based Manager for Device Events and Files.559server # [ 39.287572] systemd[1]: Finished Record System Boot/Shutdown in UTMP.560server # [ 40.268387] systemd[1]: Finished Rebuild Journal Catalog.561server # [ 40.311584] systemd[1]: Starting Update is Completed...562server # [ 40.968154] systemd[1]: Finished Update is Completed.563server # [ 43.879098] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.564server # [ 43.887645] systemd[1]: Finished Create SUID/SGID Wrappers.565server # [ 43.893043] systemd[1]: suid-sgid-wrappers.service: Consumed 2.473s CPU time, 5.5M memory peak.566server # [ 46.659351] systemd[1]: Finished Firewall.567server # [ 47.991507] systemd[1]: Finished Coldplug All udev Devices.568server # [ 48.000180] systemd[1]: Reached target System Initialization.569server # [ 48.017339] systemd[1]: Started Discard unused filesystem blocks once a week.570server # [ 48.019929] systemd[1]: Started Daily Cleanup of Temporary Directories.571server # [ 48.031420] systemd[1]: Reached target Timer Units.572server # [ 48.043467] systemd[1]: Listening on D-Bus System Message Bus Socket.573server # [ 48.050219] systemd[1]: Listening on Nix Daemon Socket.574server # [ 48.051306] systemd[1]: Listening on Hostname Service Socket.575server # [ 48.059227] systemd[1]: Reached target Socket Units.576server # [ 48.064905] systemd[1]: Reached target Basic System.577server # [ 48.083532] systemd[1]: Starting Import lastlog data into lastlog2 database...578server # [ 48.138232] systemd[1]: Starting Name Service Cache Daemon (nsncd)...579server # [ 48.186367] systemd[1]: Started Reset console on configuration changes.580server # [ 48.262699] systemd[1]: Starting resolvconf update...581server # [ 48.313508] systemd[1]: Starting D-Bus System Message Bus...582server # [ 49.308234] systemd[1]: Finished Import lastlog data into lastlog2 database.583server # [ 49.435475] nsncd[634]: Oct 26 12:31:27.867 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"584server # [ 49.466315] systemd[1]: Started Name Service Cache Daemon (nsncd).585server # [ 49.469313] systemd[1]: Reached target Host and Network Name Lookups.586server # [ 49.474218] systemd[1]: Reached target User and Group Name Lookups.587server # [ 49.515872] systemd[1]: Starting User Login Management...588server # [ 49.678973] dbus-daemon[637]: dbus[637]: Unknown username "systemd-timesync" in message bus configuration file589server # [ 50.012977] systemd[1]: Started D-Bus System Message Bus.590server # [ 50.898369] systemd-logind[654]: New seat seat0.591server # [ 50.928460] systemd[1]: Stopped target Host and Network Name Lookups.592server # [ 50.951133] systemd[1]: Stopping Host and Network Name Lookups...593server # [ 50.959881] systemd[1]: Stopped target User and Group Name Lookups.594server # [ 50.973164] systemd[1]: Stopping User and Group Name Lookups...595server # [ 50.983693] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...596server # [ 50.998251] systemd[1]: Started User Login Management.597server # [ 51.003516] systemd[1]: Starting linger-users.service...598server # [ 51.018190] systemd[1]: nscd.service: Deactivated successfully.599server # [ 51.025879] systemd[1]: Stopped Name Service Cache Daemon (nsncd).600server # [ 51.169206] systemd[1]: Starting Name Service Cache Daemon (nsncd)...601server # [ 51.588812] systemd[1]: linger-users.service: Deactivated successfully.602server # [ 51.603370] systemd[1]: Finished linger-users.service.603server # [ 51.790951] nsncd[695]: Oct 26 12:31:30.225 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"604server # [ 51.797484] systemd[1]: Started Name Service Cache Daemon (nsncd).605server # [ 51.798734] systemd[1]: Reached target Host and Network Name Lookups.606server # [ 51.805714] systemd[1]: Reached target User and Group Name Lookups.607server # [ 52.170643] systemd[1]: Finished resolvconf update.608server # [ 52.194455] systemd[1]: Reached target Preparation for Network.609server # [ 52.249995] systemd[1]: Starting DHCP Client...610server # [ 53.547238] dhcpcd[744]: dhcpcd-10.2.4 starting611server # [ 53.627140] dhcpcd[749]: dev: loaded udev612server # [ 53.972277] 8021q: 802.1Q VLAN Support v1.8613server # [ 54.374644] cfg80211: Loading compiled-in X.509 certificates for regulatory database614server # [ 54.497367] systemd[1]: Found device /dev/hvc0.615server # [ 54.602219] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'616server # [ 54.606408] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'617server # [ 54.632425] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2618server # [ 54.639815] cfg80211: failed to load regulatory.db619server # [ 55.308043] 8021q: adding VLAN 0 to HW filter on device eth0620server # [ 55.238708] dhcpcd[749]: eth0: waiting for carrier621server # [ 55.260029] dhcpcd[749]: eth0: carrier acquired622server # [ 55.333978] dhcpcd[749]: DUID 00:01:00:01:32:72:04:a5:52:54:00:12:34:56623server # [ 55.341197] dhcpcd[749]: eth0: IAID 00:12:34:56624server # [ 55.342263] dhcpcd[749]: eth0: adding address fe80::5054:ff:fe12:3456625server # [ 56.107586] systemd[1]: Found device /dev/ttyAMA0.626server # [ 56.133222] systemd[1]: Started backdoor.service.627server # [ 56.530634] (udev-worker)[771]: Network interface NamePolicy= disabled on kernel command line.628server # [ 56.542977] (udev-worker)[775]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.629server # [ 56.549699] (udev-worker)[775]: Network interface NamePolicy= disabled on kernel command line.630server # connecting to host...631server # [ 56.779601] dhcpcd[749]: eth0: soliciting a DHCP lease632server # [ 56.815060] dhcpcd[749]: eth0: offered 10.0.2.15 from 10.0.2.2633server: Guest shell says: b'Spawning backdoor root shell...\n'634server: connected to guest root shell635server: (connecting took 57.82 seconds)636server: (finished: waiting for the VM to finish booting, in 57.82 seconds)637server # [ 56.839756] dhcpcd[749]: eth0: probing address 10.0.2.15/24638server # [ 57.137004] dhcpcd[749]: eth0: soliciting an IPv6 router639server # [ 57.158184] dhcpcd[749]: eth0: Router Advertisement from fe80::2640server # [ 57.159699] dhcpcd[749]: eth0: adding address fec0::5054:ff:fe12:3456/64641server # [ 57.170380] dhcpcd[749]: eth0: adding route to fec0::/64642server # [ 57.171398] dhcpcd[749]: eth0: adding default route via fe80::2643server # [ 57.966448] dhcpcd[749]: eth0: IAID 00:12:34:56644server # [ 58.011128] dhcpcd[749]: eth0: soliciting an IPv6 router645server # [ 58.111907] systemd[1]: Found device Virtio network device.646server # [ 58.162361] systemd[1]: Starting Address configuration of eth1...647server # [ 58.351646] dhcpcd[749]: eth0: soliciting a DHCP lease648server # [ 58.353886] dhcpcd[749]: eth0: offered 10.0.2.15 from 10.0.2.2649server # [ 58.355756] dhcpcd[749]: eth0: probing address 10.0.2.15/24650server # [ 58.861814] 8021q: adding VLAN 0 to HW filter on device eth1651server # [ 58.988396] network-addresses-eth1-start[802]: adding address 192.168.1.1/24... done652server # [ 59.078659] network-addresses-eth1-start[802]: adding address 2001:db8:1::1/64... done653server # [ 59.223615] systemd[1]: Finished Address configuration of eth1.654server # [ 59.274786] systemd[1]: Starting Networking Setup...655server # [ 60.484437] systemd-logind[654]: Watching system buttons on /dev/input/event0 (gpio-keys)656server # [ 60.679333] systemd[1]: Finished Networking Setup.657server # [ 60.692690] systemd[1]: Reached target Network.658server # [ 60.704991] systemd[1]: Starting PostgreSQL Database Server...659server # [ 60.739881] systemd[1]: Starting Permit User Sessions...660server # [ 61.102494] systemd[1]: Finished Permit User Sessions.661server # [ 61.143600] systemd[1]: Started Getty on tty1.662server # [ 61.152821] systemd[1]: Reached target Login Prompts.663server # [ 61.622015] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[894]: Initializing database at /var/lib/postgresql/data664server # [ 63.211704] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: The files belonging to this database system will be owned by user "postgres".665server # [ 63.219113] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: This user must also own the server process.666server # [ 63.289381] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: The database cluster will be initialized with locale "en_US.UTF-8".667server # [ 63.297144] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: The default database encoding has accordingly been set to "UTF8".668server # [ 63.298244] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: The default text search configuration will be set to "english".669server # [ 63.299540] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: Data page checksums are enabled.670server # [ 63.306872] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: fixing permissions on existing directory /var/lib/postgresql/data ... ok671server # [ 63.343512] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: creating subdirectories ... ok672server # [ 63.351415] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: selecting dynamic shared memory implementation ... posix673server # [ 63.522078] dhcpcd[749]: eth0: leased 10.0.2.15 for 86400 seconds674server # [ 63.537503] dhcpcd[749]: eth0: adding route to 10.0.2.0/24675server # [ 63.540152] dhcpcd[749]: eth0: adding default route via 10.0.2.2676server # [ 64.951632] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: selecting default "max_connections" ... 100677server # [ 65.869067] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: selecting default "shared_buffers" ... 128MB678server # [ 66.826425] systemd[1]: Started DHCP Client.679server # [ 67.797607] mousedev: PS/2 mouse device common for all mice680server # [ 71.531734] systemd-logind[654]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)681server # [ 75.307014] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: selecting default time zone ... UTC682server # [ 75.335538] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: creating configuration files ... ok683server # [ 79.819176] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: running bootstrap script ... ok684server # [ 90.323230] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: performing post-bootstrap initialization ... ok685server # [ 93.006849] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: syncing data to disk ... ok686server # [ 93.011285] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: initdb: warning: enabling "trust" authentication for local connections687server # [ 93.017238] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: initdb: hint: You can change this by editing pg_hba.conf or using the option -A, or --auth-local and --auth-host, the next time you run initdb.688server # [ 93.024567] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: Success. You can now start the database server using:689server # [ 93.029981] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[899]: /nix/store/2b08ap06lbcgyk3pnh18zsw06n7rp0vb-postgresql-and-plugins-17.11/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start690server # [ 94.657538] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[894]: Validating PostgreSQL configuration...691server # [ 95.298694] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[1280]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, auto_explain, pg_tle, plan_filter, supabase_vault692server # [ 96.658188] postgres[1296]: 2026-10-26 12:32:15.112 UTC [1296] LOG: pgaudit extension initialized693server # [ 97.314268] postgres[1296]: 2026-10-26 12:32:15.782 UTC [1296] LOG: pgsodium primary server secret key loaded694server # [ 97.712032] postgres[1296]: 2026-10-26 12:32:16.171 UTC [1296] LOG: vault primary server secret key loaded695server # [ 98.358196] postgres[1296]: 2026-10-26 12:32:16.826 UTC [1296] LOG: starting PostgreSQL 17.11 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit696server # [ 98.393730] postgres[1296]: 2026-10-26 12:32:16.857 UTC [1296] LOG: listening on IPv4 address "0.0.0.0", port 5432697server # [ 98.396025] postgres[1296]: 2026-10-26 12:32:16.863 UTC [1296] LOG: listening on IPv6 address "::", port 5432698server # [ 98.428934] postgres[1296]: 2026-10-26 12:32:16.895 UTC [1296] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"699server # [ 98.684733] postgres[1329]: 2026-10-26 12:32:17.141 UTC [1329] LOG: database system was shut down at 2026-10-26 12:32:08 UTC700server # [ 99.127508] postgres[1296]: 2026-10-26 12:32:17.591 UTC [1296] LOG: database system is ready to accept connections701server # [ 99.253312] systemd[1]: Started PostgreSQL Database Server.702server # [ 99.279236] postgres[1339]: 2026-10-26 12:32:17.716 UTC [1339] FATAL: role "postgres" does not exist703server # [ 99.308116] systemd[1]: Starting Refresh default collation version...704server # [ 99.397272] systemd[1]: Starting Supabase Database Initialization...705server # [ 99.469876] postgres[1296]: 2026-10-26 12:32:17.931 UTC [1296] LOG: background worker "pg_net 0.20.4 worker" (PID 1339) exited with exit code 1706server # [ 99.765098] postgres[1341]: 2026-10-26 12:32:18.217 UTC [1341] LOG: pg_cron scheduler started707server # [ 100.074458] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Waiting for PostgreSQL to be ready...708server # [ 100.560427] postgres[1355]: 2026-10-26 12:32:19.023 UTC [1355] FATAL: role "postgres" does not exist709server # [ 100.664019] postgres[1296]: 2026-10-26 12:32:19.120 UTC [1296] LOG: background worker "pg_net 0.20.4 worker" (PID 1355) exited with exit code 1710server # [ 100.718463] postgres[1357]: ::1 2026-10-26 12:32:19.162 UTC [1357] root@root FATAL: role "root" does not exist711server # [ 100.756077] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: PostgreSQL is ready712server # [ 100.765660] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Creating postgres role...713server # [ 100.936502] postgres[1356]: ::1 2026-10-26 12:32:19.397 UTC [1356] supabase_admin@postgres LOG: statement: create temp view stale as714server # [ 100.940033] postgres[1356]: select datname,715server # [ 100.943623] postgres[1356]: string_to_array(datcollversion, '.')::int[] between string_to_array('2.31', '.')::int[] and string_to_array('2.44', '.')::int[]716server # [ 100.946399] postgres[1356]: and string_to_array(pg_database_collation_actual_version(oid), '.')::int[] between string_to_array('2.31', '.')::int[] and string_to_array('2.44', '.')::int[] as in_bounds717server # [ 100.948778] postgres[1356]: from pg_database718server # [ 100.950332] postgres[1356]: where datlocprovider = 'c'719server # [ 100.951694] postgres[1356]: and datcollate in ('en_US.UTF-8', 'en_US.utf8')720server # [ 100.954675] postgres[1356]: and datcollversion is not null721server # [ 100.955964] postgres[1356]: and datcollversion <> pg_database_collation_actual_version(oid);722server # [ 101.122211] postgres[1359]: ::1 2026-10-26 12:32:19.579 UTC [1359] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN;723server # [ 101.131845] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1358]: CREATE ROLE724server # [ 101.379639] systemd[1]: Finished Refresh default collation version.725server # [ 101.595623] postgres[1362]: ::1 2026-10-26 12:32:20.052 UTC [1362] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres;726server # [ 101.671038] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1360]: ALTER DATABASE727server # [ 101.714929] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql728server # [ 102.098568] postgres[1369]: ::1 2026-10-26 12:32:20.550 UTC [1369] postgres@postgres LOG: statement: create publication supabase_realtime;729server # [ 102.152453] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: CREATE PUBLICATION730server # [ 102.155931] postgres[1369]: ::1 2026-10-26 12:32:20.611 UTC [1369] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls;731server # [ 102.179308] postgres[1369]: ::1 2026-10-26 12:32:20.635 UTC [1369] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication;732server # [ 102.185380] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: ALTER ROLE733server # [ 102.186312] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: CREATE ROLE734server # [ 102.198991] postgres[1369]: ::1 2026-10-26 12:32:20.656 UTC [1369] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls;735server # [ 102.221710] postgres[1369]: ::1 2026-10-26 12:32:20.684 UTC [1369] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin;736server # [ 102.222997] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: CREATE ROLE737server # [ 102.278298] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: GRANT ROLE738server # [ 102.290331] postgres[1369]: ::1 2026-10-26 12:32:20.751 UTC [1369] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin;739server # [ 102.317399] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: GRANT740server # [ 102.320304] postgres[1369]: ::1 2026-10-26 12:32:20.780 UTC [1369] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls;741server # [ 102.334507] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: CREATE ROLE742server # [ 102.339729] postgres[1369]: ::1 2026-10-26 12:32:20.798 UTC [1369] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user;743server # [ 102.347928] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: GRANT ROLE744server # [ 102.355167] postgres[1369]: ::1 2026-10-26 12:32:20.822 UTC [1369] postgres@postgres LOG: statement: create schema if not exists extensions;745server # [ 102.402379] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: CREATE SCHEMA746server # [ 102.421675] postgres[1369]: ::1 2026-10-26 12:32:20.889 UTC [1369] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions;747server # [ 104.909873] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: CREATE EXTENSION748server # [ 104.918052] postgres[1369]: ::1 2026-10-26 12:32:23.370 UTC [1369] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions;749server # [ 105.946789] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: CREATE EXTENSION750server # [ 105.960086] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: CREATE ROLE751server # [ 105.995067] postgres[1369]: ::1 2026-10-26 12:32:24.397 UTC [1369] postgres@postgres LOG: statement: create role anon nologin noinherit;752server # [ 106.005732] postgres[1369]: ::1 2026-10-26 12:32:24.420 UTC [1369] postgres@postgres LOG: statement: create role authenticated nologin noinherit;753server # [ 106.007843] postgres[1369]: ::1 2026-10-26 12:32:24.433 UTC [1369] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls;754server # [ 106.018700] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: CREATE ROLE755server # [ 106.019261] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: CREATE ROLE756server # [ 106.019554] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: CREATE ROLE757server # [ 106.019890] postgres[1369]: ::1 2026-10-26 12:32:24.456 UTC [1369] postgres@postgres LOG: statement: create user authenticator noinherit;758server # [ 106.025166] postgres[1369]: ::1 2026-10-26 12:32:24.471 UTC [1369] postgres@postgres LOG: statement: grant anon to authenticator;759server # [ 106.027143] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: GRANT ROLE760server # [ 106.031586] postgres[1369]: ::1 2026-10-26 12:32:24.489 UTC [1369] postgres@postgres LOG: statement: grant authenticated to authenticator;761server # [ 106.041672] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: GRANT ROLE762server # [ 106.043454] postgres[1369]: ::1 2026-10-26 12:32:24.508 UTC [1369] postgres@postgres LOG: statement: grant service_role to authenticator;763server # [ 106.053893] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: GRANT ROLE764server # [ 106.061613] postgres[1369]: ::1 2026-10-26 12:32:24.520 UTC [1369] postgres@postgres LOG: statement: grant supabase_admin to authenticator;765server # [ 106.073654] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: GRANT ROLE766server # [ 106.081755] postgres[1369]: ::1 2026-10-26 12:32:24.545 UTC [1369] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role;767server # [ 106.094151] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: GRANT768server # [ 106.095378] postgres[1369]: ::1 2026-10-26 12:32:24.562 UTC [1369] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;769server # [ 106.129149] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: ALTER DEFAULT PRIVILEGES770server # [ 106.147251] postgres[1369]: ::1 2026-10-26 12:32:24.611 UTC [1369] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;771server # [ 106.180972] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: ALTER DEFAULT PRIVILEGES772server # [ 106.185055] postgres[1369]: ::1 2026-10-26 12:32:24.650 UTC [1369] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;773server # [ 106.206973] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: ALTER DEFAULT PRIVILEGES774server # [ 106.211823] postgres[1369]: ::1 2026-10-26 12:32:24.673 UTC [1369] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role;775server # [ 106.225561] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: GRANT776server # [ 106.227115] postgres[1369]: ::1 2026-10-26 12:32:24.690 UTC [1369] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions;777server # [ 106.249733] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: ALTER ROLE778server # [ 106.251392] postgres[1369]: ::1 2026-10-26 12:32:24.712 UTC [1369] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all779server # [ 106.252154] postgres[1369]: on sequences to postgres, anon, authenticated, service_role;780server # [ 106.265436] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: ALTER DEFAULT PRIVILEGES781server # [ 106.274090] postgres[1369]: ::1 2026-10-26 12:32:24.734 UTC [1369] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all782server # [ 106.274932] postgres[1369]: on tables to postgres, anon, authenticated, service_role;783server # [ 106.288409] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: ALTER DEFAULT PRIVILEGES784server # [ 106.297838] postgres[1369]: ::1 2026-10-26 12:32:24.759 UTC [1369] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all785server # [ 106.312995] postgres[1369]: on functions to postgres, anon, authenticated, service_role;786server # [ 106.327636] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: ALTER DEFAULT PRIVILEGES787server # [ 106.329770] postgres[1369]: ::1 2026-10-26 12:32:24.796 UTC [1369] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s';788server # [ 106.352944] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: ALTER ROLE789server # [ 106.353831] postgres[1369]: ::1 2026-10-26 12:32:24.818 UTC [1369] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s';790server # [ 106.378269] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1366]: ALTER ROLE791server # [ 106.471544] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql792server # [ 106.878145] postgres[1418]: ::1 2026-10-26 12:32:25.328 UTC [1418] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;793server # [ 106.914036] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE SCHEMA794server # [ 106.915595] postgres[1418]: ::1 2026-10-26 12:32:25.374 UTC [1418] postgres@postgres LOG: statement: CREATE TABLE auth.users (795server # [ 106.916082] postgres[1418]: instance_id uuid NULL,796server # [ 106.916357] postgres[1418]: id uuid NOT NULL UNIQUE,797server # [ 106.923757] postgres[1418]: aud varchar(255) NULL,798server # [ 106.930083] postgres[1418]: "role" varchar(255) NULL,799server # [ 106.931185] postgres[1418]: email varchar(255) NULL UNIQUE,800server # [ 106.933208] postgres[1418]: encrypted_password varchar(255) NULL,801server # [ 106.933762] postgres[1418]: confirmed_at timestamptz NULL,802server # [ 106.934797] postgres[1418]: invited_at timestamptz NULL,803server # [ 106.936188] postgres[1418]: confirmation_token varchar(255) NULL,804server # [ 106.949415] postgres[1418]: confirmation_sent_at timestamptz NULL,805server # [ 106.950705] postgres[1418]: recovery_token varchar(255) NULL,806server # [ 106.951525] postgres[1418]: recovery_sent_at timestamptz NULL,807server # [ 106.952087] postgres[1418]: email_change_token varchar(255) NULL,808server # [ 106.952987] postgres[1418]: email_change varchar(255) NULL,809server # [ 106.953545] postgres[1418]: email_change_sent_at timestamptz NULL,810server # [ 106.953897] postgres[1418]: last_sign_in_at timestamptz NULL,811server # [ 106.954158] postgres[1418]: raw_app_meta_data jsonb NULL,812server # [ 106.954994] postgres[1418]: raw_user_meta_data jsonb NULL,813server # [ 106.956285] postgres[1418]: is_super_admin bool NULL,814server # [ 106.961523] postgres[1418]: created_at timestamptz NULL,815server # [ 106.962795] postgres[1418]: updated_at timestamptz NULL,816server # [ 106.963311] postgres[1418]: CONSTRAINT users_pkey PRIMARY KEY (id)817server # [ 106.963606] postgres[1418]: );818server # [ 107.014324] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE TABLE819server # [ 107.017610] postgres[1418]: ::1 2026-10-26 12:32:25.485 UTC [1418] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);820server # [ 107.033175] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE INDEX821server # [ 107.034322] postgres[1418]: ::1 2026-10-26 12:32:25.501 UTC [1418] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);822server # [ 107.047541] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE INDEX823server # [ 107.049760] postgres[1418]: ::1 2026-10-26 12:32:25.516 UTC [1418] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';824server # [ 107.061353] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: COMMENT825server # [ 107.063958] postgres[1418]: ::1 2026-10-26 12:32:25.527 UTC [1418] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens (826server # [ 107.071373] postgres[1418]: instance_id uuid NULL,827server # [ 107.077358] postgres[1418]: id bigserial NOT NULL,828server # [ 107.077936] postgres[1418]: "token" varchar(255) NULL,829server # [ 107.078264] postgres[1418]: user_id varchar(255) NULL,830server # [ 107.079200] postgres[1418]: revoked bool NULL,831server # [ 107.080170] postgres[1418]: created_at timestamptz NULL,832server # [ 107.091113] postgres[1418]: updated_at timestamptz NULL,833server # [ 107.091903] postgres[1418]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)834server # [ 107.097056] postgres[1418]: );835server # [ 107.139079] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE TABLE836server # [ 107.140224] postgres[1418]: ::1 2026-10-26 12:32:25.602 UTC [1418] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);837server # [ 107.153533] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE INDEX838server # [ 107.158615] postgres[1418]: ::1 2026-10-26 12:32:25.623 UTC [1418] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id);839server # [ 107.178898] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE INDEX840server # [ 107.185530] postgres[1418]: ::1 2026-10-26 12:32:25.645 UTC [1418] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);841server # [ 107.191376] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE INDEX842server # [ 107.193714] postgres[1418]: ::1 2026-10-26 12:32:25.660 UTC [1418] postgres@postgres LOG: statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.';843server # [ 107.200373] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: COMMENT844server # [ 107.203477] postgres[1418]: ::1 2026-10-26 12:32:25.671 UTC [1418] postgres@postgres LOG: statement: CREATE TABLE auth.instances (845server # [ 107.209256] postgres[1418]: id uuid NOT NULL,846server # [ 107.210111] postgres[1418]: uuid uuid NULL,847server # [ 107.210713] postgres[1418]: raw_base_config text NULL,848server # [ 107.211274] postgres[1418]: created_at timestamptz NULL,849server # [ 107.212036] postgres[1418]: updated_at timestamptz NULL,850server # [ 107.217969] postgres[1418]: CONSTRAINT instances_pkey PRIMARY KEY (id)851server # [ 107.219168] postgres[1418]: );852server # [ 107.236974] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE TABLE853server # [ 107.238410] postgres[1418]: ::1 2026-10-26 12:32:25.703 UTC [1418] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';854server # [ 107.248024] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: COMMENT855server # [ 107.250714] postgres[1418]: ::1 2026-10-26 12:32:25.718 UTC [1418] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries (856server # [ 107.255235] postgres[1418]: instance_id uuid NULL,857server # [ 107.255651] postgres[1418]: id uuid NOT NULL,858server # [ 107.255915] postgres[1418]: payload json NULL,859server # [ 107.256160] postgres[1418]: created_at timestamptz NULL,860server # [ 107.256431] postgres[1418]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)861server # [ 107.262325] postgres[1418]: );862server # [ 107.273233] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE TABLE863server # [ 107.274484] postgres[1418]: ::1 2026-10-26 12:32:25.739 UTC [1418] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);864server # [ 107.291014] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE INDEX865server # [ 107.297290] postgres[1418]: ::1 2026-10-26 12:32:25.762 UTC [1418] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';866server # [ 107.302747] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: COMMENT867server # [ 107.308915] postgres[1418]: ::1 2026-10-26 12:32:25.773 UTC [1418] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations (868server # [ 107.310834] postgres[1418]: "version" varchar(255) NOT NULL,869server # [ 107.311621] postgres[1418]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")870server # [ 107.312019] postgres[1418]: );871server # [ 107.322695] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE TABLE872server # [ 107.325863] postgres[1418]: ::1 2026-10-26 12:32:25.794 UTC [1418] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';873server # [ 107.335725] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: COMMENT874server # [ 107.357605] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: INSERT 0 7875server # [ 107.358454] postgres[1418]: ::1 2026-10-26 12:32:25.826 UTC [1418] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$876server # [ 107.359089] postgres[1418]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;877server # [ 107.363193] postgres[1418]: $$ language sql stable;878server # [ 107.372994] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE FUNCTION879server # [ 107.374003] postgres[1418]: ::1 2026-10-26 12:32:25.839 UTC [1418] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$880server # [ 107.374898] postgres[1418]: select nullif(current_setting('request.jwt.claim.role', true), '')::text;881server # [ 107.375438] postgres[1418]: $$ language sql stable;882server # [ 107.383845] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE FUNCTION883server # [ 107.389571] postgres[1418]: ::1 2026-10-26 12:32:25.854 UTC [1418] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$884server # [ 107.390701] postgres[1418]: select nullif(current_setting('request.jwt.claim.email', true), '')::text;885server # [ 107.391400] postgres[1418]: $$ language sql stable;886server # [ 107.398793] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE FUNCTION887server # [ 107.409414] postgres[1418]: ::1 2026-10-26 12:32:25.869 UTC [1418] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;888server # [ 107.412112] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: GRANT889server # [ 107.414784] postgres[1418]: ::1 2026-10-26 12:32:25.882 UTC [1418] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;890server # [ 107.419914] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: CREATE ROLE891server # [ 107.426324] postgres[1418]: ::1 2026-10-26 12:32:25.890 UTC [1418] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;892server # [ 107.433691] postgres[1418]: ::1 2026-10-26 12:32:25.900 UTC [1418] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;893server # [ 107.435375] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: GRANT894server # [ 107.442684] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: GRANT895server # [ 107.443554] postgres[1418]: ::1 2026-10-26 12:32:25.910 UTC [1418] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;896server # [ 107.453506] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: GRANT897server # [ 107.454959] postgres[1418]: ::1 2026-10-26 12:32:25.919 UTC [1418] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth";898server # [ 107.460168] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: ALTER ROLE899server # [ 107.466313] postgres[1418]: ::1 2026-10-26 12:32:25.930 UTC [1418] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin;900server # [ 107.477833] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: ALTER TABLE901server # [ 107.482264] postgres[1418]: ::1 2026-10-26 12:32:25.948 UTC [1418] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;902server # [ 107.494479] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: ALTER TABLE903server # [ 107.498361] postgres[1418]: ::1 2026-10-26 12:32:25.966 UTC [1418] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;904server # [ 107.509284] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: ALTER TABLE905server # [ 107.510863] postgres[1418]: ::1 2026-10-26 12:32:25.975 UTC [1418] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;906server # [ 107.521835] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: ALTER TABLE907server # [ 107.527099] postgres[1418]: ::1 2026-10-26 12:32:25.991 UTC [1418] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;908server # [ 107.533005] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1415]: ALTER TABLE909server # [ 107.571588] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql910server # [ 107.834158] postgres[1421]: ::1 2026-10-26 12:32:26.294 UTC [1421] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;911server # [ 107.848919] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1420]: CREATE SCHEMA912server # [ 107.851687] postgres[1421]: ::1 2026-10-26 12:32:26.315 UTC [1421] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;913server # [ 107.865556] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1420]: CREATE ROLE914server # [ 107.866888] postgres[1421]: ::1 2026-10-26 12:32:26.329 UTC [1421] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage";915server # [ 107.876826] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1420]: ALTER ROLE916server # [ 107.878289] postgres[1421]: ::1 2026-10-26 12:32:26.345 UTC [1421] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;917server # [ 107.895561] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1420]: GRANT918server # [ 107.951363] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1420]: DO919server # [ 108.018672] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql920server # [ 108.457148] postgres[1427]: ::1 2026-10-26 12:32:26.892 UTC [1427] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;921server # [ 108.472055] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: ALTER ROLE922server # [ 108.479838] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: ALTER ROLE923server # [ 108.486672] postgres[1427]: ::1 2026-10-26 12:32:26.929 UTC [1427] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;924server # [ 108.488258] postgres[1427]: ::1 2026-10-26 12:32:26.943 UTC [1427] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()925server # [ 108.501711] postgres[1427]: RETURNS event_trigger926server # [ 108.503182] postgres[1427]: LANGUAGE plpgsql927server # [ 108.504244] postgres[1427]: AS $$928server # [ 108.509356] postgres[1427]: DECLARE929server # [ 108.510228] postgres[1427]: schema_is_cron bool;930server # [ 108.511033] postgres[1427]: BEGIN931server # [ 108.516139] postgres[1427]: schema_is_cron = (932server # [ 108.526845] postgres[1427]: SELECT n.nspname = 'cron'933server # [ 108.534439] postgres[1427]: FROM pg_event_trigger_ddl_commands() AS ev934server # [ 108.536297] postgres[1427]: LEFT JOIN pg_catalog.pg_namespace AS n935server # [ 108.537168] postgres[1427]: ON ev.objid = n.oid936server # [ 108.542438] postgres[1427]: );937server # [ 108.549704] postgres[1427]:938server # [ 108.551154] postgres[1427]: IF schema_is_cron939server # [ 108.551811] postgres[1427]: THEN940server # [ 108.552135] postgres[1427]: grant usage on schema cron to postgres with grant option;941server # [ 108.552408] postgres[1427]:942server # [ 108.558973] postgres[1427]: alter default privileges in schema cron grant all on tables to postgres with grant option;943server # [ 108.568936] postgres[1427]: alter default privileges in schema cron grant all on functions to postgres with grant option;944server # [ 108.570685] postgres[1427]: alter default privileges in schema cron grant all on sequences to postgres with grant option;945server # [ 108.571544] postgres[1427]:946server # [ 108.572178] postgres[1427]: alter default privileges for user supabase_admin in schema cron grant all947server # [ 108.584732] postgres[1427]: on sequences to postgres with grant option;948server # [ 108.587978] postgres[1427]: alter default privileges for user supabase_admin in schema cron grant all949server # [ 108.598659] postgres[1427]: on tables to postgres with grant option;950server # [ 108.603638] postgres[1427]: alter default privileges for user supabase_admin in schema cron grant all951server # [ 108.606889] postgres[1427]: on functions to postgres with grant option;952server # [ 108.608727] postgres[1427]:953server # [ 108.611145] postgres[1427]: grant all privileges on all tables in schema cron to postgres with grant option;954server # [ 108.611709] postgres[1427]:955server # [ 108.612246] postgres[1427]: END IF;956server # [ 108.612529] postgres[1427]:957server # [ 108.612937] postgres[1427]: END;958server # [ 108.614139] postgres[1427]: $$;959server # [ 108.615103] postgres[1427]: ::1 2026-10-26 12:32:26.989 UTC [1427] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')960server # [ 108.615575] postgres[1427]: EXECUTE PROCEDURE extensions.grant_pg_cron_access();961server # [ 108.615897] postgres[1427]: ::1 2026-10-26 12:32:27.034 UTC [1427] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';962server # [ 108.617031] postgres[1427]: ::1 2026-10-26 12:32:27.057 UTC [1427] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()963server # [ 108.618406] postgres[1427]: RETURNS event_trigger964server # [ 108.625150] postgres[1427]: LANGUAGE plpgsql965server # [ 108.626104] postgres[1427]: AS $$966server # [ 108.626851] postgres[1427]: BEGIN967server # [ 108.627132] postgres[1427]: IF EXISTS (968server # [ 108.627374] postgres[1427]: SELECT 1969server # [ 108.627621] postgres[1427]: FROM pg_event_trigger_ddl_commands() AS ev970server # [ 108.628016] postgres[1427]: JOIN pg_extension AS ext971server # [ 108.633058] postgres[1427]: ON ev.objid = ext.oid972server # [ 108.634164] postgres[1427]: WHERE ext.extname = 'pg_net'973server # [ 108.634738] postgres[1427]: )974server # [ 108.635657] postgres[1427]: THEN975server # [ 108.646860] postgres[1427]: IF NOT EXISTS (976server # [ 108.647375] postgres[1427]: SELECT 1977server # [ 108.647787] postgres[1427]: FROM pg_roles978server # [ 108.650869] postgres[1427]: WHERE rolname = 'supabase_functions_admin'979server # [ 108.655843] postgres[1427]: )980server # [ 108.656258] postgres[1427]: THEN981server # [ 108.665536] postgres[1427]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;982server # [ 108.666770] postgres[1427]: END IF;983server # [ 108.667606] postgres[1427]:984server # [ 108.668025] postgres[1427]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;985server # [ 108.673522] postgres[1427]:986server # [ 108.674398] postgres[1427]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;987server # [ 108.677394] postgres[1427]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;988server # [ 108.693574] postgres[1427]:989server # [ 108.694486] postgres[1427]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;990server # [ 108.696110] postgres[1427]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;991server # [ 108.701644] postgres[1427]:992server # [ 108.702314] postgres[1427]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;993server # [ 108.703007] postgres[1427]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;994server # [ 108.711031] postgres[1427]:995server # [ 108.713513] postgres[1427]: GRANT EXECUTE ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) TO supabase_functions_admin, postgres, anon, authenticated, service_role;996server # [ 108.715314] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: CREATE FUNCTION997server # [ 108.725334] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: CREATE EVENT TRIGGER998server # [ 108.726092] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: COMMENT999server # [ 108.726399] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: CREATE FUNCTION1000server # [ 108.727708] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: COMMENT1001server # [ 108.734016] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: DO1002server # [ 108.735788] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: CREATE ROLE1003server # [ 108.738089] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: GRANT1004server # [ 108.749812] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: GRANT1005server # [ 108.759831] postgres[1427]: GRANT EXECUTE ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) TO supabase_functions_admin, postgres, anon, authenticated, service_role;1006server # [ 108.777761] postgres[1427]: END IF;1007server # [ 108.779099] postgres[1427]: END;1008server # [ 108.779478] postgres[1427]: $$;1009server # [ 108.779936] postgres[1427]: ::1 2026-10-26 12:32:27.069 UTC [1427] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';1010server # [ 108.785904] postgres[1427]: ::1 2026-10-26 12:32:27.126 UTC [1427] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;1011server # [ 108.787647] postgres[1427]: ::1 2026-10-26 12:32:27.149 UTC [1427] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user;1012server # [ 108.798401] postgres[1427]: ::1 2026-10-26 12:32:27.158 UTC [1427] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user;1013server # [ 108.799326] postgres[1427]: ::1 2026-10-26 12:32:27.175 UTC [1427] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;1014server # [ 108.810257] postgres[1427]: ::1 2026-10-26 12:32:27.191 UTC [1427] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;1015server # [ 108.810888] postgres[1427]: ::1 2026-10-26 12:32:27.212 UTC [1427] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;1016server # [ 108.811518] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: GRANT1017server # [ 108.812181] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: GRANT1018server # [ 108.812931] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: GRANT1019server # [ 108.826935] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: GRANT1020server # [ 108.833903] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: GRANT1021server # [ 108.835553] postgres[1427]: ::1 2026-10-26 12:32:27.230 UTC [1427] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;1022server # [ 108.838748] postgres[1427]: ::1 2026-10-26 12:32:27.247 UTC [1427] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;1023server # [ 108.840175] postgres[1427]: ::1 2026-10-26 12:32:27.257 UTC [1427] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;1024server # [ 108.843585] postgres[1427]: ::1 2026-10-26 12:32:27.290 UTC [1427] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;1025server # [ 108.849284] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: GRANT1026server # [ 108.889281] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: GRANT1027server # [ 108.913468] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1425]: DO1028server # [ 108.985751] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running pgbouncer auth schema...1029server # [ 109.338397] postgres[1441]: ::1 2026-10-26 12:32:27.798 UTC [1441] postgres@postgres LOG: statement: CREATE USER pgbouncer;1030server # [ 109.353183] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1435]: CREATE ROLE1031server # [ 109.354232] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1435]: REVOKE1032server # [ 109.354803] postgres[1441]: ::1 2026-10-26 12:32:27.813 UTC [1441] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;1033server # [ 109.355280] postgres[1441]: ::1 2026-10-26 12:32:27.823 UTC [1441] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;1034server # [ 109.427184] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1435]: CREATE SCHEMA1035server # [ 109.430437] postgres[1441]: ::1 2026-10-26 12:32:27.898 UTC [1441] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)1036server # [ 109.431477] postgres[1441]: RETURNS TABLE(username TEXT, password TEXT) AS1037server # [ 109.432026] postgres[1441]: $$1038server # [ 109.432287] postgres[1441]: BEGIN1039server # [ 109.437650] postgres[1441]: RAISE WARNING 'PgBouncer auth request: %', p_usename;1040server # [ 109.438083] postgres[1441]:1041server # [ 109.438322] postgres[1441]: RETURN QUERY1042server # [ 109.438615] postgres[1441]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow1043server # [ 109.438953] postgres[1441]: WHERE usename = p_usename;1044server # [ 109.441186] postgres[1441]: END;1045server # [ 109.442211] postgres[1441]: $$ LANGUAGE plpgsql1046server # [ 109.442765] postgres[1441]: SET search_path = ''1047server # [ 109.443736] postgres[1441]: SECURITY DEFINER;1048server # [ 109.452730] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1435]: CREATE FUNCTION1049server # [ 109.454003] postgres[1441]: ::1 2026-10-26 12:32:27.921 UTC [1441] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;1050server # [ 109.463800] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1435]: REVOKE1051server # [ 109.465128] postgres[1441]: ::1 2026-10-26 12:32:27.933 UTC [1441] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;1052server # [ 109.476548] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1435]: GRANT1053server # [ 109.529898] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running stat extension...1054server # [ 109.942105] postgres[1451]: ::1 2026-10-26 12:32:28.396 UTC [1451] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions;1055server # [ 109.955715] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1446]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping1056server # [ 109.981051] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1446]: CREATE SCHEMA1057server # [ 109.988948] postgres[1451]: ::1 2026-10-26 12:32:28.452 UTC [1451] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;1058server # [ 111.115047] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1446]: CREATE EXTENSION1059server # [ 111.177960] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql1060server # [ 111.431777] postgres[1457]: ::1 2026-10-26 12:32:29.892 UTC [1457] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres;1061server # [ 111.466151] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1456]: GRANT1062server # [ 111.475637] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1456]: GRANT1063server # [ 111.485328] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1456]: GRANT1064server # [ 111.486251] postgres[1457]: ::1 2026-10-26 12:32:29.913 UTC [1457] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres;1065server # [ 111.487352] postgres[1457]: ::1 2026-10-26 12:32:29.928 UTC [1457] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres;1066server # [ 111.490248] postgres[1457]: ::1 2026-10-26 12:32:29.937 UTC [1457] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;1067server # [ 111.501083] postgres[1457]: ::1 2026-10-26 12:32:29.958 UTC [1457] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;1068server # [ 111.502747] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1456]: GRANT1069server # [ 111.503228] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1456]: GRANT1070server # [ 111.503589] postgres[1457]: ::1 2026-10-26 12:32:29.971 UTC [1457] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;1071server # [ 111.512735] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1456]: GRANT1072server # [ 111.514403] postgres[1457]: ::1 2026-10-26 12:32:29.979 UTC [1457] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;1073server # [ 111.515665] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1456]: GRANT1074server # [ 111.525838] postgres[1457]: ::1 2026-10-26 12:32:29.983 UTC [1457] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;1075server # [ 111.533153] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1456]: GRANT1076server # [ 111.534015] postgres[1457]: ::1 2026-10-26 12:32:30.001 UTC [1457] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;1077server # [ 111.601352] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1456]: GRANT1078server # [ 111.648451] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1456]: DO1079server # [ 111.666946] postgres[1457]: ::1 2026-10-26 12:32:30.124 UTC [1457] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;1080server # [ 111.673099] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1456]: ALTER ROLE1081server # [ 111.720617] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql1082server # [ 112.227614] postgres[1470]: ::1 2026-10-26 12:32:30.691 UTC [1470] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1083server # [ 112.293739] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: GRANT1084server # [ 112.295443] postgres[1470]: ::1 2026-10-26 12:32:30.735 UTC [1470] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1085server # [ 112.309264] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: GRANT1086server # [ 112.316844] postgres[1470]: ::1 2026-10-26 12:32:30.783 UTC [1470] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1087server # [ 112.342006] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: GRANT1088server # [ 112.343386] postgres[1470]: ::1 2026-10-26 12:32:30.806 UTC [1470] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;1089server # [ 112.360079] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: ALTER TABLE1090server # [ 112.369451] postgres[1470]: ::1 2026-10-26 12:32:30.833 UTC [1470] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;1091server # [ 112.385281] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: ALTER TABLE1092server # [ 112.388155] postgres[1470]: ::1 2026-10-26 12:32:30.850 UTC [1470] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;1093server # [ 112.405623] postgres[1470]: ::1 2026-10-26 12:32:30.868 UTC [1470] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;1094server # [ 112.406571] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: ALTER TABLE1095server # [ 112.413562] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: ALTER TABLE1096server # [ 112.426857] postgres[1470]: ::1 2026-10-26 12:32:30.884 UTC [1470] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;1097server # [ 112.436743] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: ALTER TABLE1098server # [ 112.445681] postgres[1470]: ::1 2026-10-26 12:32:30.909 UTC [1470] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres;1099server # [ 112.458628] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: GRANT1100server # [ 112.474324] postgres[1470]: ::1 2026-10-26 12:32:30.930 UTC [1470] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;1101server # [ 112.478404] postgres[1470]: ::1 2026-10-26 12:32:30.945 UTC [1470] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;1102server # [ 112.484932] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: GRANT1103server # [ 112.486310] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: GRANT1104server # [ 112.487459] postgres[1470]: ::1 2026-10-26 12:32:30.954 UTC [1470] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;1105server # [ 112.509225] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: GRANT1106server # [ 112.511574] postgres[1470]: ::1 2026-10-26 12:32:30.974 UTC [1470] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user;1107server # [ 112.538028] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: ALTER DEFAULT PRIVILEGES1108server # [ 112.539365] postgres[1470]: ::1 2026-10-26 12:32:31.003 UTC [1470] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1109server # [ 112.545983] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: ALTER DEFAULT PRIVILEGES1110server # [ 112.548965] postgres[1470]: ::1 2026-10-26 12:32:31.016 UTC [1470] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user;1111server # [ 112.562200] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1463]: ALTER DEFAULT PRIVILEGES1112server # [ 112.615086] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql1113server # [ 113.079384] postgres[1484]: ::1 2026-10-26 12:32:31.535 UTC [1484] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime;1114server # [ 113.135835] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1478]: CREATE SCHEMA1115server # [ 113.171486] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql1116server # [ 113.439376] postgres[1487]: ::1 2026-10-26 12:32:31.896 UTC [1487] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres;1117server # [ 113.453183] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1486]: GRANT1118server # [ 113.456064] postgres[1487]: ::1 2026-10-26 12:32:31.923 UTC [1487] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;1119server # [ 113.467532] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1486]: GRANT1120server # [ 113.474186] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1486]: GRANT1121server # [ 113.475215] postgres[1487]: ::1 2026-10-26 12:32:31.934 UTC [1487] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;1122server # [ 113.481211] postgres[1487]: ::1 2026-10-26 12:32:31.938 UTC [1487] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;1123server # [ 113.489143] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1486]: GRANT1124server # [ 113.510815] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql1125server # [ 113.787861] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1488]: DO1126server # [ 113.794138] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1488]: DO1127server # [ 113.806028] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1488]: DO1128server # [ 113.896830] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql1129server # [ 114.259728] postgres[1495]: ::1 2026-10-26 12:32:32.708 UTC [1495] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user;1130server # [ 114.306613] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1492]: ALTER DEFAULT PRIVILEGES1131server # [ 114.321643] postgres[1495]: ::1 2026-10-26 12:32:32.746 UTC [1495] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1132server # [ 114.323272] postgres[1495]: ::1 2026-10-26 12:32:32.762 UTC [1495] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user;1133server # [ 114.329994] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1492]: ALTER DEFAULT PRIVILEGES1134server # [ 114.337057] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1492]: ALTER DEFAULT PRIVILEGES1135server # [ 114.367685] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql1136server # [ 114.786788] postgres[1498]: ::1 2026-10-26 12:32:33.244 UTC [1498] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';1137server # [ 114.824552] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1496]: ALTER ROLE1138server # [ 114.843247] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql1139server # [ 115.253367] postgres[1509]: ::1 2026-10-26 12:32:33.704 UTC [1509] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1140server # [ 115.262757] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1141server # [ 115.270615] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: DROP EVENT TRIGGER1142server # [ 115.273581] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1143server # [ 115.278132] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: DROP FUNCTION1144server # [ 115.279286] postgres[1509]: ::1 2026-10-26 12:32:33.723 UTC [1509] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1145server # [ 115.285976] postgres[1509]: ::1 2026-10-26 12:32:33.730 UTC [1509] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1146server # [ 115.286990] postgres[1509]: DECLARE1147server # [ 115.287324] postgres[1509]: cmd record;1148server # [ 115.287594] postgres[1509]: BEGIN1149server # [ 115.287820] postgres[1509]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1150server # [ 115.289365] postgres[1509]: LOOP1151server # [ 115.289808] postgres[1509]: IF cmd.command_tag IN (1152server # [ 115.290375] postgres[1509]: 'CREATE SCHEMA', 'ALTER SCHEMA'1153server # [ 115.290860] postgres[1509]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1154server # [ 115.292086] postgres[1509]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1155server # [ 115.297903] postgres[1509]: , 'CREATE VIEW', 'ALTER VIEW'1156server # [ 115.300016] postgres[1509]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1157server # [ 115.306226] postgres[1509]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1158server # [ 115.306925] postgres[1509]: , 'CREATE TRIGGER'1159server # [ 115.307224] postgres[1509]: , 'CREATE TYPE'1160server # [ 115.307449] postgres[1509]: , 'CREATE RULE'1161server # [ 115.307681] postgres[1509]: , 'COMMENT'1162server # [ 115.307910] postgres[1509]: )1163server # [ 115.308129] postgres[1509]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1164server # [ 115.319312] postgres[1509]: AND cmd.schema_name is distinct from 'pg_temp'1165server # [ 115.325206] postgres[1509]: THEN1166server # [ 115.327308] postgres[1509]: NOTIFY pgrst, 'reload schema';1167server # [ 115.334962] postgres[1509]: END IF;1168server # [ 115.336877] postgres[1509]: END LOOP;1169server # [ 115.337415] postgres[1509]: END; $$ LANGUAGE plpgsql;1170server # [ 115.338384] postgres[1509]: ::1 2026-10-26 12:32:33.758 UTC [1509] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1171server # [ 115.339450] postgres[1509]: DECLARE1172server # [ 115.344493] postgres[1509]: obj record;1173server # [ 115.346492] postgres[1509]: BEGIN1174server # [ 115.347446] postgres[1509]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1175server # [ 115.352688] postgres[1509]: LOOP1176server # [ 115.353551] postgres[1509]: IF obj.object_type IN (1177server # [ 115.354282] postgres[1509]: 'schema'1178server # [ 115.355094] postgres[1509]: , 'table'1179server # [ 115.355447] postgres[1509]: , 'foreign table'1180server # [ 115.356185] postgres[1509]: , 'view'1181server # [ 115.370006] postgres[1509]: , 'materialized view'1182server # [ 115.379113] postgres[1509]: , 'function'1183server # [ 115.386331] postgres[1509]: , 'trigger'1184server # [ 115.395631] postgres[1509]: , 'type'1185server # [ 115.402796] postgres[1509]: , 'rule'1186server # [ 115.403887] postgres[1509]: )1187server # [ 115.419290] postgres[1509]: AND obj.is_temporary IS false -- no pg_temp objects1188server # [ 115.427530] postgres[1509]: THEN1189server # [ 115.428121] postgres[1509]: NOTIFY pgrst, 'reload schema';1190server # [ 115.436862] postgres[1509]: END IF;1191server # [ 115.437578] postgres[1509]: END LOOP;1192server # [ 115.439375] postgres[1509]: END; $$ LANGUAGE plpgsql;1193server # [ 115.446855] postgres[1509]: ::1 2026-10-26 12:32:33.774 UTC [1509] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1194server # [ 115.453674] postgres[1509]: ::1 2026-10-26 12:32:33.785 UTC [1509] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1195server # [ 115.455179] postgres[1509]: ON ddl_command_end1196server # [ 115.455725] postgres[1509]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1197server # [ 115.462106] postgres[1509]: ::1 2026-10-26 12:32:33.801 UTC [1509] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1198server # [ 115.463936] postgres[1509]: ::1 2026-10-26 12:32:33.805 UTC [1509] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1199server # [ 115.470143] postgres[1509]: ON sql_drop1200server # [ 115.471756] postgres[1509]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1201server # [ 115.479001] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: CREATE FUNCTION1202server # [ 115.480163] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: CREATE FUNCTION1203server # [ 115.486062] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping1204server # [ 115.488217] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: DROP EVENT TRIGGER1205server # [ 115.490147] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: CREATE EVENT TRIGGER1206server # [ 115.490714] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping1207server # [ 115.497579] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: DROP EVENT TRIGGER1208server # [ 115.498812] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1502]: CREATE EVENT TRIGGER1209server # [ 115.512437] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql1210server # [ 116.725480] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1513]: DO1211server # [ 116.758716] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql1212server # [ 116.990074] postgres[1527]: ::1 2026-10-26 12:32:35.453 UTC [1527] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public;1213server # [ 117.033942] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: CREATE SCHEMA1214server # [ 117.034842] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping1215server # [ 117.037251] postgres[1527]: ::1 2026-10-26 12:32:35.493 UTC [1527] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb);1216server # [ 117.038887] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: DROP FUNCTION1217server # [ 117.041348] postgres[1527]: ::1 2026-10-26 12:32:35.508 UTC [1527] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1218server # [ 117.042234] postgres[1527]: "operationName" text default null,1219server # [ 117.042959] postgres[1527]: query text default null,1220server # [ 117.043926] postgres[1527]: variables jsonb default null,1221server # [ 117.045049] postgres[1527]: extensions jsonb default null1222server # [ 117.045591] postgres[1527]: )1223server # [ 117.045852] postgres[1527]: returns jsonb1224server # [ 117.046316] postgres[1527]: language plpgsql1225server # [ 117.046809] postgres[1527]: as $$1226server # [ 117.047531] postgres[1527]: DECLARE1227server # [ 117.047903] postgres[1527]: server_version float;1228server # [ 117.048482] postgres[1527]: BEGIN1229server # [ 117.049563] postgres[1527]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1230server # [ 117.050488] postgres[1527]:1231server # [ 117.051153] postgres[1527]: IF server_version >= 14 THEN1232server # [ 117.051449] postgres[1527]: RETURN jsonb_build_object(1233server # [ 117.051703] postgres[1527]: 'data', null::jsonb,1234server # [ 117.053893] postgres[1527]: 'errors', array['pg_graphql extension is not enabled.']1235server # [ 117.054456] postgres[1527]: );1236server # [ 117.055182] postgres[1527]: ELSE1237server # [ 117.055487] postgres[1527]: RETURN jsonb_build_object(1238server # [ 117.057216] postgres[1527]: 'data', null::jsonb,1239server # [ 117.057904] postgres[1527]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1240server # [ 117.058876] postgres[1527]: );1241server # [ 117.059217] postgres[1527]: END IF;1242server # [ 117.059652] postgres[1527]: END;1243server # [ 117.060034] postgres[1527]: $$;1244server # [ 117.069254] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: CREATE FUNCTION1245server # [ 117.073283] postgres[1527]: ::1 2026-10-26 12:32:35.539 UTC [1527] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;1246server # [ 117.089679] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: GRANT1247server # [ 117.090566] postgres[1527]: ::1 2026-10-26 12:32:35.553 UTC [1527] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;1248server # [ 117.095799] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: ALTER DEFAULT PRIVILEGES1249server # [ 117.101043] postgres[1527]: ::1 2026-10-26 12:32:35.566 UTC [1527] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;1250server # [ 117.107370] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: ALTER DEFAULT PRIVILEGES1251server # [ 117.109335] postgres[1527]: ::1 2026-10-26 12:32:35.577 UTC [1527] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;1252server # [ 117.120264] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: ALTER DEFAULT PRIVILEGES1253server # [ 117.125803] postgres[1527]: ::1 2026-10-26 12:32:35.590 UTC [1527] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1254server # [ 117.127194] postgres[1527]: on sequences to postgres, anon, authenticated, service_role;1255server # [ 117.133389] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: ALTER DEFAULT PRIVILEGES1256server # [ 117.137174] postgres[1527]: ::1 2026-10-26 12:32:35.603 UTC [1527] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1257server # [ 117.139398] postgres[1527]: on tables to postgres, anon, authenticated, service_role;1258server # [ 117.151095] postgres[1527]: ::1 2026-10-26 12:32:35.615 UTC [1527] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1259server # [ 117.154481] postgres[1527]: on functions to postgres, anon, authenticated, service_role;1260server # [ 117.155446] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: ALTER DEFAULT PRIVILEGES1261server # [ 117.160136] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: ALTER DEFAULT PRIVILEGES1262server # [ 117.168726] postgres[1527]: ::1 2026-10-26 12:32:35.633 UTC [1527] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()1263server # [ 117.171143] postgres[1527]: RETURNS event_trigger1264server # [ 117.171997] postgres[1527]: LANGUAGE plpgsql1265server # [ 117.172284] postgres[1527]: AS $func$1266server # [ 117.173676] postgres[1527]: DECLARE1267server # [ 117.173963] postgres[1527]: func_is_graphql_resolve bool;1268server # [ 117.174203] postgres[1527]: BEGIN1269server # [ 117.174412] postgres[1527]: func_is_graphql_resolve = (1270server # [ 117.174821] postgres[1527]: SELECT n.proname = 'resolve'1271server # [ 117.175361] postgres[1527]: FROM pg_event_trigger_ddl_commands() AS ev1272server # [ 117.175823] postgres[1527]: LEFT JOIN pg_catalog.pg_proc AS n1273server # [ 117.177246] postgres[1527]: ON ev.objid = n.oid1274server # [ 117.177963] postgres[1527]: );1275server # [ 117.178307] postgres[1527]:1276server # [ 117.178723] postgres[1527]: IF func_is_graphql_resolve1277server # [ 117.179252] postgres[1527]: THEN1278server # [ 117.180041] postgres[1527]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1279server # [ 117.181192] postgres[1527]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1280server # [ 117.181654] postgres[1527]:1281server # [ 117.182146] postgres[1527]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1282server # [ 117.182771] postgres[1527]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1283server # [ 117.185676] postgres[1527]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1284server # [ 117.187181] postgres[1527]:1285server # [ 117.187609] postgres[1527]: DROP FUNCTION IF EXISTS graphql_public.graphql;1286server # [ 117.188940] postgres[1527]: create or replace function graphql_public.graphql(1287server # [ 117.189352] postgres[1527]: "operationName" text default null,1288server # [ 117.190393] postgres[1527]: query text default null,1289server # [ 117.190775] postgres[1527]: variables jsonb default null,1290server # [ 117.192921] postgres[1527]: extensions jsonb default null1291server # [ 117.193457] postgres[1527]: )1292server # [ 117.193705] postgres[1527]: returns jsonb1293server # [ 117.196028] postgres[1527]: language sql1294server # [ 117.197959] postgres[1527]: as $$1295server # [ 117.198834] postgres[1527]: SELECT graphql.resolve(query, coalesce(variables, '{}'));1296server # [ 117.199952] postgres[1527]: $$;1297server # [ 117.201316] postgres[1527]:1298server # [ 117.201621] postgres[1527]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1299server # [ 117.202969] postgres[1527]: END IF;1300server # [ 117.203490] postgres[1527]:1301server # [ 117.203852] postgres[1527]: END;1302server # [ 117.205026] postgres[1527]: $func$;1303server # [ 117.206378] postgres[1527]: ::1 2026-10-26 12:32:35.663 UTC [1527] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;1304server # [ 117.208589] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: CREATE FUNCTION1305server # [ 117.209096] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping1306server # [ 117.211190] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: DROP EVENT TRIGGER1307server # [ 117.216079] postgres[1527]: ::1 2026-10-26 12:32:35.680 UTC [1527] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')1308server # [ 117.217755] postgres[1527]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access();1309server # [ 117.223380] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: CREATE EVENT TRIGGER1310server # [ 117.224901] postgres[1527]: ::1 2026-10-26 12:32:35.691 UTC [1527] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';1311server # [ 117.235161] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: COMMENT1312server # [ 117.241759] postgres[1527]: ::1 2026-10-26 12:32:35.704 UTC [1527] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1313server # [ 117.243330] postgres[1527]: RETURNS event_trigger1314server # [ 117.249089] postgres[1527]: LANGUAGE plpgsql1315server # [ 117.250102] postgres[1527]: AS $func$1316server # [ 117.250887] postgres[1527]: DECLARE1317server # [ 117.251959] postgres[1527]: graphql_is_dropped bool;1318server # [ 117.257812] postgres[1527]: BEGIN1319server # [ 117.258432] postgres[1527]: graphql_is_dropped = (1320server # [ 117.259619] postgres[1527]: SELECT ev.schema_name = 'graphql_public'1321server # [ 117.265463] postgres[1527]: FROM pg_event_trigger_dropped_objects() AS ev1322server # [ 117.266072] postgres[1527]: WHERE ev.schema_name = 'graphql_public'1323server # [ 117.267601] postgres[1527]: );1324server # [ 117.273022] postgres[1527]:1325server # [ 117.273682] postgres[1527]: IF graphql_is_dropped1326server # [ 117.274457] postgres[1527]: THEN1327server # [ 117.274938] postgres[1527]: create or replace function graphql_public.graphql(1328server # [ 117.275217] postgres[1527]: "operationName" text default null,1329server # [ 117.275469] postgres[1527]: query text default null,1330server # [ 117.281304] postgres[1527]: variables jsonb default null,1331server # [ 117.281952] postgres[1527]: extensions jsonb default null1332server # [ 117.282820] postgres[1527]: )1333server # [ 117.283746] postgres[1527]: returns jsonb1334server # [ 117.284109] postgres[1527]: language plpgsql1335server # [ 117.293863] postgres[1527]: as $$1336server # [ 117.299291] postgres[1527]: DECLARE1337server # [ 117.300331] postgres[1527]: server_version float;1338server # [ 117.305279] postgres[1527]: BEGIN1339server # [ 117.305960] postgres[1527]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1340server # [ 117.307196] postgres[1527]:1341server # [ 117.307478] postgres[1527]: IF server_version >= 14 THEN1342server # [ 117.307776] postgres[1527]: RETURN jsonb_build_object(1343server # [ 117.308460] postgres[1527]: 'data', null::jsonb,1344server # [ 117.317619] postgres[1527]: 'errors', array['pg_graphql extension is not enabled.']1345server # [ 117.318345] postgres[1527]: );1346server # [ 117.319422] postgres[1527]: ELSE1347server # [ 117.323057] postgres[1527]: RETURN jsonb_build_object(1348server # [ 117.323623] postgres[1527]: 'data', null::jsonb,1349server # [ 117.325433] postgres[1527]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1350server # [ 117.327400] postgres[1527]: );1351server # [ 117.329346] postgres[1527]: END IF;1352server # [ 117.330320] postgres[1527]: END;1353server # [ 117.331009] postgres[1527]: $$;1354server # [ 117.331322] postgres[1527]: END IF;1355server # [ 117.332018] postgres[1527]:1356server # [ 117.332461] postgres[1527]: END;1357server # [ 117.335432] postgres[1527]: $func$;1358server # [ 117.338489] postgres[1527]: ::1 2026-10-26 12:32:35.760 UTC [1527] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;1359server # [ 117.342080] postgres[1527]: ::1 2026-10-26 12:32:35.764 UTC [1527] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')1360server # [ 117.343507] postgres[1527]: EXECUTE PROCEDURE extensions.set_graphql_placeholder();1361server # [ 117.349747] postgres[1527]: ::1 2026-10-26 12:32:35.778 UTC [1527] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';1362server # [ 117.357834] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: CREATE FUNCTION1363server # [ 117.359112] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping1364server # [ 117.359681] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: DROP EVENT TRIGGER1365server # [ 117.365685] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: CREATE EVENT TRIGGER1366server # [ 117.367671] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1526]: COMMENT1367server # [ 117.380913] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql1368server # [ 117.619873] postgres[1529]: ::1 2026-10-26 12:32:36.080 UTC [1529] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1369server # [ 117.629249] postgres[1529]: ::1 2026-10-26 12:32:36.088 UTC [1529] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1370server # [ 117.642639] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1528]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1371server # [ 117.647341] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1528]: DROP EVENT TRIGGER1372server # [ 117.649513] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1528]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1373server # [ 117.651471] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1528]: DROP FUNCTION1374server # [ 117.652610] postgres[1529]: ::1 2026-10-26 12:32:36.107 UTC [1529] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1375server # [ 117.654189] postgres[1529]: DECLARE1376server # [ 117.655508] postgres[1529]: cmd record;1377server # [ 117.655869] postgres[1529]: BEGIN1378server # [ 117.657730] postgres[1529]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1379server # [ 117.659041] postgres[1529]: LOOP1380server # [ 117.660196] postgres[1529]: IF cmd.command_tag IN (1381server # [ 117.661505] postgres[1529]: 'CREATE SCHEMA', 'ALTER SCHEMA'1382server # [ 117.662432] postgres[1529]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1383server # [ 117.663947] postgres[1529]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1384server # [ 117.666486] postgres[1529]: , 'CREATE VIEW', 'ALTER VIEW'1385server # [ 117.667997] postgres[1529]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1386server # [ 117.669499] postgres[1529]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1387server # [ 117.670250] postgres[1529]: , 'CREATE TRIGGER'1388server # [ 117.671454] postgres[1529]: , 'CREATE TYPE', 'ALTER TYPE'1389server # [ 117.671814] postgres[1529]: , 'CREATE RULE'1390server # [ 117.674622] postgres[1529]: , 'COMMENT'1391server # [ 117.675153] postgres[1529]: )1392server # [ 117.675426] postgres[1529]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1393server # [ 117.675701] postgres[1529]: AND cmd.schema_name is distinct from 'pg_temp'1394server # [ 117.677884] postgres[1529]: THEN1395server # [ 117.678304] postgres[1529]: NOTIFY pgrst, 'reload schema';1396server # [ 117.679521] postgres[1529]: END IF;1397server # [ 117.679961] postgres[1529]: END LOOP;1398server # [ 117.680208] postgres[1529]: END; $$ LANGUAGE plpgsql;1399server # [ 117.708945] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1528]: CREATE FUNCTION1400server # [ 117.709894] postgres[1529]: ::1 2026-10-26 12:32:36.171 UTC [1529] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1401server # [ 117.710931] postgres[1529]: DECLARE1402server # [ 117.711397] postgres[1529]: obj record;1403server # [ 117.711794] postgres[1529]: BEGIN1404server # [ 117.712184] postgres[1529]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1405server # [ 117.717499] postgres[1529]: LOOP1406server # [ 117.718391] postgres[1529]: IF obj.object_type IN (1407server # [ 117.725479] postgres[1529]: 'schema'1408server # [ 117.726926] postgres[1529]: , 'table'1409server # [ 117.727725] postgres[1529]: , 'foreign table'1410server # [ 117.734920] postgres[1529]: , 'view'1411server # [ 117.741634] postgres[1529]: , 'materialized view'1412server # [ 117.748320] postgres[1529]: , 'function'1413server # [ 117.750433] postgres[1529]: , 'trigger'1414server # [ 117.751876] postgres[1529]: , 'type'1415server # [ 117.752177] postgres[1529]: , 'rule'1416server # [ 117.754165] postgres[1529]: )1417server # [ 117.755180] postgres[1529]: AND obj.is_temporary IS false -- no pg_temp objects1418server # [ 117.757977] postgres[1529]: THEN1419server # [ 117.758344] postgres[1529]: NOTIFY pgrst, 'reload schema';1420server # [ 117.761167] postgres[1529]: END IF;1421server # [ 117.761733] postgres[1529]: END LOOP;1422server # [ 117.761999] postgres[1529]: END; $$ LANGUAGE plpgsql;1423server # [ 117.764716] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1528]: CREATE FUNCTION1424server # [ 117.769238] postgres[1529]: ::1 2026-10-26 12:32:36.235 UTC [1529] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1425server # [ 117.785850] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1528]: DROP EVENT TRIGGER1426server # [ 117.793478] postgres[1529]: ::1 2026-10-26 12:32:36.256 UTC [1529] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1427server # [ 117.795024] postgres[1529]: ON ddl_command_end1428server # [ 117.802236] postgres[1529]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1429server # [ 117.811095] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1528]: CREATE EVENT TRIGGER1430server # [ 117.817858] postgres[1529]: ::1 2026-10-26 12:32:36.280 UTC [1529] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1431server # [ 117.825606] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1528]: DROP EVENT TRIGGER1432server # [ 117.831475] postgres[1529]: ::1 2026-10-26 12:32:36.296 UTC [1529] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1433server # [ 117.845662] postgres[1529]: ON sql_drop1434server # [ 117.846473] postgres[1529]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1435server # [ 117.848140] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1528]: CREATE EVENT TRIGGER1436server # [ 117.926856] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql1437server # [ 118.455895] postgres[1541]: ::1 2026-10-26 12:32:36.917 UTC [1541] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;1438server # [ 118.481342] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1534]: ALTER ROLE1439server # [ 118.509715] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql1440server # [ 118.937167] postgres[1548]: ::1 2026-10-26 12:32:37.382 UTC [1548] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1441server # [ 118.939140] postgres[1548]: returns event_trigger1442server # [ 118.950115] postgres[1548]: language plpgsql1443server # [ 118.952379] postgres[1548]: AS $func$1444server # [ 118.961517] postgres[1548]: DECLARE1445server # [ 118.962364] postgres[1548]: func_is_graphql_resolve bool;1446server # [ 118.963661] postgres[1548]: BEGIN1447server # [ 118.973524] postgres[1548]: func_is_graphql_resolve = (1448server # [ 118.975923] postgres[1548]: SELECT n.proname = 'resolve'1449server # [ 118.980749] postgres[1548]: FROM pg_event_trigger_ddl_commands() AS ev1450server # [ 118.993110] postgres[1548]: LEFT JOIN pg_catalog.pg_proc AS n1451server # [ 118.995130] postgres[1548]: ON ev.objid = n.oid1452server # [ 118.995849] postgres[1548]: );1453server # [ 119.004977] postgres[1548]:1454server # [ 119.013247] postgres[1548]: IF func_is_graphql_resolve1455server # [ 119.014243] postgres[1548]: THEN1456server # [ 119.015654] postgres[1548]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1457server # [ 119.023793] postgres[1548]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1458server # [ 119.038439] postgres[1548]:1459server # [ 119.039938] postgres[1548]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1460server # [ 119.042773] postgres[1548]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1461server # [ 119.050615] postgres[1548]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1462server # [ 119.057270] postgres[1548]:1463server # [ 119.071440] postgres[1548]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1464server # [ 119.074329] postgres[1548]: DROP FUNCTION IF EXISTS graphql_public.graphql;1465server # [ 119.081662] postgres[1548]: create or replace function graphql_public.graphql(1466server # [ 119.082888] postgres[1548]: "operationName" text default null,1467server # [ 119.083251] postgres[1548]: query text default null,1468server # [ 119.083962] postgres[1548]: variables jsonb default null,1469server # [ 119.092439] postgres[1548]: extensions jsonb default null1470server # [ 119.099252] postgres[1548]: )1471server # [ 119.104837] postgres[1548]: returns jsonb1472server # [ 119.107436] postgres[1548]: language sql1473server # [ 119.114231] postgres[1548]: as $$1474server # [ 119.115292] postgres[1548]: -- This changed1475server # [ 119.115825] postgres[1548]: select graphql.resolve(1476server # [ 119.116096] postgres[1548]: query := query,1477server # [ 119.116362] postgres[1548]: variables := coalesce(variables, '{}'),1478server # [ 119.117497] postgres[1548]: "operationName" := "operationName",1479server # [ 119.118023] postgres[1548]: extensions := extensions1480server # [ 119.119112] postgres[1548]: );1481server # [ 119.120025] postgres[1548]: $$;1482server # [ 119.121603] postgres[1548]:1483server # [ 119.123336] postgres[1548]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1484server # [ 119.125028] postgres[1548]: END IF;1485server # [ 119.125480] postgres[1548]:1486server # [ 119.127128] postgres[1548]: END;1487server # [ 119.128732] postgres[1548]: $func$;1488server # [ 119.129754] postgres[1548]: ::1 2026-10-26 12:32:37.585 UTC [1548] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1489server # [ 119.130709] postgres[1548]: RETURNS event_trigger1490server # [ 119.131019] postgres[1548]: LANGUAGE plpgsql1491server # [ 119.131660] postgres[1548]: AS $func$1492server # [ 119.132809] postgres[1548]: DECLARE1493server # [ 119.133692] postgres[1548]: graphql_is_dropped bool;1494server # [ 119.134790] postgres[1548]: BEGIN1495server # [ 119.135351] postgres[1548]: graphql_is_dropped = (1496server # [ 119.136033] postgres[1548]: SELECT ev.schema_name = 'graphql_public'1497server # [ 119.136352] postgres[1548]: FROM pg_event_trigger_dropped_objects() AS ev1498server # [ 119.137205] postgres[1548]: WHERE ev.schema_name = 'graphql_public'1499server # [ 119.138171] postgres[1548]: );1500server # [ 119.138473] postgres[1548]:1501server # [ 119.141395] postgres[1548]: IF graphql_is_dropped1502server # [ 119.142657] postgres[1548]: THEN1503server # [ 119.143584] postgres[1548]: create or replace function graphql_public.graphql(1504server # [ 119.144947] postgres[1548]: "operationName" text default null,1505server # [ 119.146377] postgres[1548]: query text default null,1506server # [ 119.147675] postgres[1548]: variables jsonb default null,1507server # [ 119.148978] postgres[1548]: extensions jsonb default null1508server # [ 119.149812] postgres[1548]: )1509server # [ 119.150103] postgres[1548]: returns jsonb1510server # [ 119.150337] postgres[1548]: language plpgsql1511server # [ 119.150806] postgres[1548]: as $$1512server # [ 119.151286] postgres[1548]: DECLARE1513server # [ 119.151622] postgres[1548]: server_version float;1514server # [ 119.151901] postgres[1548]: BEGIN1515server # [ 119.153467] postgres[1548]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1516server # [ 119.155049] postgres[1548]:1517server # [ 119.156999] postgres[1548]: IF server_version >= 14 THEN1518server # [ 119.159462] postgres[1548]: RETURN jsonb_build_object(1519server # [ 119.162126] postgres[1548]: 'errors', jsonb_build_array(1520server # [ 119.162708] postgres[1548]: jsonb_build_object(1521server # [ 119.163028] postgres[1548]: 'message', 'pg_graphql extension is not enabled.'1522server # [ 119.163446] postgres[1548]: )1523server # [ 119.163826] postgres[1548]: )1524server # [ 119.165158] postgres[1548]: );1525server # [ 119.165648] postgres[1548]: ELSE1526server # [ 119.165946] postgres[1548]: RETURN jsonb_build_object(1527server # [ 119.166212] postgres[1548]: 'errors', jsonb_build_array(1528server # [ 119.166970] postgres[1548]: jsonb_build_object(1529server # [ 119.167739] postgres[1548]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1530server # [ 119.170944] postgres[1548]: )1531server # [ 119.173166] postgres[1548]: )1532server # [ 119.175942] postgres[1548]: );1533server # [ 119.177290] postgres[1548]: END IF;1534server # [ 119.177730] postgres[1548]: END;1535server # [ 119.178165] postgres[1548]: $$;1536server # [ 119.180108] postgres[1548]: END IF;1537server # [ 119.182566] postgres[1548]:1538server # [ 119.183554] postgres[1548]: END;1539server # [ 119.184988] postgres[1548]: $func$;1540server # [ 119.189646] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1545]: CREATE FUNCTION1541server # [ 119.191496] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1545]: CREATE FUNCTION1542server # [ 119.195474] postgres[1548]: ::1 2026-10-26 12:32:37.655 UTC [1548] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1543server # [ 119.197469] postgres[1548]: "operationName" text default null,1544server # [ 119.197906] postgres[1548]: query text default null,1545server # [ 119.198203] postgres[1548]: variables jsonb default null,1546server # [ 119.198443] postgres[1548]: extensions jsonb default null1547server # [ 119.199427] postgres[1548]: )1548server # [ 119.199768] postgres[1548]: returns jsonb1549server # [ 119.201581] postgres[1548]: language plpgsql1550server # [ 119.203901] postgres[1548]: as $$1551server # [ 119.212239] postgres[1548]: DECLARE1552server # [ 119.216934] postgres[1548]: server_version float;1553server # [ 119.217731] postgres[1548]: BEGIN1554server # [ 119.218737] postgres[1548]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1555server # [ 119.219682] postgres[1548]:1556server # [ 119.221549] postgres[1548]: IF server_version >= 14 THEN1557server # [ 119.224298] postgres[1548]: RETURN jsonb_build_object(1558server # [ 119.226248] postgres[1548]: 'errors', jsonb_build_array(1559server # [ 119.226716] postgres[1548]: jsonb_build_object(1560server # [ 119.227251] postgres[1548]: 'message', 'pg_graphql extension is not enabled.'1561server # [ 119.227567] postgres[1548]: )1562server # [ 119.228175] postgres[1548]: )1563server # [ 119.229596] postgres[1548]: );1564server # [ 119.230664] postgres[1548]: ELSE1565server # [ 119.231456] postgres[1548]: RETURN jsonb_build_object(1566server # [ 119.233050] postgres[1548]: 'errors', jsonb_build_array(1567server # [ 119.233665] postgres[1548]: jsonb_build_object(1568server # [ 119.234098] postgres[1548]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1569server # [ 119.234927] postgres[1548]: )1570server # [ 119.235413] postgres[1548]: )1571server # [ 119.235746] postgres[1548]: );1572server # [ 119.236159] postgres[1548]: END IF;1573server # [ 119.236419] postgres[1548]: END;1574server # [ 119.239085] postgres[1548]: $$;1575server # [ 119.241124] postgres[1548]: ::1 2026-10-26 12:32:37.704 UTC [1548] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1576server # [ 119.242223] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1545]: CREATE FUNCTION1577server # [ 119.246943] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1545]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping1578server # [ 119.253379] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1545]: DROP EXTENSION1579server # [ 120.881599] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1545]: DO1580server # [ 120.911200] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql1581server # [ 121.179443] postgres[1563]: ::1 2026-10-26 12:32:39.637 UTC [1563] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres;1582server # [ 121.229051] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1562]: GRANT ROLE1583server # [ 121.255496] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql1584server # [ 121.706290] postgres[1571]: ::1 2026-10-26 12:32:40.154 UTC [1571] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1585server # [ 121.707383] postgres[1571]: returns event_trigger1586server # [ 121.713571] postgres[1571]: language plpgsql1587server # [ 121.715016] postgres[1571]: AS $func$1588server # [ 121.721835] postgres[1571]: DECLARE1589server # [ 121.729029] postgres[1571]: func_is_graphql_resolve bool;1590server # [ 121.741358] postgres[1571]: BEGIN1591server # [ 121.742317] postgres[1571]: func_is_graphql_resolve = (1592server # [ 121.743816] postgres[1571]: SELECT n.proname = 'resolve'1593server # [ 121.751495] postgres[1571]: FROM pg_event_trigger_ddl_commands() AS ev1594server # [ 121.757335] postgres[1571]: LEFT JOIN pg_catalog.pg_proc AS n1595server # [ 121.757872] postgres[1571]: ON ev.objid = n.oid1596server # [ 121.758282] postgres[1571]: );1597server # [ 121.759019] postgres[1571]:1598server # [ 121.759890] postgres[1571]: IF func_is_graphql_resolve1599server # [ 121.760224] postgres[1571]: THEN1600server # [ 121.761819] postgres[1571]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1601server # [ 121.763458] postgres[1571]: DROP FUNCTION IF EXISTS graphql_public.graphql;1602server # [ 121.769680] postgres[1571]: create or replace function graphql_public.graphql(1603server # [ 121.770801] postgres[1571]: "operationName" text default null,1604server # [ 121.771651] postgres[1571]: query text default null,1605server # [ 121.774863] postgres[1571]: variables jsonb default null,1606server # [ 121.779300] postgres[1571]: extensions jsonb default null1607server # [ 121.781107] postgres[1571]: )1608server # [ 121.782312] postgres[1571]: returns jsonb1609server # [ 121.783716] postgres[1571]: language sql1610server # [ 121.790572] postgres[1571]: as $$1611server # [ 121.791137] postgres[1571]: select graphql.resolve(1612server # [ 121.792556] postgres[1571]: query := query,1613server # [ 121.795870] postgres[1571]: variables := coalesce(variables, '{}'),1614server # [ 121.801696] postgres[1571]: "operationName" := "operationName",1615server # [ 121.802816] postgres[1571]: extensions := extensions1616server # [ 121.804706] postgres[1571]: );1617server # [ 121.805843] postgres[1571]: $$;1618server # [ 121.807149] postgres[1571]:1619server # [ 121.807915] postgres[1571]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1620server # [ 121.814502] postgres[1571]: -- function in the extension so we need to grant permissions on existing entities AND1621server # [ 121.815155] postgres[1571]: -- update default permissions to any others that are created after `graphql.resolve`1622server # [ 121.815837] postgres[1571]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1623server # [ 121.816489] postgres[1571]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1624server # [ 121.834454] postgres[1571]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1625server # [ 121.841082] postgres[1571]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1626server # [ 121.842088] postgres[1571]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1627server # [ 121.843746] postgres[1571]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1628server # [ 121.851683] postgres[1571]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1629server # [ 121.854758] postgres[1571]: END IF;1630server # [ 121.855191] postgres[1571]:1631server # [ 121.855469] postgres[1571]: END;1632server # [ 121.855797] postgres[1571]: $func$;1633server # [ 121.878886] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1564]: CREATE FUNCTION1634server # [ 121.880038] postgres[1571]: ::1 2026-10-26 12:32:40.312 UTC [1571] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1635server # [ 122.027670] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1564]: DROP EXTENSION1636server # [ 123.703639] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1564]: DO1637server # [ 123.751880] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql1638server # [ 124.930329] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1590]: DO1639server # [ 125.731840] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1590]: DO1640server # [ 125.828982] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql1641server # [ 126.126864] postgres[1617]: ::1 2026-10-26 12:32:44.578 UTC [1617] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s';1642server # [ 126.153798] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1616]: ALTER ROLE1643server # [ 126.200058] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql1644server # [ 126.585984] postgres[1623]: ::1 2026-10-26 12:32:45.030 UTC [1623] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator;1645server # [ 126.641368] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1621]: REVOKE ROLE1646server # [ 126.642762] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql1647server # [ 129.059777] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1624]: DO1648server # [ 129.099583] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql1649server # [ 129.467772] postgres[1651]: ::1 2026-10-26 12:32:47.924 UTC [1651] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres;1650server # [ 129.493980] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1648]: GRANT ROLE1651server # [ 129.527411] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql1652server # [ 129.797944] postgres[1653]: ::1 2026-10-26 12:32:48.255 UTC [1653] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option;1653server # [ 129.833336] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1652]: GRANT1654server # [ 129.835079] postgres[1653]: ::1 2026-10-26 12:32:48.298 UTC [1653] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option;1655server # [ 129.859755] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1652]: GRANT1656server # [ 129.866140] postgres[1653]: ::1 2026-10-26 12:32:48.331 UTC [1653] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option;1657server # [ 129.869294] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1652]: GRANT1658server # [ 129.871507] postgres[1653]: ::1 2026-10-26 12:32:48.339 UTC [1653] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;1659server # [ 129.883290] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1652]: ALTER DEFAULT PRIVILEGES1660server # [ 129.887979] postgres[1653]: ::1 2026-10-26 12:32:48.351 UTC [1653] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;1661server # [ 129.894204] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1652]: ALTER DEFAULT PRIVILEGES1662server # [ 129.895629] postgres[1653]: ::1 2026-10-26 12:32:48.362 UTC [1653] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;1663server # [ 129.913173] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1652]: ALTER DEFAULT PRIVILEGES1664server # [ 129.961125] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql1665server # [ 130.347903] postgres[1659]: ::1 2026-10-26 12:32:48.806 UTC [1659] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres;1666server # [ 130.373689] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1656]: GRANT ROLE1667server # [ 130.430042] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql1668server # [ 130.777456] postgres[1661]: ::1 2026-10-26 12:32:49.230 UTC [1661] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin;1669server # [ 130.789509] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1660]: GRANT ROLE1670server # [ 130.836681] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql1671server # [ 131.272072] postgres[1668]: ::1 2026-10-26 12:32:49.716 UTC [1668] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit;1672server # [ 131.281317] postgres[1668]: ::1 2026-10-26 12:32:49.741 UTC [1668] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit;1673server # [ 131.295573] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1662]: ALTER ROLE1674server # [ 131.300988] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1662]: ALTER ROLE1675server # [ 131.302112] postgres[1668]: ::1 2026-10-26 12:32:49.762 UTC [1668] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit;1676server # [ 131.303982] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1662]: ALTER ROLE1677server # [ 131.395162] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1662]: DO1678server # [ 131.462135] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql1679server # [ 131.969135] postgres[1682]: ::1 2026-10-26 12:32:50.409 UTC [1682] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin;1680server # [ 132.037988] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1676]: GRANT ROLE1681server # [ 132.064999] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1676]: REVOKE ROLE1682server # [ 132.068043] postgres[1682]: ::1 2026-10-26 12:32:50.483 UTC [1682] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin;1683server # [ 132.108636] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql1684server # [ 132.481599] postgres[1691]: ::1 2026-10-26 12:32:50.942 UTC [1691] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1685server # [ 132.483773] postgres[1691]: returns event_trigger1686server # [ 132.490447] postgres[1691]: language plpgsql1687server # [ 132.494494] postgres[1691]: AS $func$1688server # [ 132.495222] postgres[1691]: DECLARE1689server # [ 132.495988] postgres[1691]: func_is_graphql_resolve bool;1690server # [ 132.501362] postgres[1691]: BEGIN1691server # [ 132.502698] postgres[1691]: func_is_graphql_resolve = (1692server # [ 132.504072] postgres[1691]: SELECT n.proname = 'resolve'1693server # [ 132.508696] postgres[1691]: FROM pg_event_trigger_ddl_commands() AS ev1694server # [ 132.510383] postgres[1691]: LEFT JOIN pg_catalog.pg_proc AS n1695server # [ 132.511593] postgres[1691]: ON ev.objid = n.oid1696server # [ 132.512438] postgres[1691]: );1697server # [ 132.519059] postgres[1691]:1698server # [ 132.525484] postgres[1691]: IF func_is_graphql_resolve1699server # [ 132.527011] postgres[1691]: THEN1700server # [ 132.527643] postgres[1691]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1701server # [ 132.531382] postgres[1691]: DROP FUNCTION IF EXISTS graphql_public.graphql;1702server # [ 132.535319] postgres[1691]: create or replace function graphql_public.graphql(1703server # [ 132.538864] postgres[1691]: "operationName" text default null,1704server # [ 132.539497] postgres[1691]: query text default null,1705server # [ 132.539807] postgres[1691]: variables jsonb default null,1706server # [ 132.540097] postgres[1691]: extensions jsonb default null1707server # [ 132.544871] postgres[1691]: )1708server # [ 132.545681] postgres[1691]: returns jsonb1709server # [ 132.546329] postgres[1691]: language sql1710server # [ 132.546790] postgres[1691]: as $$1711server # [ 132.547415] postgres[1691]: select graphql.resolve(1712server # [ 132.548129] postgres[1691]: query := query,1713server # [ 132.553764] postgres[1691]: variables := coalesce(variables, '{}'),1714server # [ 132.554432] postgres[1691]: "operationName" := "operationName",1715server # [ 132.554808] postgres[1691]: extensions := extensions1716server # [ 132.555080] postgres[1691]: );1717server # [ 132.555901] postgres[1691]: $$;1718server # [ 132.562090] postgres[1691]:1719server # [ 132.562886] postgres[1691]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1720server # [ 132.563348] postgres[1691]: -- function in the extension so we need to grant permissions on existing entities AND1721server # [ 132.564513] postgres[1691]: -- update default permissions to any others that are created after `graphql.resolve`1722server # [ 132.571732] postgres[1691]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1723server # [ 132.574983] postgres[1691]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1724server # [ 132.576051] postgres[1691]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1725server # [ 132.581174] postgres[1691]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1726server # [ 132.582255] postgres[1691]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1727server # [ 132.583582] postgres[1691]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1728server # [ 132.589139] postgres[1691]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1729server # [ 132.589758] postgres[1691]:1730server # [ 132.590022] postgres[1691]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles1731server # [ 132.591264] postgres[1691]: grant usage on schema graphql_public to postgres with grant option;1732server # [ 132.601776] postgres[1691]: grant usage on schema graphql to postgres with grant option;1733server # [ 132.602928] postgres[1691]: END IF;1734server # [ 132.603344] postgres[1691]:1735server # [ 132.604176] postgres[1691]: END;1736server # [ 132.610109] postgres[1691]: $func$;1737server # [ 132.637088] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1690]: CREATE FUNCTION1738server # [ 132.639644] postgres[1691]: ::1 2026-10-26 12:32:51.101 UTC [1691] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1739server # [ 132.741841] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1690]: DROP EXTENSION1740server # [ 134.279489] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1690]: DO1741server # [ 134.364112] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql1742server # [ 134.771913] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1702]: DO1743server # [ 134.793661] postgres[1705]: ::1 2026-10-26 12:32:53.236 UTC [1705] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger1744server # [ 134.795237] postgres[1705]: LANGUAGE plpgsql1745server # [ 134.797888] postgres[1705]: AS $$1746server # [ 134.798655] postgres[1705]: BEGIN1747server # [ 134.799442] postgres[1705]: IF EXISTS (1748server # [ 134.799741] postgres[1705]: SELECT1749server # [ 134.805873] postgres[1705]: FROM pg_event_trigger_ddl_commands() AS ev1750server # [ 134.806855] postgres[1705]: JOIN pg_extension AS ext1751server # [ 134.808126] postgres[1705]: ON ev.objid = ext.oid1752server # [ 134.822759] postgres[1705]: WHERE ext.extname = 'pg_cron'1753server # [ 134.823252] postgres[1705]: )1754server # [ 134.824171] postgres[1705]: THEN1755server # [ 134.826306] postgres[1705]: grant usage on schema cron to postgres with grant option;1756server # [ 134.827679] postgres[1705]:1757server # [ 134.828230] postgres[1705]: alter default privileges in schema cron grant all on tables to postgres with grant option;1758server # [ 134.828583] postgres[1705]: alter default privileges in schema cron grant all on functions to postgres with grant option;1759server # [ 134.828875] postgres[1705]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1760server # [ 134.833919] postgres[1705]:1761server # [ 134.834416] postgres[1705]: alter default privileges for user supabase_admin in schema cron grant all1762server # [ 134.840665] postgres[1705]: on sequences to postgres with grant option;1763server # [ 134.841533] postgres[1705]: alter default privileges for user supabase_admin in schema cron grant all1764server # [ 134.842383] postgres[1705]: on tables to postgres with grant option;1765server # [ 134.843497] postgres[1705]: alter default privileges for user supabase_admin in schema cron grant all1766server # [ 134.844085] postgres[1705]: on functions to postgres with grant option;1767server # [ 134.845567] postgres[1705]:1768server # [ 134.846112] postgres[1705]: grant all privileges on all tables in schema cron to postgres with grant option;1769server # [ 134.846908] postgres[1705]: revoke all on table cron.job from postgres;1770server # [ 134.847776] postgres[1705]: grant select on table cron.job to postgres with grant option;1771server # [ 134.854920] postgres[1705]: END IF;1772server # [ 134.864945] postgres[1705]: END;1773server # [ 134.865775] postgres[1705]: $$;1774server # [ 134.869170] postgres[1705]: ::1 2026-10-26 12:32:53.312 UTC [1705] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access;1775server # [ 134.870707] postgres[1705]: ::1 2026-10-26 12:32:53.327 UTC [1705] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;1776server # [ 134.878687] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1702]: CREATE FUNCTION1777server # [ 134.879267] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1702]: DROP EVENT TRIGGER1778server # [ 134.885268] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1702]: ALTER FUNCTION1779server # [ 134.887389] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1702]: CREATE EVENT TRIGGER1780server # [ 134.909830] postgres[1705]: ::1 2026-10-26 12:32:53.346 UTC [1705] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end1781server # [ 134.925294] postgres[1705]: WHEN TAG IN ('CREATE EXTENSION')1782server # [ 134.926326] postgres[1705]: EXECUTE FUNCTION extensions.grant_pg_cron_access();1783server # [ 134.967816] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql1784server # [ 135.403624] postgres[1716]: ::1 2026-10-26 12:32:53.842 UTC [1716] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s';1785server # [ 135.430414] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1712]: ALTER ROLE1786server # [ 135.468063] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql1787server # [ 135.883010] postgres[1723]: ::1 2026-10-26 12:32:54.341 UTC [1723] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin;1788server # [ 135.954376] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1720]: ALTER FUNCTION1789server # [ 135.966760] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1720]: ALTER FUNCTION1790server # [ 135.977639] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1720]: ALTER FUNCTION1791server # [ 135.978702] postgres[1723]: ::1 2026-10-26 12:32:54.410 UTC [1723] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;1792server # [ 135.992185] postgres[1723]: ::1 2026-10-26 12:32:54.429 UTC [1723] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;1793server # [ 136.013401] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql1794server # [ 136.340041] postgres[1727]: ::1 2026-10-26 12:32:54.803 UTC [1727] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres;1795server # [ 136.364778] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1726]: GRANT ROLE1796server # [ 136.421635] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql1797server # [ 137.268719] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1728]: DO1798server # [ 137.326066] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql1799server # [ 137.977895] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1730]: DO1800server # [ 137.990677] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1730]: DO1801server # [ 138.052926] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql1802server # [ 138.550469] postgres[1751]: ::1 2026-10-26 12:32:56.999 UTC [1751] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none;1803server # [ 138.556215] postgres[1751]: ::1 2026-10-26 12:32:57.023 UTC [1751] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none;1804server # [ 138.567771] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1747]: ALTER ROLE1805server # [ 138.571995] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1747]: ALTER ROLE1806server # [ 138.575172] postgres[1751]: ::1 2026-10-26 12:32:57.039 UTC [1751] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none;1807server # [ 138.586728] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1747]: ALTER ROLE1808server # [ 138.675535] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql1809server # [ 139.119960] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1755]: DO1810server # [ 139.152904] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql1811server # [ 139.415195] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1760]: DO1812server # [ 139.444128] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql1813server # [ 139.862848] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1762]: CREATE FUNCTION1814server # [ 139.884648] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1762]: DO1815server # [ 139.942657] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql1816server # [ 140.322540] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1768]: ALTER FUNCTION1817server # [ 140.338296] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1768]: GRANT1818server # [ 140.401505] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql1819server # [ 140.775549] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1770]: DROP EVENT TRIGGER1820server # [ 140.831703] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1770]: ALTER FUNCTION1821server # [ 140.849233] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1770]: CREATE EVENT TRIGGER1822server # [ 140.886432] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql1823server # [ 141.305548] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1778]: DO1824server # [ 141.371876] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql1825server # [ 141.872711] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1790]: CREATE FUNCTION1826server # [ 141.881446] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1790]: GRANT1827server # [ 141.923433] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql1828server # [ 142.210602] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1800]: REVOKE ROLE1829server # [ 142.243991] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1800]: DO1830server # [ 142.253880] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1800]: DO1831server # [ 142.260948] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1800]: REVOKE ROLE1832server # [ 142.286042] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1800]: REVOKE1833server # [ 142.313431] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1800]: DO1834server # [ 142.342255] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql1835server # [ 142.583544] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1802]: DO1836server # [ 142.632592] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql1837server # [ 142.963522] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1804]: DO1838server # [ 142.979282] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql1839server # [ 143.394007] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1806]: DO1840server # [ 143.426145] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql1841server # [ 143.886735] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1811]: ALTER ROLE1842server # [ 143.911146] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql1843server # [ 144.396740] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1818]: GRANT ROLE1844server # [ 144.441980] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1818]: DO1845server # [ 144.509201] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql1846server # [ 145.073638] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1827]: GRANT1847server # [ 145.140678] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql1848server # [ 145.574034] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1838]: CREATE FUNCTION1849server # [ 145.581592] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1838]: REVOKE1850server # [ 145.598253] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1838]: REVOKE1851server # [ 145.621057] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1838]: GRANT1852server # [ 145.668723] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql1853server # [ 146.089994] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1844]: DO1854server # [ 146.143952] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql1855server # [ 146.470883] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1846]: ALTER ROLE1856server # [ 146.495540] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql1857server # [ 146.912374] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1848]: DROP EXTENSION1858server # [ 146.925719] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql1859server # [ 147.490364] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1850]: CREATE FUNCTION1860server # [ 147.492114] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1850]: DROP EVENT TRIGGER1861server # [ 147.521641] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1850]: CREATE EVENT TRIGGER1862server # [ 147.615751] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql1863server # [ 148.180975] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1866]: DO1864server # [ 148.253373] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1866]: CREATE FUNCTION1865server # [ 148.325148] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql1866server # [ 148.738375] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1877]: CREATE FUNCTION1867server # [ 148.766076] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1877]: CREATE FUNCTION1868server # [ 148.810942] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql1869server # [ 149.111095] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1880]: CREATE FUNCTION1870server # [ 149.125470] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1880]: CREATE FUNCTION1871server # [ 149.134417] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1880]: CREATE FUNCTION1872server # [ 149.157026] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1880]: CREATE FUNCTION1873server # [ 149.169977] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1880]: CREATE FUNCTION1874server # [ 149.185576] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1880]: CREATE FUNCTION1875server # [ 149.238557] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Running postgresql schema...1876server # [ 149.616872] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER DATABASE1877server # [ 149.621665] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER DATABASE1878server # [ 149.724458] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER ROLE1879server # [ 149.798002] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER ROLE1880server # [ 149.865564] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER ROLE1881server # [ 149.954090] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER ROLE1882server # [ 150.022469] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER ROLE1883server # [ 150.089750] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER ROLE1884server # [ 150.233916] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER ROLE1885server # [ 150.370261] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER ROLE1886server # [ 150.521223] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER ROLE1887server # [ 150.553120] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1882]: ALTER ROLE1888server # [ 150.623328] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[1346]: Database initialization complete1889server # [ 150.666332] systemd[1]: Finished Supabase Database Initialization.1890server # [ 150.681875] systemd[1]: Reached target Multi-User System.1891server # [ 150.690150] systemd[1]: Startup finished in 19.030s (kernel) + 2min 11.657s (userspace) = 2min 30.687s.1892server: (finished: waiting for unit supabase-db-init.service, in 153.00 seconds)1893server: waiting for unit postgresql-collation-refresh.service1894server: (finished: waiting for unit postgresql-collation-refresh.service, in 0.92 seconds)1895server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database g locale_provider = libc locale = 'en_US.UTF-8' template template0"1896server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database g locale_provider = libc locale = 'en_US.UTF-8' template template0", in 1.81 seconds)1897server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database out locale_provider = libc locale = 'en_US.UTF-8' template template0"1898server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database out locale_provider = libc locale = 'en_US.UTF-8' template template0", in 1.24 seconds)1899server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database de locale_provider = libc locale = 'de_DE.UTF-8' template template0"1900server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database de locale_provider = libc locale = 'de_DE.UTF-8' template template0", in 1.45 seconds)1901server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database c locale_provider = libc locale = 'C' template template0"1902server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database c locale_provider = libc locale = 'C' template template0", in 0.95 seconds)1903server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database i locale_provider = icu locale = 'en_US.UTF-8' icu_locale = 'en-US' template template0"1904server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database i locale_provider = icu locale = 'en_US.UTF-8' icu_locale = 'en-US' template template0", in 1.65 seconds)1905server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'g'"1906server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'g'", in 0.57 seconds)1907server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'i'"1908server # [ 160.934921] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31909server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'i'", in 0.62 seconds)1910subtest: Nothing stale1911server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'g'"1912server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'g'", in 0.59 seconds)1913server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'out'"1914server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'out'", in 0.58 seconds)1915server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'"1916server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'", in 0.75 seconds)1917server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'"1918server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'", in 0.74 seconds)1919server # [ 164.459838] systemd[1]: postgresql-collation-refresh.service: Deactivated successfully.1920server # [ 164.484783] systemd[1]: Stopped Refresh default collation version.1921server # [ 164.487198] systemd[1]: postgresql-collation-refresh.service: Consumed 363ms CPU time, 2.3M memory peak, 1.6K incoming IP traffic, 1.9K outgoing IP traffic.1922server # [ 164.506749] systemd[1]: Stopping Refresh default collation version...1923server # [ 164.528944] systemd[1]: Starting Refresh default collation version...1924server # [ 165.174051] systemd[1]: Finished Refresh default collation version.1925server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'c'"1926server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'c'", in 0.66 seconds)1927(finished: subtest: Nothing stale, in 4.72 seconds)1928subtest: A stale glibc en_US database inside the bounds is refreshed1929server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'g'"1930server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'g'", in 0.76 seconds)1931server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'out'"1932server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'out'", in 0.74 seconds)1933server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'"1934server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'", in 0.57 seconds)1935server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'"1936server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'", in 0.55 seconds)1937server # [ 169.132695] systemd[1]: postgresql-collation-refresh.service: Deactivated successfully.1938server # [ 169.145445] systemd[1]: Stopped Refresh default collation version.1939server # [ 169.158664] systemd[1]: postgresql-collation-refresh.service: Consumed 167ms CPU time, 2M memory peak, 1.2K incoming IP traffic, 1.8K outgoing IP traffic.1940server # [ 169.161708] systemd[1]: Stopping Refresh default collation version...1941server # [ 169.202043] systemd[1]: Starting Refresh default collation version...1942server # [ 169.928920] psql[2103]: psql:/nix/var/nix/profiles/site/share/postgres-collation-refresh.sql:18: NOTICE: changing version from 2.31 to 2.401943server # [ 170.025822] systemd[1]: Finished Refresh default collation version.1944server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'g'"1945server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'g'", in 0.72 seconds)1946server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'c'"1947server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'c'", in 0.55 seconds)1948(finished: subtest: A stale glibc en_US database inside the bounds is refreshed, in 5.50 seconds)1949subtest: ICU and non-English glibc databases are left alone1950server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'g'"1951server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'g'", in 0.54 seconds)1952server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'out'"1953server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'out'", in 0.78 seconds)1954server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'de'"1955server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'de'", in 0.76 seconds)1956server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '1.0' where datname = 'i'"1957server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '1.0' where datname = 'i'", in 0.60 seconds)1958server # [ 174.596272] systemd[1]: postgresql-collation-refresh.service: Deactivated successfully.1959server # [ 174.611480] systemd[1]: Stopped Refresh default collation version.1960server # [ 174.613636] systemd[1]: postgresql-collation-refresh.service: Consumed 208ms CPU time, 1.7M memory peak, 1.8K incoming IP traffic, 2K outgoing IP traffic.1961server # [ 174.618925] systemd[1]: Stopping Refresh default collation version...1962server # [ 174.622249] systemd[1]: Starting Refresh default collation version...1963server # [ 175.248668] systemd[1]: Finished Refresh default collation version.1964server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'de'"1965server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'de'", in 0.78 seconds)1966server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'i'"1967server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'i'", in 0.71 seconds)1968server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'c'"1969server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'c'", in 0.63 seconds)1970(finished: subtest: ICU and non-English glibc databases are left alone, in 6.03 seconds)1971subtest: A database above 2.44 fails the unit, the others are refreshed1972server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'g'"1973server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'g'", in 0.53 seconds)1974server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.99' where datname = 'out'"1975server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.99' where datname = 'out'", in 0.66 seconds)1976server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'"1977server # [ 179.432301] systemd[1]: Starting Virtual Console Setup...1978server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'", in 0.87 seconds)1979server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'"1980server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'", in 1.14 seconds)1981server # [ 181.550992] systemd[1]: postgresql-collation-refresh.service: Deactivated successfully.1982server # [ 181.559733] systemd[1]: Stopped Refresh default collation version.1983server # [ 181.577274] systemd[1]: postgresql-collation-refresh.service: Consumed 157ms CPU time, 1.7M memory peak, 1.4K incoming IP traffic, 1.8K outgoing IP traffic.1984server # [ 181.580080] systemd[1]: Stopping Refresh default collation version...1985server # [ 181.620821] systemd[1]: Starting Refresh default collation version...1986server # [ 182.503234] psql[2251]: psql:/nix/var/nix/profiles/site/share/postgres-collation-refresh.sql:18: NOTICE: changing version from 2.31 to 2.401987server # [ 182.527006] postgres[2252]: ::1 2026-10-26 12:33:40.985 UTC [2252] supabase_admin@postgres ERROR: collation_refresh: still stale: "out"1988server # [ 182.548199] postgres[2252]: ::1 2026-10-26 12:33:40.985 UTC [2252] supabase_admin@postgres CONTEXT: PL/pgSQL function inline_code_block line 6 at RAISE1989server # [ 182.573608] postgres[2252]: ::1 2026-10-26 12:33:40.985 UTC [2252] supabase_admin@postgres STATEMENT: do $$1990server # [ 182.586932] postgres[2252]: declare names text;1991server # [ 182.587735] postgres[2252]: begin1992server # [ 182.594575] postgres[2252]: select string_agg(format('%I', datname), ', ' order by datname) into names from stale;1993server # [ 182.597790] postgres[2252]: if names is not null then1994server # [ 182.605450] postgres[2252]: raise exception 'collation_refresh: still stale: %', names;1995server # [ 182.615082] postgres[2252]: end if;1996server # [ 182.618455] postgres[2252]: end $$;1997server # [ 182.619466] psql[2251]: psql:/nix/var/nix/profiles/site/share/postgres-collation-refresh.sql:28: ERROR: collation_refresh: still stale: "out"1998server # [ 182.622215] psql[2251]: CONTEXT: PL/pgSQL function inline_code_block line 6 at RAISE1999server # [ 182.637902] systemd[1]: postgresql-collation-refresh.service: Main process exited, code=exited, status=3/NOTIMPLEMENTED2000server # [ 182.650098] systemd[1]: postgresql-collation-refresh.service: Failed with result 'exit-code'.2001server # [ 182.675449] systemd[1]: Failed to start Refresh default collation version.2002server # Job for postgresql-collation-refresh.service failed because the control process exited with error code.2003server # See "systemctl status postgresql-collation-refresh.service" and "journalctl -xeu postgresql-collation-refresh.service" for details.2004server # [ 182.686857] systemd[1]: postgresql-collation-refresh.service: Consumed 258ms CPU time, 1.9M memory peak, 2K incoming IP traffic, 2.1K outgoing IP traffic.2005server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'out'"2006server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'out'", in 1.11 seconds)2007server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'g'"2008server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'g'", in 1.30 seconds)2009server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'c'"2010server # [ 185.691051] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2011server # [ 186.013261] systemd[1]: Finished Virtual Console Setup.2012server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'c'", in 0.99 seconds)2013(finished: subtest: A database above 2.44 fails the unit, the others are refreshed, in 8.79 seconds)2014subtest: A database below 2.31 fails the unit2015server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'g'"2016server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'g'", in 0.56 seconds)2017server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.28' where datname = 'out'"2018server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.28' where datname = 'out'", in 0.71 seconds)2019server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'"2020server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'", in 1.11 seconds)2021server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'"2022server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'", in 0.64 seconds)2023server # [ 189.844054] systemd[1]: Starting Refresh default collation version...2024server # [ 190.566491] postgres[2326]: ::1 2026-10-26 12:33:49.031 UTC [2326] supabase_admin@postgres ERROR: collation_refresh: still stale: "out"2025server # [ 190.577682] postgres[2326]: ::1 2026-10-26 12:33:49.031 UTC [2326] supabase_admin@postgres CONTEXT: PL/pgSQL function inline_code_block line 6 at RAISE2026server # [ 190.578481] postgres[2326]: ::1 2026-10-26 12:33:49.031 UTC [2326] supabase_admin@postgres STATEMENT: do $$2027server # [ 190.579003] postgres[2326]: declare names text;2028server # [ 190.579288] postgres[2326]: begin2029server # [ 190.579514] postgres[2326]: select string_agg(format('%I', datname), ', ' order by datname) into names from stale;2030server # [ 190.585522] postgres[2326]: if names is not null then2031server # [ 190.586459] postgres[2326]: raise exception 'collation_refresh: still stale: %', names;2032server # [ 190.587003] postgres[2326]: end if;2033server # [ 190.587814] postgres[2326]: end $$;2034server # [ 190.602930] psql[2325]: psql:/nix/var/nix/profiles/site/share/postgres-collation-refresh.sql:28: ERROR: collation_refresh: still stale: "out"2035server # [ 190.608174] psql[2325]: CONTEXT: PL/pgSQL function inline_code_block line 6 at RAISE2036server # [ 190.629233] systemd[1]: postgresql-collation-refresh.service: Main process exited, code=exited, status=3/NOTIMPLEMENTED2037server # [ 190.631483] systemd[1]: postgresql-collation-refresh.service: Failed with result 'exit-code'.2038server # [ 190.642791] systemd[1]: Failed to start Refresh default collation version.2039server # [ 190.657521] systemd[1]: postgresql-collation-refresh.service: Consumed 183ms CPU time, 1.7M memory peak, 1.7K incoming IP traffic, 1.9K outgoing IP traffic.2040server # Job for postgresql-collation-refresh.service failed because the control process exited with error code.2041server # See "systemctl status postgresql-collation-refresh.service" and "journalctl -xeu postgresql-collation-refresh.service" for details.2042server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'out'"2043server # [ 191.114031] systemd-logind[654]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2044server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'out'", in 0.56 seconds)2045server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'c'"2046server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'c'", in 0.41 seconds)2047(finished: subtest: A database below 2.31 fails the unit, in 5.51 seconds)2048subtest: A database that fails to refresh does not stop the others2049server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create role refresher login"2050server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create role refresher login", in 0.44 seconds)2051server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database a_other locale_provider = libc locale = 'en_US.UTF-8' template template0"2052server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database a_other locale_provider = libc locale = 'en_US.UTF-8' template template0", in 0.83 seconds)2053server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database b_owned owner refresher locale_provider = libc locale = 'en_US.UTF-8' template template0"2054server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "create database b_owned owner refresher locale_provider = libc locale = 'en_US.UTF-8' template template0", in 0.69 seconds)2055server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'g'"2056server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'g'", in 0.40 seconds)2057server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'out'"2058server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'out'", in 0.42 seconds)2059server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'"2060server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'", in 0.40 seconds)2061server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'"2062server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'", in 0.41 seconds)2063server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'a_other'"2064server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'a_other'", in 0.40 seconds)2065server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'b_owned'"2066server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'b_owned'", in 0.44 seconds)2067server # [ 196.618451] postgres[2381]: ::1 2026-10-26 12:33:55.082 UTC [2381] refresher@postgres LOG: statement: create temp view stale as2068server # [ 196.623843] postgres[2381]: select datname,2069server # [ 196.625612] postgres[2381]: string_to_array(datcollversion, '.')::int[] between string_to_array('2.31', '.')::int[] and string_to_array('2.44', '.')::int[]2070server # [ 196.626343] postgres[2381]: and string_to_array(pg_database_collation_actual_version(oid), '.')::int[] between string_to_array('2.31', '.')::int[] and string_to_array('2.44', '.')::int[] as in_bounds2071server # [ 196.627459] postgres[2381]: from pg_database2072server # [ 196.627991] postgres[2381]: where datlocprovider = 'c'2073server # [ 196.629354] postgres[2381]: and datcollate in ('en_US.UTF-8', 'en_US.utf8')2074server # [ 196.630055] postgres[2381]: and datcollversion is not null2075server # [ 196.630495] postgres[2381]: and datcollversion <> pg_database_collation_actual_version(oid);2076server # [ 196.672598] postgres[2381]: ::1 2026-10-26 12:33:55.140 UTC [2381] refresher@postgres LOG: statement: alter database a_other refresh collation version2077server # [ 196.675078] postgres[2381]: ::1 2026-10-26 12:33:55.141 UTC [2381] refresher@postgres ERROR: must be owner of database a_other2078server # [ 196.676245] postgres[2381]: ::1 2026-10-26 12:33:55.141 UTC [2381] refresher@postgres STATEMENT: alter database a_other refresh collation version2079server # psql:/nix/var/nix/profiles/site/share/postgres-collation-refresh.sql:18: ERROR: must be owner of database a_other2080server # [ 196.680463] postgres[2381]: ::1 2026-10-26 12:33:55.148 UTC [2381] refresher@postgres LOG: statement: alter database b_owned refresh collation version2081server # psql:/nix/var/nix/profiles/site/share/postgres-collation-refresh.sql:18: NOTICE: changing version from 2.31 to 2.402082server # psql:[ 196.698702] postgres[2381]: ::1 2026-10-26 12:33:55.166 UTC [2381] refresher@postgres ERROR: collation_refresh: still stale: a_other2083server # /nix/var/nix/profiles/site/share/postgres-collation-refresh.sql:28: ERROR: collation_refresh: still stale: a_other2084server # CONTEXT: PL/pgSQL function inline_code_block line 6 at RAISE2085server # [ 196.699902] postgres[2381]: ::1 2026-10-26 12:33:55.166 UTC [2381] refresher@postgres CONTEXT: PL/pgSQL function inline_code_block line 6 at RAISE2086server # [ 196.701538] postgres[2381]: ::1 2026-10-26 12:33:55.166 UTC [2381] refresher@postgres STATEMENT: do $$2087server # [ 196.703473] postgres[2381]: declare names text;2088server # [ 196.705997] postgres[2381]: begin2089server # [ 196.706723] postgres[2381]: select string_agg(format('%I', datname), ', ' order by datname) into names from stale;2090server # [ 196.707871] postgres[2381]: if names is not null then2091server # [ 196.709297] postgres[2381]: raise exception 'collation_refresh: still stale: %', names;2092server # [ 196.710079] postgres[2381]: end if;2093server # [ 196.710908] postgres[2381]: end $$;2094server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'a_other'"2095server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'a_other'", in 0.42 seconds)2096server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'b_owned'"2097server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'b_owned'", in 0.42 seconds)2098(finished: subtest: A database that fails to refresh does not stop the others, in 5.81 seconds)2099subtest: A postgres restart reruns the unit and leaves postgres active when it fails2100server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'g'"2101server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.31' where datname = 'g'", in 0.44 seconds)2102server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.99' where datname = 'out'"2103server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.99' where datname = 'out'", in 0.47 seconds)2104server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'"2105server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'de'", in 0.44 seconds)2106server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'"2107server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '153.121' where datname = 'i'", in 0.41 seconds)2108server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'a_other'"2109server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "update pg_database set datcollversion = '2.40' where datname = 'a_other'", in 0.42 seconds)2110server: must succeed: systemctl reset-failed postgresql-collation-refresh.service2111server: (finished: must succeed: systemctl reset-failed postgresql-collation-refresh.service, in 0.32 seconds)2112server: must succeed: systemctl restart postgresql2113server # [ 200.445749] systemd[1]: supabase-db-init.service: Deactivated successfully.2114server # [ 200.459376] systemd[1]: Stopped Supabase Database Initialization.2115server # [ 200.513323] postgres[1296]: 2026-10-26 12:33:58.898 UTC [1296] LOG: received fast shutdown request2116server # [ 200.517695] postgres[1296]: 2026-10-26 12:33:58.920 UTC [1296] LOG: aborting any active transactions2117server # [ 200.520505] systemd[1]: supabase-db-init.service: Consumed 7.988s CPU time, 2.6M memory peak, 91.5K incoming IP traffic, 131.1K outgoing IP traffic.2118server # [ 200.542348] postgres[1341]: 2026-10-26 12:33:58.946 UTC [1341] LOG: pg_cron scheduler shutting down2119server # [ 200.551292] systemd[1]: Stopping Supabase Database Initialization...2120server # [ 200.553604] systemd[1]: Stopping PostgreSQL Database Server...2121server # [ 200.660122] postgres[1296]: 2026-10-26 12:33:59.127 UTC [1296] LOG: background worker "pg_cron launcher" (PID 1341) exited with exit code 12122server # [ 200.661551] postgres[1296]: 2026-10-26 12:33:59.128 UTC [1296] LOG: background worker "logical replication launcher" (PID 1343) exited with exit code 12123server # [ 200.670193] postgres[1296]: 2026-10-26 12:33:59.137 UTC [1296] LOG: background worker "pg_net 0.20.4 worker" (PID 1367) exited with exit code 12124server # [ 200.682924] postgres[1326]: 2026-10-26 12:33:59.142 UTC [1326] LOG: shutting down2125server # [ 200.690473] postgres[1326]: 2026-10-26 12:33:59.157 UTC [1326] LOG: checkpoint starting: shutdown immediate2126server # [ 205.289208] postgres[1326]: 2026-10-26 12:34:03.742 UTC [1326] LOG: checkpoint complete: wrote 6698 buffers (40.9%); 0 WAL file(s) added, 0 removed, 2 recycled; write=2.216 s, sync=2.286 s, total=4.600 s; sync files=2211, longest=0.082 s, average=0.002 s; distance=31976 kB, estimate=31976 kB; lsn=0/366FC48, redo lsn=0/366FC482127server # [ 205.487775] postgres[1296]: 2026-10-26 12:34:03.940 UTC [1296] LOG: database system is shut down2128server # [ 205.566204] systemd[1]: postgresql.service: Deactivated successfully.2129server # [ 205.569577] systemd[1]: Stopped PostgreSQL Database Server.2130server # [ 205.571891] systemd[1]: postgresql.service: Consumed 45.892s CPU time, 262.9M memory peak, 176.6M written to disk, 195.7K incoming IP traffic, 164.5K outgoing IP traffic.2131server # [ 205.614750] systemd[1]: Starting PostgreSQL Database Server...2132server # [ 206.957342] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[2420]: Validating PostgreSQL configuration...2133server # [ 207.287431] 0sww9i4l2852y2y5znimhd17vwbzl9s8-postgresql-init[2432]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, auto_explain, pg_tle, plan_filter, supabase_vault2134server # [ 207.898809] postgres[2434]: 2026-10-26 12:34:06.360 UTC [2434] LOG: pgaudit extension initialized2135server # [ 208.223724] postgres[2434]: 2026-10-26 12:34:06.690 UTC [2434] LOG: pgsodium primary server secret key loaded2136server # [ 208.439672] postgres[2434]: 2026-10-26 12:34:06.907 UTC [2434] LOG: vault primary server secret key loaded2137server # [ 208.681265] postgres[2434]: 2026-10-26 12:34:07.148 UTC [2434] LOG: starting PostgreSQL 17.11 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit2138server # [ 208.692836] postgres[2434]: 2026-10-26 12:34:07.159 UTC [2434] LOG: listening on IPv4 address "0.0.0.0", port 54322139server # [ 208.696962] postgres[2434]: 2026-10-26 12:34:07.159 UTC [2434] LOG: listening on IPv6 address "::", port 54322140server # [ 208.707778] postgres[2434]: 2026-10-26 12:34:07.175 UTC [2434] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"2141server # [ 208.791366] postgres[2439]: 2026-10-26 12:34:07.253 UTC [2439] LOG: database system was shut down at 2026-10-26 12:34:03 UTC2142server # [ 208.890965] postgres[2434]: 2026-10-26 12:34:07.357 UTC [2434] LOG: database system is ready to accept connections2143server # [ 208.928184] systemd[1]: Started PostgreSQL Database Server.2144server # [ 209.021527] systemd[1]: Starting Refresh default collation version...2145server # [ 209.073447] systemd[1]: Starting Supabase Database Initialization...2146server: (finished: must succeed: systemctl restart postgresql, in 8.98 seconds)2147server: waiting for success: systemctl is-failed postgresql-collation-refresh.service2148server # [ 209.449629] postgres[2443]: 2026-10-26 12:34:07.895 UTC [2443] LOG: pg_cron scheduler started2149server # [ 209.570707] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[2446]: Waiting for PostgreSQL to be ready...2150server # [ 209.982988] postgres[2454]: ::1 2026-10-26 12:34:08.446 UTC [2454] root@root FATAL: role "root" does not exist2151server # [ 210.027728] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[2446]: PostgreSQL is ready2152server # [ 210.033652] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[2446]: Creating postgres role...2153server # [ 210.066989] psql[2445]: psql:/nix/var/nix/profiles/site/share/postgres-collation-refresh.sql:18: NOTICE: changing version from 2.31 to 2.402154server # [ 210.099838] postgres[2453]: ::1 2026-10-26 12:34:08.552 UTC [2453] supabase_admin@postgres ERROR: collation_refresh: still stale: "out"2155server # [ 210.117563] postgres[2453]: ::1 2026-10-26 12:34:08.552 UTC [2453] supabase_admin@postgres CONTEXT: PL/pgSQL function inline_code_block line 6 at RAISE2156server # [ 210.119486] postgres[2453]: ::1 2026-10-26 12:34:08.552 UTC [2453] supabase_admin@postgres STATEMENT: do $$2157server # [ 210.130118] postgres[2453]: declare names text;2158server # [ 210.133787] postgres[2453]: begin2159server # [ 210.134928] postgres[2453]: select string_agg(format('%I', datname), ', ' order by datname) into names from stale;2160server # [ 210.135956] postgres[2453]: if names is not null then2161server # [ 210.143887] postgres[2453]: raise exception 'collation_refresh: still stale: %', names;2162server # [ 210.148146] postgres[2453]: end if;2163server # [ 210.156711] postgres[2453]: end $$;2164server # [ 210.158702] psql[2445]: psql:/nix/var/nix/profiles/site/share/postgres-collation-refresh.sql:28: ERROR: collation_refresh: still stale: "out"2165server # [ 210.159662] psql[2445]: CONTEXT: PL/pgSQL function inline_code_block line 6 at RAISE2166server # [ 210.186252] systemd[1]: postgresql-collation-refresh.service: Main process exited, code=exited, status=3/NOTIMPLEMENTED2167server # [ 210.201020] systemd[1]: postgresql-collation-refresh.service: Failed with result 'exit-code'.2168server # [ 210.218826] systemd[1]: Failed to start Refresh default collation version.2169server # [ 210.219772] systemd[1]: postgresql-collation-refresh.service: Consumed 236ms CPU time, 1.7M memory peak, 2.1K incoming IP traffic, 2.1K outgoing IP traffic.2170server # [ 210.326989] postgres[2457]: ::1 2026-10-26 12:34:08.791 UTC [2457] supabase_admin@postgres ERROR: role "postgres" already exists2171server # [ 210.329409] postgres[2457]: ::1 2026-10-26 12:34:08.791 UTC [2457] supabase_admin@postgres STATEMENT: CREATE ROLE postgres SUPERUSER LOGIN;2172server # [ 210.363228] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[2455]: ERROR: role "postgres" already exists2173server # [ 210.561266] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[2458]: ALTER DATABASE2174server # [ 210.611345] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[2446]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql2175server # [ 210.792476] postgres[2461]: ::1 2026-10-26 12:34:09.256 UTC [2461] postgres@postgres LOG: statement: create publication supabase_realtime;2176server # [ 210.798921] postgres[2461]: ::1 2026-10-26 12:34:09.266 UTC [2461] postgres@postgres ERROR: publication "supabase_realtime" already exists2177server # [ 210.800085] postgres[2461]: ::1 2026-10-26 12:34:09.266 UTC [2461] postgres@postgres STATEMENT: create publication supabase_realtime;2178server # [ 210.811080] rjq9bb8v5f710jyvcna3min6c9zxgci5-supabase-db-init[2460]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql:5: ERROR: publication "supabase_realtime" already exists2179server # [ 210.864785] systemd[1]: supabase-db-init.service: Main process exited, code=exited, status=3/NOTIMPLEMENTED2180server # [ 210.867604] systemd[1]: supabase-db-init.service: Failed with result 'exit-code'.2181server # [ 210.874455] systemd[1]: Failed to start Supabase Database Initialization.2182server # [ 210.882432] systemd[1]: supabase-db-init.service: Consumed 547ms CPU time, 1.8M memory peak, 3.4K incoming IP traffic, 2.9K outgoing IP traffic.2183server: (finished: waiting for success: systemctl is-failed postgresql-collation-refresh.service, in 2.28 seconds)2184server: must succeed: systemctl is-active postgresql.service2185server: (finished: must succeed: systemctl is-active postgresql.service, in 0.32 seconds)2186server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'g'"2187server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'g'", in 0.43 seconds)2188server: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'out'"2189server: (finished: must succeed: psql -h localhost -U supabase_admin -d postgres -At -v ON_ERROR_STOP=1 -c "select coalesce(datcollversion, '-') from pg_database where datname = 'out'", in 0.44 seconds)2190(finished: subtest: A postgres restart reruns the unit and leaves postgres active when it fails, in 14.97 seconds)2191(finished: run the VM test script, in 213.69 seconds)2192test script finished in 214.09s2193cleanup2194kill machine (pid 9)2195qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13)2196vde_switch: EOF data port: Interrupted system call2197kill vlan (pid 7)2198vde_switch: EOF on stdin, cleaning up and exiting2199vde_switch: Caught signal 15, cleaning up and exiting2200(finished: cleanup, in 0.01 seconds)2201vde_switch: Could not remove ctl socket '/build/vde1.ctl': No such file or directory