vm-test-run-amcheck-upgrade
checks.aarch64-linux.ext-amcheck-upgrade
· build #370
· 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.chbfyz8LDZ', fmt=raw size=107374182420server # Discarding device blocks: 0/262144 done21server # Creating filesystem with 262144 4k blocks and 65536 inodes22server # Filesystem UUID: 70d6403b-5b6c-4aa5-9230-62cbbf3c37d323server # Superblock backups stored on blocks:24server # 32768, 98304, 163840, 22937625server # 26server # Allocating group tables: 0/8 done27server # Writing inode tables: 0/8 done28server # Creating journal (8192 blocks): done29server # Writing superblocks and filesystem accounting information: 0/8 done30server # 31server # Virtualisation disk image created.32server: QEMU running (pid 9)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/51mjry1hnx13bixr69pkxj0kvj7jv17l-nixos-system-server-test/init regInfo=/nix/store/xjahn90cl2s94zx84a3dk4z4wprs3sqr-closure-info/registration console=ttyAMA0,115200n8 console=tty069server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/xjahn90cl2s94zx84a3dk4z4wprs3sqr-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 @0x0000000100b00000102server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b10000103server # [ 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.000041] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns107server # [ 0.004047] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)108server # [ 0.016207] Console: colour dummy device 80x25109server # [ 0.018146] printk: legacy console [tty0] enabled110server # [ 0.024464] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)111server # [ 0.024911] pid_max: default: 32768 minimum: 301112server # [ 0.027103] LSM: initializing lsm=capability,landlock,yama,bpf113server # [ 0.028755] landlock: Up and running.114server # [ 0.028826] Yama: becoming mindful.115server # [ 0.032023] LSM support for eBPF active116server # [ 0.035514] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)117server # [ 0.035722] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)118server # [ 0.068667] cacheinfo: Unable to detect cache hierarchy for CPU 0119server # [ 0.082343] rcu: Hierarchical SRCU implementation.120server # [ 0.082457] rcu: Max phase no-delay instances is 1000.121server # [ 0.083991] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level122server # [ 0.092637] fsl-mc MSI: its@8080000 domain created123server # [ 0.095220] EFI services will not be available.124server # [ 0.096972] smp: Bringing up secondary CPUs ...125server # [ 0.101366] Detected PIPT I-cache on CPU1126server # [ 0.102686] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000127server # [ 0.103445] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000128server # [ 0.105031] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]129server # [ 0.109813] smp: Brought up 1 node, 2 CPUs130server # [ 0.110056] SMP: Total of 2 processors activated.131server # [ 0.110102] CPU: All CPU(s) started at EL1132server # [ 0.110272] CPU features: detected: Branch Target Identification133server # [ 0.110329] CPU features: detected: 32-bit EL0 Support134server # [ 0.110358] CPU features: detected: 32-bit EL1 Support135server # [ 0.110676] CPU features: detected: ARMv8.4 Translation Table Level136server # [ 0.110736] CPU features: detected: Instruction cache invalidation not required for I/D coherence137server # [ 0.110784] CPU features: detected: Data cache clean to the PoU not required for I/D coherence138server # [ 0.110845] CPU features: detected: Common not Private translations139server # [ 0.110873] CPU features: detected: CRC32 instructions140server # [ 0.110899] CPU features: detected: Data cache clean to Point of Deep Persistence141server # [ 0.110930] CPU features: detected: Data cache clean to Point of Persistence142server # [ 0.110955] CPU features: detected: Data independent timing control (DIT)143server # [ 0.110985] CPU features: detected: E0PD144server # [ 0.111008] CPU features: detected: Enhanced Counter Virtualization145server # [ 0.111033] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)146server # [ 0.111062] CPU features: detected: Enhanced Privileged Access Never147server # [ 0.111090] CPU features: detected: Enhanced Virtualization Traps148server # [ 0.111118] CPU features: detected: Fine Grained Traps149server # [ 0.111180] CPU features: detected: Generic authentication (IMP DEF algorithm)150server # [ 0.111280] CPU features: detected: RCpc load-acquire (LDAPR)151server # [ 0.111331] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)152server # [ 0.111360] CPU features: detected: LSE atomic instructions153server # [ 0.111382] CPU features: detected: Memory Copy and Memory Set instructions154server # [ 0.111406] CPU features: detected: Privileged Access Never155server # [ 0.111432] CPU features: detected: RAS Extension Support156server # [ 0.111458] CPU features: detected: Random Number Generator157server # [ 0.111482] CPU features: detected: Speculation barrier (SB)158server # [ 0.111505] CPU features: detected: Stage-2 Force Write-Back159server # [ 0.111533] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality160server # [ 0.111565] CPU features: detected: TLB range maintenance instructions161server # [ 0.111593] CPU features: detected: WFx with timeout162server # [ 0.111640] CPU features: detected: Speculative Store Bypassing Safe (SSBS)163server # [ 0.111671] CPU features: detected: Scalable Vector Extension164server # [ 0.117492] alternatives: applying system-wide alternatives165server # [ 0.134991] CPU features: detected: Hardware dirty bit management on CPU0-1166server # [ 0.135573] SVE: maximum available vector length 256 bytes per vector167server # [ 0.135658] SVE: default vector length 64 bytes per vector168server # [ 0.151038] Memory: 3922900K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved)169server # [ 0.175511] devtmpfs: initialized170server # [ 0.207215] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns171server # [ 0.207719] futex hash table entries: 512 (order: 3, 32768 bytes, linear)172server # [ 0.210427] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL173server # [ 0.210513] 0 pages in range for non-PLT usage174server # [ 0.210556] 509248 pages in range for PLT usage175server # [ 0.214723] pinctrl core: initialized pinctrl subsystem176server # [ 0.226234] DMI not present or invalid.177server # [ 0.246203] NET: Registered PF_NETLINK/PF_ROUTE protocol family178server # [ 0.261148] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations179server # [ 0.262311] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations180server # [ 0.263639] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations181server # [ 0.263934] audit: initializing netlink subsys (disabled)182server # [ 0.267133] audit: type=2000 audit(0.212:1): state=initialized audit_enabled=0 res=1183server # [ 0.273048] thermal_sys: Registered thermal governor 'fair_share'184server # [ 0.273103] thermal_sys: Registered thermal governor 'bang_bang'185server # [ 0.273158] thermal_sys: Registered thermal governor 'step_wise'186server # [ 0.273185] thermal_sys: Registered thermal governor 'user_space'187server # [ 0.273210] thermal_sys: Registered thermal governor 'power_allocator'188server # [ 0.275153] cpuidle: using governor ladder189server # [ 0.275580] cpuidle: using governor menu190server # [ 0.277595] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.191server # [ 0.278429] ASID allocator initialised with 65536 entries192server # [ 0.286591] Serial: AMBA PL011 UART driver193server # [ 0.341028] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1194server # [ 0.342740] printk: legacy console [ttyAMA0] enabled195server # [ 0.386104] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages196server # [ 0.386624] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page197server # [ 0.386862] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages198server # [ 0.387028] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page199server # [ 0.387128] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages200server # [ 0.387226] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page201server # [ 0.387647] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages202server # [ 0.387765] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page203server # [ 0.402657] fbcon: Taking over console204server # [ 0.403748] ACPI: Interpreter disabled.205server # [ 0.412019] iommu: Default domain type: Translated206server # [ 0.412593] iommu: DMA domain TLB invalidation policy: strict mode207server # [ 0.417625] SCSI subsystem initialized208server # [ 0.420638] usbcore: registered new interface driver usbfs209server # [ 0.421036] usbcore: registered new interface driver hub210server # [ 0.421283] usbcore: registered new device driver usb211server # [ 0.424555] pps_core: LinuxPPS API ver. 1 registered212server # [ 0.424697] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>213server # [ 0.424886] PTP clock support registered214server # [ 0.425300] EDAC MC: Ver: 3.0.0215server # [ 0.427141] scmi_core: SCMI protocol bus registered216server # [ 0.431824] FPGA manager framework217server # [ 0.433082] Advanced Linux Sound Architecture Driver Initialized.218server # [ 0.442646] vgaarb: loaded219server # [ 0.449543] clocksource: Switched to clocksource arch_sys_counter220server # [ 0.452871] VFS: Disk quotas dquot_6.6.0221server # [ 0.453098] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)222server # [ 0.455804] netfs: FS-Cache loaded223server # [ 0.457494] pnp: PnP ACPI: disabled224server # [ 0.483777] NET: Registered PF_INET protocol family225server # [ 0.484987] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)226server # [ 0.606935] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)227server # [ 0.607366] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)228server # [ 0.607687] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)229server # [ 0.608518] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)230server # [ 0.609468] TCP: Hash tables configured (established 32768 bind 32768)231server # [ 0.611427] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)232server # [ 0.611933] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)233server # [ 0.612251] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)234server # [ 0.614006] NET: Registered PF_UNIX/PF_LOCAL protocol family235server # [ 0.614518] NET: Registered PF_XDP protocol family236server # [ 0.615174] PCI: CLS 0 bytes, default 64237server # [ 0.620182] Trying to unpack rootfs image as initramfs...238server # [ 0.622303] kvm [1]: HYP mode not available239server # [ 0.739163] Initialise system trusted keyrings240server # [ 0.743069] workingset: timestamp_bits=42 max_order=20 bucket_order=0241server # [ 0.746905] squashfs: version 4.0 (2009/01/31) Phillip Lougher242server # [ 0.747568] 9p: Installing v9fs 9p2000 file system support243server # [ 0.818459] Key type asymmetric registered244server # [ 0.818789] Asymmetric key parser 'x509' registered245server # [ 0.819931] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244)246server # [ 0.822461] io scheduler mq-deadline registered247server # [ 0.822633] io scheduler kyber registered248server # [ 0.850695] pl061_gpio 9030000.pl061: PL061 GPIO chip registered249server # [ 0.855882] ledtrig-cpu: registered to indicate activity on CPUs250server # [ 0.860664] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:251server # [ 0.861324] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000252server # [ 0.863101] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000253server # [ 0.863294] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000254server # [ 0.863792] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits255server # [ 0.864988] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]256server # [ 0.867787] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00257server # [ 0.868975] pci_bus 0000:00: root bus resource [bus 00-ff]258server # [ 0.870082] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]259server # [ 0.870325] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]260server # [ 0.870888] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]261server # [ 0.872355] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint262server # [ 0.876157] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint263server # [ 0.876563] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]264server # [ 0.876703] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]265server # [ 0.877112] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]266server # [ 0.878629] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]267server # [ 0.879420] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint268server # [ 0.879597] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]269server # [ 0.879693] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]270server # [ 0.879810] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271server # [ 0.880269] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint272server # [ 0.880429] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]273server # [ 0.880524] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]274server # [ 0.880637] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275server # [ 0.881064] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint276server # [ 0.881209] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]277server # [ 0.881302] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]278server # [ 0.881411] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279server # [ 0.883116] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint280server # [ 0.883351] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]281server # [ 0.883663] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]282server # [ 0.883878] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]283server # [ 0.884385] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint284server # [ 0.884710] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]285server # [ 0.884968] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]286server # [ 0.885080] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]287server # [ 0.886165] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint288server # [ 0.886879] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]289server # [ 0.887455] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]290server # [ 0.887921] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]291server # [ 0.888445] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]292server # [ 0.890153] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint293server # [ 0.891031] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]294server # [ 0.891236] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]295server # [ 0.891734] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint296server # [ 0.891897] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]297server # [ 0.892008] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298server # [ 0.892518] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint299server # [ 0.893172] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]300server # [ 0.895245] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint301server # [ 0.895536] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]302server # [ 0.895657] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]303server # [ 0.895943] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]304server # [ 0.896710] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint305server # [ 0.897002] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]306server # [ 0.897103] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]307server # [ 0.897215] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]308server # [ 0.900198] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned309server # [ 0.900488] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned310server # [ 0.900840] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned311server # [ 0.902121] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned312server # [ 0.902417] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned313server # [ 0.902773] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned314server # [ 0.902918] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned315server # [ 0.903047] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned316server # [ 0.903183] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned317server # [ 0.903324] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned318server # [ 0.903464] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned319server # [ 0.903594] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned320server # [ 0.903959] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned321server # [ 0.904110] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned322server # [ 0.904232] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned323server # [ 0.904343] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned324server # [ 0.904641] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned325server # [ 0.904782] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned326server # [ 0.904896] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned327server # [ 0.905004] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned328server # [ 0.905116] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned329server # [ 0.905230] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned330server # [ 0.905544] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned331server # [ 0.906480] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned332server # [ 0.906752] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned333server # [ 0.906905] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned334server # [ 0.907246] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned335server # [ 0.907470] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned336server # [ 0.907577] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned337server # [ 0.907679] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned338server # [ 0.907783] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned339server # [ 0.907881] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned340server # [ 0.907980] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned341server # [ 0.908078] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned342server # [ 0.908366] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]343server # [ 0.908480] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]344server # [ 0.908581] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]345server # [ 0.911079] pci 0000:00:0a.0: enabling device (0000 -> 0002)346server # [ 0.971477] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)347server # [ 0.975084] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)348server # [ 0.977012] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)349server # [ 0.979950] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)350server # [ 0.982162] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)351server # [ 0.983875] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)352server # [ 0.986019] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)353server # [ 0.988738] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)354server # [ 0.991750] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)355server # [ 0.994087] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)356server # [ 0.996931] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)357server # [ 1.015991] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled358server # [ 1.026233] msm_serial: driver initialized359server # [ 1.027258] SuperH (H)SCI(F) driver initialized360server # [ 1.027680] STM32 USART driver initialized361server # [ 1.077826] loop: module loaded362server # [ 1.078561] virtio_blk virtio5: 2/0/0 default/read/poll queues363server # [ 1.082824] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)364server # [ 1.095792] megasas: 07.727.03.00-rc1365server # [ 1.102729] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]366server # [ 1.107356] Freeing initrd memory: 10684K367server # [ 1.107651] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000368server # [ 1.108581] Intel/Sharp Extended Query Table at 0x0031369server # [ 1.111243] Using buffer write method370server # [ 1.111913] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]371server # [ 1.114025] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000372server # [ 1.114564] Intel/Sharp Extended Query Table at 0x0031373server # [ 1.116479] Using buffer write method374server # [ 1.116718] Concatenating MTD devices:375server # [ 1.116800] (0): "0.flash"376server # [ 1.116861] (1): "0.flash"377server # [ 1.116917] into device "0.flash"378server # [ 1.144916] tun: Universal TUN/TAP device driver, 1.6379server # [ 1.158338] thunder_xcv, ver 1.0380server # [ 1.158612] thunder_bgx, ver 1.0381server # [ 1.158806] nicpf, ver 1.0382server # [ 1.161214] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version383server # [ 1.161973] hns3: Copyright (c) 2017 Huawei Corporation.384server # [ 1.162745] hclge is initializing385server # [ 1.163006] e1000: Intel(R) PRO/1000 Network Driver386server # [ 1.163098] e1000: Copyright (c) 1999-2006 Intel Corporation.387server # [ 1.163314] e1000e: Intel(R) PRO/1000 Network Driver388server # [ 1.163403] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.389server # [ 1.163620] igb: Intel(R) Gigabit Ethernet Network Driver390server # [ 1.163715] igb: Copyright (c) 2007-2014 Intel Corporation.391server # [ 1.163898] igbvf: Intel(R) Gigabit Virtual Function Network Driver392server # [ 1.164393] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.393server # [ 1.165187] sky2: driver version 1.30394server # [ 1.174796] ehci-pci 0000:00:0a.0: EHCI Host Controller395server # [ 1.175398] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1396server # [ 1.177299] usbcore: registered new interface driver usb-storage397server # [ 1.178991] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000398server # [ 1.179078] usbcore: registered new interface driver usbserial_generic399server # [ 1.180163] usbserial: USB Serial support registered for generic400server # [ 1.190461] rtc-pl031 9010000.pl031: registered as rtc0401server # [ 1.191172] rtc-pl031 9010000.pl031: setting system clock to 2026-10-20T16:54:44 UTC (1792515284)402server # [ 1.194002] i2c_dev: i2c /dev entries driver403server # [ 1.194156] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00404server # [ 1.201166] hub 1-0:1.0: USB hub found405server # [ 1.202835] hub 1-0:1.0: 6 ports detected406server # [ 1.209177] sdhci: Secure Digital Host Controller Interface driver407server # [ 1.209351] sdhci: Copyright(c) Pierre Ossman408server # [ 1.212384] Synopsys Designware Multimedia Card Interface Driver409server # [ 1.214410] sdhci-pltfm: SDHCI platform and OF driver helper410server # [ 1.221648] hid: raw HID events driver (C) Jiri Kosina411server # [ 1.224074] usbcore: registered new interface driver usbhid412server # [ 1.224208] usbhid: USB HID core driver413server # [ 1.233008] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available414server # [ 1.250256] drop_monitor: Initializing network drop monitor service415server # [ 1.251603] NET: Registered PF_INET6 protocol family416server # [ 1.269474] Segment Routing with IPv6417server # [ 1.270329] In-situ OAM (IOAM) with IPv6418server # [ 1.271029] NET: Registered PF_PACKET protocol family419server # [ 1.272951] 9pnet: Installing 9P2000 support420server # [ 1.278784] Key type dns_resolver registered421server # [ 1.317237] registered taskstats version 1422server # [ 1.320413] Loading compiled-in X.509 certificates423server # [ 1.382891] Demotion targets for Node 0: null424server # [ 1.385854] Key type .fscrypt registered425server # [ 1.386021] Key type fscrypt-provisioning registered426server # [ 1.404337] input: gpio-keys as /devices/platform/gpio-keys/input/input0427server # [ 1.450858] usb 1-1: new high-speed USB device number 2 using ehci-pci428server # [ 1.454192] clk: Disabling unused clocks429server # [ 1.454839] PM: genpd: Disabling unused power domains430server # [ 1.455222] ALSA device list:431server # [ 1.455335] No soundcards found.432server # [ 1.544138] Freeing unused kernel memory: 4416K433server # [ 1.547594] Run /init as init process434server # [ 1.674475] 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.824472] 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.951289] usb 1-2: new high-speed USB device number 3 using ehci-pci437server # [ 2.137141] 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.144567] 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.150947] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev440server # [ 2.276981] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0441server # [ 2.278584] [drm] features: -virgl +edid -resource_blob -host_visible442server # [ 2.278614] [drm] features: -context_init443server # [ 2.280979] [drm] number of scanouts: 1444server # [ 2.281163] [drm] number of cap sets: 0445server # [ 2.292476] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0446server # [ 2.368447] Console: switching to colour frame buffer device 160x50447server # [ 2.379827] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device448server # [ 5.211342] EXT4-fs (vda): mounted filesystem 70d6403b-5b6c-4aa5-9230-62cbbf3c37d3 r/w with ordered data mode. Quota mode: none.449server # [ 7.688520] EXT4-fs (vda): re-mounted 70d6403b-5b6c-4aa5-9230-62cbbf3c37d3.450server # [ 7.709091] booting system configuration /nix/store/51mjry1hnx13bixr69pkxj0kvj7jv17l-nixos-system-server-test451server # [ 20.426828] 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 # [ 20.437737] systemd[1]: Detected virtualization qemu.453server # [ 20.443999] systemd[1]: Detected architecture arm64.454server # [ 20.449092] systemd[1]: Detected first boot.455server # [ 20.479608] systemd[1]: Initializing machine ID from random generator.456server # [ 20.509614] systemd[1]: Hostname set to <server>.457server # [ 21.764207] systemd[1]: bpf-restrict-fs: LSM BPF program attached458server # [ 23.176246] systemd[1]: Applying preset policy.459server # [ 26.749246] 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 # [ 30.235269] systemd[1]: Queued start job for default target Multi-User System.463server # [ 30.411648] systemd[1]: Created slice Slice /system/getty.464server # [ 30.424460] systemd[1]: Created slice Slice /system/modprobe.465server # [ 30.435975] systemd[1]: Created slice User and Session Slice.466server # [ 30.443491] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.467server # [ 30.448035] systemd[1]: Started Forward Password Requests to Wall Directory Watch.468server # [ 30.452887] systemd[1]: Expecting device /dev/hvc0...469server # [ 30.456192] systemd[1]: Expecting device /dev/ttyAMA0...470server # [ 30.458612] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1...471server # [ 30.463449] systemd[1]: Reached target Local Encrypted Volumes.472server # [ 30.467495] systemd[1]: Reached target Virtual Machines and Containers.473server # [ 30.471114] systemd[1]: Reached target Path Units.474server # [ 30.474568] systemd[1]: Reached target Remote File Systems.475server # [ 30.478173] systemd[1]: Reached target Slice Units.476server # [ 30.480533] systemd[1]: Reached target Swaps.477server # [ 30.513589] systemd[1]: Listening on Process Core Dump Socket.478server # [ 30.533298] systemd[1]: Listening on Credential Encryption/Decryption.479server # [ 30.543238] systemd[1]: Listening on Journal Audit Socket.480server # [ 30.548602] systemd[1]: Listening on Journal Socket (/dev/log).481server # [ 30.553611] systemd[1]: Listening on Journal Sockets.482server # [ 30.560972] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.483server # [ 30.565519] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki).484server # [ 30.571221] systemd[1]: Listening on udev Control Socket.485server # [ 30.576231] systemd[1]: Listening on udev Kernel Socket.486server # [ 30.616169] systemd[1]: Mounting Huge Pages File System...487server # [ 30.650606] systemd[1]: Mounting POSIX Message Queue File System...488server # [ 30.688417] systemd[1]: Mounting Kernel Debug File System...489server # [ 30.742524] systemd[1]: Mounting Kernel Trace File System...490server # [ 30.834884] systemd[1]: Starting Create List of Static Device Nodes...491server # [ 30.939657] systemd[1]: Starting Load Kernel Module 9pnet_virtio...492server # [ 30.962924] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs).493server # [ 31.080120] systemd[1]: Mounting Kernel Configuration File System...494server # [ 31.097277] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm).495server # [ 31.113847] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore).496server # [ 31.192035] systemd[1]: Starting Load Kernel Module fuse...497server # [ 31.201463] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).498server # [ 31.213823] 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 # [ 31.350897] systemd[1]: Starting Journal Service...500server # [ 31.420055] systemd[1]: Starting Load Kernel Modules...501server # [ 31.479867] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...502server # [ 31.528759] systemd[1]: Starting Remount Root and Kernel File Systems...503server # [ 31.542256] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).504server # [ 31.605814] systemd[1]: Starting Coldplug All udev Devices...505server # [ 31.676682] systemd[1]: Mounted Huge Pages File System.506server # [ 31.692978] systemd[1]: Mounted POSIX Message Queue File System.507server # [ 31.712532] systemd[1]: Mounted Kernel Debug File System.508server # [ 31.725326] systemd[1]: Mounted Kernel Trace File System.509server # [ 31.753144] systemd[1]: Finished Create List of Static Device Nodes.510server # [ 31.779461] systemd[1]: Mounted Kernel Configuration File System.511server # [ 31.856134] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...512server # [ 31.877091] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.513server # [ 31.900207] systemd[1]: Finished Load Kernel Module 9pnet_virtio.514server # [ 32.405285] fuse: init (API version 7.41)515server # [ 32.475193] systemd[1]: modprobe@fuse.service: Deactivated successfully.516server # [ 32.485901] systemd[1]: Finished Load Kernel Module fuse.517server # [ 32.530624] systemd[1]: Mounting FUSE Control File System...518server # [ 32.721406] EXT4-fs (vda): re-mounted 70d6403b-5b6c-4aa5-9230-62cbbf3c37d3.519server # [ 32.798448] systemd[1]: Finished Load Kernel Modules.520server # [ 32.827179] systemd[1]: Mounted FUSE Control File System.521server # [ 32.866824] systemd[1]: Starting Firewall...522server # [ 32.909140] systemd[1]: Starting Apply Kernel Variables...523server # [ 32.924420] systemd[1]: Finished Remount Root and Kernel File Systems.524server # [ 32.939438] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).525server # [ 32.982581] systemd[1]: Starting Load/Save OS Random Seed...526server # [ 32.990996] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).527server # [ 33.077920] systemd-journald[396]: Collecting audit messages is enabled.528server # [ 33.860211] systemd[1]: Finished Load/Save OS Random Seed.529server # [ 33.874904] systemd[1]: Reached target First Boot Complete.530server # [ 34.116011] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.531server # [ 34.266985] systemd[1]: Starting Create Static Device Nodes in /dev...532server # [ 34.455240] systemd[1]: Finished Apply Kernel Variables.533server # [ 34.589909] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.534server # [ 35.223400] systemd[1]: Finished Create Static Device Nodes in /dev.535server # [ 35.244810] systemd[1]: Reached target Preparation for Local File Systems.536server # [ 35.295199] systemd[1]: Mounting /run/wrappers...537server # [ 35.329791] systemd[1]: Starting Rule-based Manager for Device Events and Files...538server # [ 35.581176] systemd[1]: Started Journal Service.539server # [ 35.542061] systemd-modules-load[397]: Module 'atkbd' is built in540server # [ 35.567996] systemd-modules-load[397]: Module 'loop' is built in541server # [ 35.587860] systemd-oomd[398]: No swap; memory pressure usage will be degraded542server # [ 35.644244] systemd[1]: Starting Flush Journal to Persistent Storage...543server # [ 35.667003] systemd[1]: Mounted /run/wrappers.544server # [ 35.671529] systemd[1]: Reached target Local File Systems.545server # [ 35.677438] systemd[1]: Listening on Boot Entries Service Socket.546server # [ 35.703755] systemd[1]: Starting Create SUID/SGID Wrappers...547server # [ 35.710753] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met.548server # [ 35.745937] systemd[1]: Starting Save Transient machine-id to Disk...549server # [ 36.372316] systemd-journald[396]: Received client request to flush runtime journal.550server # [ 36.936002] systemd-udevd[425]: Using default interface naming scheme 'v258'.551server # [ 36.968244] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.552server # [ 36.984264] systemd[1]: Finished Save Transient machine-id to Disk.553server # [ 37.010858] systemd[1]: Finished Flush Journal to Persistent Storage.554server # [ 37.042733] systemd[1]: Starting Create System Files and Directories...555server # [ 39.026581] systemd[1]: Started Rule-based Manager for Device Events and Files.556server # [ 39.282555] systemd[1]: Finished Create System Files and Directories.557server # [ 39.373218] systemd[1]: Starting Rebuild Journal Catalog...558server # [ 39.430405] systemd[1]: Starting Record System Boot/Shutdown in UTMP...559server # [ 40.627884] systemd[1]: Finished Record System Boot/Shutdown in UTMP.560server # [ 41.827919] systemd[1]: Finished Rebuild Journal Catalog.561server # [ 41.859198] systemd[1]: Starting Update is Completed...562server # [ 42.609661] systemd[1]: Finished Update is Completed.563server # [ 46.362024] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.564server # [ 46.371713] systemd[1]: Finished Create SUID/SGID Wrappers.565server # [ 46.377852] systemd[1]: suid-sgid-wrappers.service: Consumed 2.881s CPU time, 5.6M memory peak.566server # [ 48.598090] systemd[1]: Finished Firewall.567server # [ 50.151906] systemd[1]: Finished Coldplug All udev Devices.568server # [ 50.173081] systemd[1]: Reached target System Initialization.569server # [ 50.174316] systemd[1]: Started Discard unused filesystem blocks once a week.570server # [ 50.175590] systemd[1]: Started Daily Cleanup of Temporary Directories.571server # [ 50.193210] systemd[1]: Reached target Timer Units.572server # [ 50.198505] systemd[1]: Listening on D-Bus System Message Bus Socket.573server # [ 50.205755] systemd[1]: Listening on Nix Daemon Socket.574server # [ 50.207628] systemd[1]: Listening on Hostname Service Socket.575server # [ 50.221032] systemd[1]: Reached target Socket Units.576server # [ 50.222932] systemd[1]: Reached target Basic System.577server # [ 50.229961] systemd[1]: Starting Import lastlog data into lastlog2 database...578server # [ 50.266145] systemd[1]: Starting Name Service Cache Daemon (nsncd)...579server # [ 50.314032] systemd[1]: Started Reset console on configuration changes.580server # [ 50.368768] systemd[1]: Starting resolvconf update...581server # [ 50.447435] systemd[1]: Starting D-Bus System Message Bus...582server # [ 51.494027] systemd[1]: Finished Import lastlog data into lastlog2 database.583server # [ 51.677779] systemd[1]: Started Name Service Cache Daemon (nsncd).584server # [ 51.683643] systemd[1]: Reached target Host and Network Name Lookups.585server # [ 51.727257] nsncd[629]: Oct 20 16:55:35.025 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"586server # [ 51.731084] systemd[1]: Reached target User and Group Name Lookups.587server # [ 51.769849] systemd[1]: Starting User Login Management...588server # [ 51.853521] dbus-daemon[632]: dbus[632]: Unknown username "systemd-timesync" in message bus configuration file589server # [ 52.274897] systemd[1]: Started D-Bus System Message Bus.590server # [ 53.101435] systemd-logind[650]: New seat seat0.591server # [ 53.142115] systemd[1]: Started User Login Management.592server # [ 53.170133] systemd[1]: Starting linger-users.service...593server # [ 53.382820] systemd[1]: Stopped target Host and Network Name Lookups.594server # [ 53.419035] systemd[1]: Stopping Host and Network Name Lookups...595server # [ 53.426523] systemd[1]: Stopped target User and Group Name Lookups.596server # [ 53.437163] systemd[1]: Stopping User and Group Name Lookups...597server # [ 53.456919] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...598server # [ 53.484674] systemd[1]: nscd.service: Deactivated successfully.599server # [ 53.498005] systemd[1]: Stopped Name Service Cache Daemon (nsncd).600server # [ 53.636994] systemd[1]: Starting Name Service Cache Daemon (nsncd)...601server # [ 53.710098] systemd[1]: linger-users.service: Deactivated successfully.602server # [ 53.729905] systemd[1]: Finished linger-users.service.603server # [ 54.333384] nsncd[691]: Oct 20 16:55:37.689 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"604server # [ 54.367110] systemd[1]: Started Name Service Cache Daemon (nsncd).605server # [ 54.374720] systemd[1]: Reached target Host and Network Name Lookups.606server # [ 54.380934] systemd[1]: Reached target User and Group Name Lookups.607server # [ 54.673376] systemd[1]: Finished resolvconf update.608server # [ 54.681826] systemd[1]: Reached target Preparation for Network.609server # [ 54.729275] systemd[1]: Starting DHCP Client...610server # [ 55.899745] dhcpcd[740]: dhcpcd-10.2.4 starting611server # [ 56.015198] dhcpcd[744]: dev: loaded udev612server # [ 56.374889] 8021q: 802.1Q VLAN Support v1.8613server # [ 57.112348] cfg80211: Loading compiled-in X.509 certificates for regulatory database614server # [ 57.430526] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'615server # [ 57.436510] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'616server # [ 57.465159] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2617server # [ 57.472322] cfg80211: failed to load regulatory.db618server # [ 58.014734] systemd[1]: Found device /dev/hvc0.619server # [ 58.247761] 8021q: adding VLAN 0 to HW filter on device eth0620server # [ 58.203542] dhcpcd[744]: eth0: waiting for carrier621server # [ 58.211567] dhcpcd[744]: eth0: carrier acquired622server # [ 58.326341] dhcpcd[744]: DUID 00:01:00:01:32:6a:59:8d:52:54:00:12:34:56623server # [ 58.331648] dhcpcd[744]: eth0: IAID 00:12:34:56624server # [ 58.335687] dhcpcd[744]: eth0: adding address fe80::5054:ff:fe12:3456625server # [ 58.492794] systemd[1]: Found device /dev/ttyAMA0.626server # [ 58.513031] dhcpcd[744]: eth0: soliciting a DHCP lease627server # [ 58.535975] dhcpcd[744]: eth0: offered 10.0.2.15 from 10.0.2.2628server # [ 58.546492] systemd[1]: Started backdoor.service.629server # [ 58.567528] dhcpcd[744]: eth0: probing address 10.0.2.15/24630server: Guest root shell did not produce any data yet...631server: To debug, enter the VM and run 'systemctl status backdoor.service'.632server # connecting to host...633server: Guest shell says: b'Spawning backdoor root shell...\n'634server: connected to guest root shell635server: (connecting took 60.27 seconds)636server: (finished: waiting for the VM to finish booting, in 60.27 seconds)637server # [ 60.198300] dhcpcd[744]: eth0: soliciting an IPv6 router638server # [ 60.207104] dhcpcd[744]: eth0: Router Advertisement from fe80::2639server # [ 60.207803] dhcpcd[744]: eth0: adding address fec0::5054:ff:fe12:3456/64640server # [ 60.228951] dhcpcd[744]: eth0: adding route to fec0::/64641server # [ 60.230693] dhcpcd[744]: eth0: adding default route via fe80::2642server # [ 61.314912] (udev-worker)[794]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.643server # [ 61.332660] (udev-worker)[794]: Network interface NamePolicy= disabled on kernel command line.644server # [ 61.479626] (udev-worker)[799]: Network interface NamePolicy= disabled on kernel command line.645server # [ 62.286938] systemd[1]: Found device Virtio network device.646server # [ 62.307056] systemd[1]: Starting Address configuration of eth1...647server # [ 62.439842] dhcpcd[744]: eth0: IAID 00:12:34:56648server # [ 63.116522] 8021q: adding VLAN 0 to HW filter on device eth1649server # [ 63.219523] dhcpcd[744]: eth0: soliciting an IPv6 router650server # [ 63.275719] network-addresses-eth1-start[827]: adding address 192.168.1.1/24... done651server # [ 63.521131] network-addresses-eth1-start[827]: adding address 2001:db8:1::1/64... done652server # [ 63.827518] systemd[1]: Finished Address configuration of eth1.653server # [ 63.908984] systemd[1]: Starting Networking Setup...654server # [ 64.211876] dhcpcd[744]: eth0: leased 10.0.2.15 for 86400 seconds655server # [ 64.226953] dhcpcd[744]: eth0: adding route to 10.0.2.0/24656server # [ 64.242114] dhcpcd[744]: eth0: adding default route via 10.0.2.2657server # [ 65.378162] systemd-logind[650]: Watching system buttons on /dev/input/event0 (gpio-keys)658server # [ 66.866686] systemd[1]: Started DHCP Client.659server # [ 66.892256] dhcpcd[744]: eth0: rebinding lease of 10.0.2.15660server # [ 66.903768] dhcpcd[744]: eth0: leased 10.0.2.15 for 86400 seconds661server # [ 70.614729] systemd[1]: Finished Networking Setup.662server # [ 70.665287] systemd[1]: Reached target Network.663server # [ 70.699979] systemd[1]: Starting PostgreSQL Database Server...664server # [ 70.769859] systemd[1]: Starting Permit User Sessions...665server # [ 71.579744] systemd[1]: Finished Permit User Sessions.666server # [ 71.702162] systemd[1]: Started Getty on tty1.667server # [ 71.724883] systemd[1]: Reached target Login Prompts.668server # [ 72.302413] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1047]: Initializing database at /var/lib/postgresql/data669server # [ 74.114472] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: The files belonging to this database system will be owned by user "postgres".670server # [ 74.138010] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: This user must also own the server process.671server # [ 74.205330] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: The database cluster will be initialized with locale "en_US.UTF-8".672server # [ 74.207898] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: The default database encoding has accordingly been set to "UTF8".673server # [ 74.220291] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: The default text search configuration will be set to "english".674server # [ 74.230258] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: Data page checksums are enabled.675server # [ 74.243125] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: fixing permissions on existing directory /var/lib/postgresql/data ... ok676server # [ 74.258128] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: creating subdirectories ... ok677server # [ 74.270191] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: selecting dynamic shared memory implementation ... posix678server # [ 75.211330] mousedev: PS/2 mouse device common for all mice679server # [ 75.636874] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: selecting default max_connections ... 100680server # [ 76.516718] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: selecting default shared_buffers ... 128MB681server # [ 79.611499] systemd-logind[650]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)682server # [ 89.019618] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: selecting default time zone ... UTC683server # [ 89.070790] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: creating configuration files ... ok684server # [ 93.475055] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: running bootstrap script ... ok685server # [ 107.157893] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: performing post-bootstrap initialization ... ok686server # [ 109.722952] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: syncing data to disk ... ok687server # [ 109.731895] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: initdb: warning: enabling "trust" authentication for local connections688server # [ 109.751287] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: 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.689server # [ 109.754240] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: Success. You can now start the database server using:690server # [ 109.757050] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1048]: /nix/store/zkfh9k9lkmv1r8szq0yka3cksxypcga4-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start691server # [ 111.456986] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1047]: Validating PostgreSQL configuration...692server # [ 111.978023] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[1436]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault693server # [ 113.447695] postgres[1442]: 2026-10-20 16:56:36.824 UTC [1442] LOG: pgaudit extension initialized694server # [ 114.365232] postgres[1442]: 2026-10-20 16:56:37.745 UTC [1442] LOG: pgsodium primary server secret key loaded695server # [ 114.949445] postgres[1442]: 2026-10-20 16:56:38.326 UTC [1442] LOG: vault primary server secret key loaded696server # [ 115.593457] postgres[1442]: 2026-10-20 16:56:38.978 UTC [1442] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit697server # [ 115.637335] postgres[1442]: 2026-10-20 16:56:39.017 UTC [1442] LOG: listening on IPv4 address "0.0.0.0", port 5432698server # [ 115.649206] postgres[1442]: 2026-10-20 16:56:39.032 UTC [1442] LOG: listening on IPv6 address "::", port 5432699server # [ 115.671809] postgres[1442]: 2026-10-20 16:56:39.055 UTC [1442] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"700server # [ 115.803007] postgres[1487]: 2026-10-20 16:56:39.172 UTC [1487] LOG: database system was shut down at 2026-10-20 16:56:30 UTC701server # [ 116.157631] postgres[1442]: 2026-10-20 16:56:39.530 UTC [1442] LOG: database system is ready to accept connections702server # [ 116.197090] postgres[1494]: 2026-10-20 16:56:39.569 UTC [1494] FATAL: role "postgres" does not exist703server # [ 116.202005] systemd[1]: Started PostgreSQL Database Server.704server # [ 116.263592] systemd[1]: Starting Supabase Database Initialization...705server # [ 116.405280] postgres[1492]: 2026-10-20 16:56:39.757 UTC [1492] LOG: TimescaleDB background worker launcher connected to shared catalogs706server # [ 116.479622] postgres[1442]: 2026-10-20 16:56:39.864 UTC [1442] LOG: background worker "pg_net 0.20.4 worker" (PID 1494) exited with exit code 1707server # [ 116.658999] postgres[1495]: 2026-10-20 16:56:40.006 UTC [1495] LOG: pg_cron scheduler started708server # [ 116.747108] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Waiting for PostgreSQL to be ready...709server # [ 117.454273] postgres[1515]: ::1 2026-10-20 16:56:40.822 UTC [1515] root@root FATAL: role "root" does not exist710server # [ 117.510283] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: PostgreSQL is ready711server # [ 117.518652] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Creating postgres role...712server # [ 117.649826] postgres[1518]: 2026-10-20 16:56:41.005 UTC [1518] FATAL: role "postgres" does not exist713server # [ 117.749870] postgres[1442]: 2026-10-20 16:56:41.124 UTC [1442] LOG: background worker "pg_net 0.20.4 worker" (PID 1518) exited with exit code 1714server # [ 118.015288] postgres[1519]: ::1 2026-10-20 16:56:41.389 UTC [1519] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN;715server # [ 118.062838] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1517]: CREATE ROLE716server # [ 118.299392] postgres[1521]: ::1 2026-10-20 16:56:41.682 UTC [1521] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres;717server # [ 118.316185] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1520]: ALTER DATABASE718server # [ 118.382254] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql719server # [ 118.640531] postgres[1523]: ::1 2026-10-20 16:56:42.013 UTC [1523] postgres@postgres LOG: statement: create publication supabase_realtime;720server # [ 118.650394] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: CREATE PUBLICATION721server # [ 118.651945] postgres[1523]: ::1 2026-10-20 16:56:42.036 UTC [1523] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls;722server # [ 118.674902] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: ALTER ROLE723server # [ 118.675884] postgres[1523]: ::1 2026-10-20 16:56:42.061 UTC [1523] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication;724server # [ 118.685037] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: CREATE ROLE725server # [ 118.689172] postgres[1523]: ::1 2026-10-20 16:56:42.070 UTC [1523] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls;726server # [ 118.699720] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: CREATE ROLE727server # [ 118.701723] postgres[1523]: ::1 2026-10-20 16:56:42.087 UTC [1523] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin;728server # [ 118.717401] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: GRANT ROLE729server # [ 118.719498] postgres[1523]: ::1 2026-10-20 16:56:42.099 UTC [1523] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin;730server # [ 118.725226] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: GRANT731server # [ 118.726581] postgres[1523]: ::1 2026-10-20 16:56:42.112 UTC [1523] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls;732server # [ 118.736467] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: CREATE ROLE733server # [ 118.742492] postgres[1523]: ::1 2026-10-20 16:56:42.123 UTC [1523] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user;734server # [ 118.753130] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: GRANT ROLE735server # [ 118.761929] postgres[1523]: ::1 2026-10-20 16:56:42.144 UTC [1523] postgres@postgres LOG: statement: create schema if not exists extensions;736server # [ 118.779962] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: CREATE SCHEMA737server # [ 118.787028] postgres[1523]: ::1 2026-10-20 16:56:42.169 UTC [1523] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions;738server # [ 121.562271] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: CREATE EXTENSION739server # [ 121.583359] postgres[1523]: ::1 2026-10-20 16:56:44.939 UTC [1523] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions;740server # [ 122.412107] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: CREATE EXTENSION741server # [ 122.418685] postgres[1523]: ::1 2026-10-20 16:56:45.800 UTC [1523] postgres@postgres LOG: statement: create role anon nologin noinherit;742server # [ 122.425997] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: CREATE ROLE743server # [ 122.430132] postgres[1523]: ::1 2026-10-20 16:56:45.815 UTC [1523] postgres@postgres LOG: statement: create role authenticated nologin noinherit;744server # [ 122.439902] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: CREATE ROLE745server # [ 122.442953] postgres[1523]: ::1 2026-10-20 16:56:45.828 UTC [1523] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls;746server # [ 122.449696] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: CREATE ROLE747server # [ 122.451559] postgres[1523]: ::1 2026-10-20 16:56:45.836 UTC [1523] postgres@postgres LOG: statement: create user authenticator noinherit;748server # [ 122.462697] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: CREATE ROLE749server # [ 122.466666] postgres[1523]: ::1 2026-10-20 16:56:45.851 UTC [1523] postgres@postgres LOG: statement: grant anon to authenticator;750server # [ 122.475214] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: GRANT ROLE751server # [ 122.477892] postgres[1523]: ::1 2026-10-20 16:56:45.862 UTC [1523] postgres@postgres LOG: statement: grant authenticated to authenticator;752server # [ 122.490295] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: GRANT ROLE753server # [ 122.492819] postgres[1523]: ::1 2026-10-20 16:56:45.876 UTC [1523] postgres@postgres LOG: statement: grant service_role to authenticator;754server # [ 122.502171] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: GRANT ROLE755server # [ 122.506311] postgres[1523]: ::1 2026-10-20 16:56:45.890 UTC [1523] postgres@postgres LOG: statement: grant supabase_admin to authenticator;756server # [ 122.514289] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: GRANT ROLE757server # [ 122.516663] postgres[1523]: ::1 2026-10-20 16:56:45.902 UTC [1523] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role;758server # [ 122.534376] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: GRANT759server # [ 122.539784] postgres[1523]: ::1 2026-10-20 16:56:45.922 UTC [1523] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;760server # [ 122.603007] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: ALTER DEFAULT PRIVILEGES761server # [ 122.620105] postgres[1523]: ::1 2026-10-20 16:56:45.953 UTC [1523] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;762server # [ 122.632345] postgres[1523]: ::1 2026-10-20 16:56:45.982 UTC [1523] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;763server # [ 122.639503] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: ALTER DEFAULT PRIVILEGES764server # [ 122.640039] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: ALTER DEFAULT PRIVILEGES765server # [ 122.658849] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: GRANT766server # [ 122.665956] postgres[1523]: ::1 2026-10-20 16:56:46.000 UTC [1523] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role;767server # [ 122.667587] postgres[1523]: ::1 2026-10-20 16:56:46.020 UTC [1523] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions;768server # [ 122.669188] postgres[1523]: ::1 2026-10-20 16:56:46.046 UTC [1523] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all769server # [ 122.671552] postgres[1523]: on sequences to postgres, anon, authenticated, service_role;770server # [ 122.673323] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: ALTER ROLE771server # [ 122.677864] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: ALTER DEFAULT PRIVILEGES772server # [ 122.684844] postgres[1523]: ::1 2026-10-20 16:56:46.065 UTC [1523] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all773server # [ 122.687012] postgres[1523]: on tables to postgres, anon, authenticated, service_role;774server # [ 122.690596] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: ALTER DEFAULT PRIVILEGES775server # [ 122.691452] postgres[1523]: ::1 2026-10-20 16:56:46.077 UTC [1523] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all776server # [ 122.697580] postgres[1523]: on functions to postgres, anon, authenticated, service_role;777server # [ 122.700969] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: ALTER DEFAULT PRIVILEGES778server # [ 122.702111] postgres[1523]: ::1 2026-10-20 16:56:46.088 UTC [1523] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s';779server # [ 122.710983] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: ALTER ROLE780server # [ 122.712106] postgres[1523]: ::1 2026-10-20 16:56:46.098 UTC [1523] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s';781server # [ 122.726921] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1522]: ALTER ROLE782server # [ 122.783089] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql783server # [ 123.199221] postgres[1563]: ::1 2026-10-20 16:56:46.566 UTC [1563] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;784server # [ 123.267750] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE SCHEMA785server # [ 123.285462] postgres[1563]: ::1 2026-10-20 16:56:46.634 UTC [1563] postgres@postgres LOG: statement: CREATE TABLE auth.users (786server # [ 123.287479] postgres[1563]: instance_id uuid NULL,787server # [ 123.287885] postgres[1563]: id uuid NOT NULL UNIQUE,788server # [ 123.301034] postgres[1563]: aud varchar(255) NULL,789server # [ 123.302335] postgres[1563]: "role" varchar(255) NULL,790server # [ 123.305105] postgres[1563]: email varchar(255) NULL UNIQUE,791server # [ 123.307424] postgres[1563]: encrypted_password varchar(255) NULL,792server # [ 123.308060] postgres[1563]: confirmed_at timestamptz NULL,793server # [ 123.318636] postgres[1563]: invited_at timestamptz NULL,794server # [ 123.325660] postgres[1563]: confirmation_token varchar(255) NULL,795server # [ 123.326537] postgres[1563]: confirmation_sent_at timestamptz NULL,796server # [ 123.327189] postgres[1563]: recovery_token varchar(255) NULL,797server # [ 123.332809] postgres[1563]: recovery_sent_at timestamptz NULL,798server # [ 123.341298] postgres[1563]: email_change_token varchar(255) NULL,799server # [ 123.343912] postgres[1563]: email_change varchar(255) NULL,800server # [ 123.351825] postgres[1563]: email_change_sent_at timestamptz NULL,801server # [ 123.357902] postgres[1563]: last_sign_in_at timestamptz NULL,802server # [ 123.358950] postgres[1563]: raw_app_meta_data jsonb NULL,803server # [ 123.359544] postgres[1563]: raw_user_meta_data jsonb NULL,804server # [ 123.359859] postgres[1563]: is_super_admin bool NULL,805server # [ 123.367510] postgres[1563]: created_at timestamptz NULL,806server # [ 123.373862] postgres[1563]: updated_at timestamptz NULL,807server # [ 123.375143] postgres[1563]: CONSTRAINT users_pkey PRIMARY KEY (id)808server # [ 123.384940] postgres[1563]: );809server # [ 123.611788] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE TABLE810server # [ 123.641225] postgres[1563]: ::1 2026-10-20 16:56:47.013 UTC [1563] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);811server # [ 123.689599] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE INDEX812server # [ 123.695161] postgres[1563]: ::1 2026-10-20 16:56:47.080 UTC [1563] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);813server # [ 123.740701] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE INDEX814server # [ 123.742362] postgres[1563]: ::1 2026-10-20 16:56:47.127 UTC [1563] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';815server # [ 123.757331] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: COMMENT816server # [ 123.759891] postgres[1563]: ::1 2026-10-20 16:56:47.140 UTC [1563] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens (817server # [ 123.778719] postgres[1563]: instance_id uuid NULL,818server # [ 123.785736] postgres[1563]: id bigserial NOT NULL,819server # [ 123.786601] postgres[1563]: "token" varchar(255) NULL,820server # [ 123.786967] postgres[1563]: user_id varchar(255) NULL,821server # [ 123.795332] postgres[1563]: revoked bool NULL,822server # [ 123.807318] postgres[1563]: created_at timestamptz NULL,823server # [ 123.821076] postgres[1563]: updated_at timestamptz NULL,824server # [ 123.826213] postgres[1563]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)825server # [ 123.835568] postgres[1563]: );826server # [ 123.893298] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE TABLE827server # [ 123.894703] postgres[1563]: ::1 2026-10-20 16:56:47.278 UTC [1563] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);828server # [ 123.933891] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE INDEX829server # [ 123.935787] postgres[1563]: ::1 2026-10-20 16:56:47.314 UTC [1563] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id);830server # [ 123.958735] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE INDEX831server # [ 123.983410] postgres[1563]: ::1 2026-10-20 16:56:47.353 UTC [1563] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);832server # [ 124.021703] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE INDEX833server # [ 124.039589] postgres[1563]: ::1 2026-10-20 16:56:47.422 UTC [1563] postgres@postgres LOG: statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.';834server # [ 124.069108] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: COMMENT835server # [ 124.077610] postgres[1563]: ::1 2026-10-20 16:56:47.452 UTC [1563] postgres@postgres LOG: statement: CREATE TABLE auth.instances (836server # [ 124.078196] postgres[1563]: id uuid NOT NULL,837server # [ 124.078627] postgres[1563]: uuid uuid NULL,838server # [ 124.087871] postgres[1563]: raw_base_config text NULL,839server # [ 124.091351] postgres[1563]: created_at timestamptz NULL,840server # [ 124.101358] postgres[1563]: updated_at timestamptz NULL,841server # [ 124.102624] postgres[1563]: CONSTRAINT instances_pkey PRIMARY KEY (id)842server # [ 124.103789] postgres[1563]: );843server # [ 124.140391] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE TABLE844server # [ 124.145748] postgres[1563]: ::1 2026-10-20 16:56:47.524 UTC [1563] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';845server # [ 124.146756] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: COMMENT846server # [ 124.153733] postgres[1563]: ::1 2026-10-20 16:56:47.535 UTC [1563] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries (847server # [ 124.169819] postgres[1563]: instance_id uuid NULL,848server # [ 124.170503] postgres[1563]: id uuid NOT NULL,849server # [ 124.170774] postgres[1563]: payload json NULL,850server # [ 124.171015] postgres[1563]: created_at timestamptz NULL,851server # [ 124.171251] postgres[1563]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)852server # [ 124.171508] postgres[1563]: );853server # [ 124.219687] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE TABLE854server # [ 124.231468] postgres[1563]: ::1 2026-10-20 16:56:47.607 UTC [1563] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);855server # [ 124.262473] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE INDEX856server # [ 124.264154] postgres[1563]: ::1 2026-10-20 16:56:47.641 UTC [1563] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';857server # [ 124.266602] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: COMMENT858server # [ 124.268874] postgres[1563]: ::1 2026-10-20 16:56:47.654 UTC [1563] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations (859server # [ 124.270020] postgres[1563]: "version" varchar(255) NOT NULL,860server # [ 124.271171] postgres[1563]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")861server # [ 124.271556] postgres[1563]: );862server # [ 124.309426] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE TABLE863server # [ 124.310325] postgres[1563]: ::1 2026-10-20 16:56:47.696 UTC [1563] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';864server # [ 124.317530] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: COMMENT865server # [ 124.342579] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: INSERT 0 7866server # [ 124.344207] postgres[1563]: ::1 2026-10-20 16:56:47.728 UTC [1563] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$867server # [ 124.351778] postgres[1563]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;868server # [ 124.357520] postgres[1563]: $$ language sql stable;869server # [ 124.359409] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE FUNCTION870server # [ 124.361822] postgres[1563]: ::1 2026-10-20 16:56:47.747 UTC [1563] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$871server # [ 124.362566] postgres[1563]: select nullif(current_setting('request.jwt.claim.role', true), '')::text;872server # [ 124.363139] postgres[1563]: $$ language sql stable;873server # [ 124.377926] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE FUNCTION874server # [ 124.379403] postgres[1563]: ::1 2026-10-20 16:56:47.760 UTC [1563] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$875server # [ 124.380069] postgres[1563]: select nullif(current_setting('request.jwt.claim.email', true), '')::text;876server # [ 124.386854] postgres[1563]: $$ language sql stable;877server # [ 124.389588] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE FUNCTION878server # [ 124.391801] postgres[1563]: ::1 2026-10-20 16:56:47.777 UTC [1563] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;879server # [ 124.401085] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: GRANT880server # [ 124.405861] postgres[1563]: ::1 2026-10-20 16:56:47.789 UTC [1563] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;881server # [ 124.412055] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: CREATE ROLE882server # [ 124.417428] postgres[1563]: ::1 2026-10-20 16:56:47.800 UTC [1563] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;883server # [ 124.425506] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: GRANT884server # [ 124.426457] postgres[1563]: ::1 2026-10-20 16:56:47.809 UTC [1563] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;885server # [ 124.434253] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: GRANT886server # [ 124.441968] postgres[1563]: ::1 2026-10-20 16:56:47.820 UTC [1563] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;887server # [ 124.446025] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: GRANT888server # [ 124.449365] postgres[1563]: ::1 2026-10-20 16:56:47.834 UTC [1563] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth";889server # [ 124.455316] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: ALTER ROLE890server # [ 124.458914] postgres[1563]: ::1 2026-10-20 16:56:47.843 UTC [1563] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin;891server # [ 124.471845] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: ALTER TABLE892server # [ 124.474800] postgres[1563]: ::1 2026-10-20 16:56:47.857 UTC [1563] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;893server # [ 124.487879] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: ALTER TABLE894server # [ 124.489972] postgres[1563]: ::1 2026-10-20 16:56:47.872 UTC [1563] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;895server # [ 124.499828] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: ALTER TABLE896server # [ 124.507665] postgres[1563]: ::1 2026-10-20 16:56:47.889 UTC [1563] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;897server # [ 124.513171] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: ALTER TABLE898server # [ 124.517219] postgres[1563]: ::1 2026-10-20 16:56:47.901 UTC [1563] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;899server # [ 124.526807] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1558]: ALTER TABLE900server # [ 124.573364] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql901server # [ 124.797810] postgres[1580]: ::1 2026-10-20 16:56:48.176 UTC [1580] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;902server # [ 124.807142] postgres[1580]: ::1 2026-10-20 16:56:48.189 UTC [1580] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;903server # [ 124.826211] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1579]: CREATE SCHEMA904server # [ 124.826901] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1579]: CREATE ROLE905server # [ 124.831880] postgres[1580]: ::1 2026-10-20 16:56:48.199 UTC [1580] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage";906server # [ 124.835409] postgres[1580]: ::1 2026-10-20 16:56:48.208 UTC [1580] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;907server # [ 124.837351] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1579]: ALTER ROLE908server # [ 124.838490] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1579]: GRANT909server # [ 124.863317] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1579]: DO910server # [ 124.900884] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql911server # [ 125.170489] postgres[1582]: ::1 2026-10-20 16:56:48.548 UTC [1582] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;912server # [ 125.209600] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: ALTER ROLE913server # [ 125.217428] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: ALTER ROLE914server # [ 125.219044] postgres[1582]: ::1 2026-10-20 16:56:48.577 UTC [1582] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;915server # [ 125.225445] postgres[1582]: ::1 2026-10-20 16:56:48.591 UTC [1582] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()916server # [ 125.226510] postgres[1582]: RETURNS event_trigger917server # [ 125.226901] postgres[1582]: LANGUAGE plpgsql918server # [ 125.227181] postgres[1582]: AS $$919server # [ 125.227625] postgres[1582]: DECLARE920server # [ 125.227887] postgres[1582]: schema_is_cron bool;921server # [ 125.239439] postgres[1582]: BEGIN922server # [ 125.247922] postgres[1582]: schema_is_cron = (923server # [ 125.252192] postgres[1582]: SELECT n.nspname = 'cron'924server # [ 125.255875] postgres[1582]: FROM pg_event_trigger_ddl_commands() AS ev925server # [ 125.262653] postgres[1582]: LEFT JOIN pg_catalog.pg_namespace AS n926server # [ 125.265203] postgres[1582]: ON ev.objid = n.oid927server # [ 125.265879] postgres[1582]: );928server # [ 125.266321] postgres[1582]:929server # [ 125.266622] postgres[1582]: IF schema_is_cron930server # [ 125.267378] postgres[1582]: THEN931server # [ 125.268060] postgres[1582]: grant usage on schema cron to postgres with grant option;932server # [ 125.268738] postgres[1582]:933server # [ 125.269222] postgres[1582]: alter default privileges in schema cron grant all on tables to postgres with grant option;934server # [ 125.269714] postgres[1582]: alter default privileges in schema cron grant all on functions to postgres with grant option;935server # [ 125.270127] postgres[1582]: alter default privileges in schema cron grant all on sequences to postgres with grant option;936server # [ 125.270492] postgres[1582]:937server # [ 125.270726] postgres[1582]: alter default privileges for user supabase_admin in schema cron grant all938server # [ 125.285096] postgres[1582]: on sequences to postgres with grant option;939server # [ 125.286266] postgres[1582]: alter default privileges for user supabase_admin in schema cron grant all940server # [ 125.286707] postgres[1582]: on tables to postgres with grant option;941server # [ 125.287159] postgres[1582]: alter default privileges for user supabase_admin in schema cron grant all942server # [ 125.288322] postgres[1582]: on functions to postgres with grant option;943server # [ 125.290950] postgres[1582]:944server # [ 125.291691] postgres[1582]: grant all privileges on all tables in schema cron to postgres with grant option;945server # [ 125.298353] postgres[1582]:946server # [ 125.312397] postgres[1582]: END IF;947server # [ 125.318328] postgres[1582]:948server # [ 125.319515] postgres[1582]: END;949server # [ 125.320155] postgres[1582]: $$;950server # [ 125.328838] postgres[1582]: ::1 2026-10-20 16:56:48.651 UTC [1582] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')951server # [ 125.330034] postgres[1582]: EXECUTE PROCEDURE extensions.grant_pg_cron_access();952server # [ 125.331800] postgres[1582]: ::1 2026-10-20 16:56:48.696 UTC [1582] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';953server # [ 125.339288] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: CREATE FUNCTION954server # [ 125.340039] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: CREATE EVENT TRIGGER955server # [ 125.341667] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: COMMENT956server # [ 125.343890] postgres[1582]: ::1 2026-10-20 16:56:48.717 UTC [1582] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()957server # [ 125.351401] postgres[1582]: RETURNS event_trigger958server # [ 125.353878] postgres[1582]: LANGUAGE plpgsql959server # [ 125.354293] postgres[1582]: AS $$960server # [ 125.354557] postgres[1582]: BEGIN961server # [ 125.354786] postgres[1582]: IF EXISTS (962server # [ 125.355329] postgres[1582]: SELECT 1963server # [ 125.356250] postgres[1582]: FROM pg_event_trigger_ddl_commands() AS ev964server # [ 125.361913] postgres[1582]: JOIN pg_extension AS ext965server # [ 125.366194] postgres[1582]: ON ev.objid = ext.oid966server # [ 125.366879] postgres[1582]: WHERE ext.extname = 'pg_net'967server # [ 125.367662] postgres[1582]: )968server # [ 125.367950] postgres[1582]: THEN969server # [ 125.368702] postgres[1582]: IF NOT EXISTS (970server # [ 125.370483] postgres[1582]: SELECT 1971server # [ 125.370892] postgres[1582]: FROM pg_roles972server # [ 125.371644] postgres[1582]: WHERE rolname = 'supabase_functions_admin'973server # [ 125.374657] postgres[1582]: )974server # [ 125.383697] postgres[1582]: THEN975server # [ 125.385539] postgres[1582]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;976server # [ 125.386362] postgres[1582]: END IF;977server # [ 125.387558] postgres[1582]:978server # [ 125.391029] postgres[1582]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;979server # [ 125.399027] postgres[1582]:980server # [ 125.399633] postgres[1582]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;981server # [ 125.407414] postgres[1582]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;982server # [ 125.419472] postgres[1582]:983server # [ 125.422205] postgres[1582]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;984server # [ 125.423735] postgres[1582]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;985server # [ 125.428554] postgres[1582]:986server # [ 125.437427] postgres[1582]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;987server # [ 125.439812] postgres[1582]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;988server # [ 125.444515] postgres[1582]:989server # [ 125.450162] postgres[1582]: 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;990server # [ 125.451704] postgres[1582]: 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;991server # [ 125.452333] postgres[1582]: END IF;992server # [ 125.457311] postgres[1582]: END;993server # [ 125.467303] postgres[1582]: $$;994server # [ 125.472835] postgres[1582]: ::1 2026-10-20 16:56:48.775 UTC [1582] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';995server # [ 125.474973] postgres[1582]: ::1 2026-10-20 16:56:48.840 UTC [1582] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;996server # [ 125.487745] postgres[1582]: ::1 2026-10-20 16:56:48.857 UTC [1582] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user;997server # [ 125.494361] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: CREATE FUNCTION998server # [ 125.507918] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: COMMENT999server # [ 125.511910] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: DO1000server # [ 125.515520] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: CREATE ROLE1001server # [ 125.516649] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: GRANT1002server # [ 125.517825] postgres[1582]: ::1 2026-10-20 16:56:48.873 UTC [1582] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user;1003server # [ 125.518217] postgres[1582]: ::1 2026-10-20 16:56:48.890 UTC [1582] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;1004server # [ 125.519856] postgres[1582]: ::1 2026-10-20 16:56:48.902 UTC [1582] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;1005server # [ 125.522373] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: GRANT1006server # [ 125.522942] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: GRANT1007server # [ 125.545155] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: GRANT1008server # [ 125.548969] postgres[1582]: ::1 2026-10-20 16:56:48.933 UTC [1582] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;1009server # [ 125.562595] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: GRANT1010server # [ 125.566817] postgres[1582]: ::1 2026-10-20 16:56:48.952 UTC [1582] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;1011server # [ 125.587640] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: GRANT1012server # [ 125.598438] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: GRANT1013server # [ 125.605336] postgres[1582]: ::1 2026-10-20 16:56:48.975 UTC [1582] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;1014server # [ 125.606601] postgres[1582]: ::1 2026-10-20 16:56:48.980 UTC [1582] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;1015server # [ 125.635693] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: GRANT1016server # [ 125.641229] postgres[1582]: ::1 2026-10-20 16:56:49.025 UTC [1582] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;1017server # [ 125.695554] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: GRANT1018server # [ 125.707955] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1581]: DO1019server # [ 125.822320] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running pgbouncer auth schema...1020server # [ 126.285057] postgres[1597]: ::1 2026-10-20 16:56:49.660 UTC [1597] postgres@postgres LOG: statement: CREATE USER pgbouncer;1021server # [ 126.302935] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1594]: CREATE ROLE1022server # [ 126.307892] postgres[1597]: ::1 2026-10-20 16:56:49.684 UTC [1597] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;1023server # [ 126.309857] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1594]: REVOKE1024server # [ 126.310435] postgres[1597]: ::1 2026-10-20 16:56:49.696 UTC [1597] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;1025server # [ 126.405280] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1594]: CREATE SCHEMA1026server # [ 126.406294] postgres[1597]: ::1 2026-10-20 16:56:49.792 UTC [1597] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)1027server # [ 126.407406] postgres[1597]: RETURNS TABLE(username TEXT, password TEXT) AS1028server # [ 126.407833] postgres[1597]: $$1029server # [ 126.408099] postgres[1597]: BEGIN1030server # [ 126.414039] postgres[1597]: RAISE WARNING 'PgBouncer auth request: %', p_usename;1031server # [ 126.414790] postgres[1597]:1032server # [ 126.420926] postgres[1597]: RETURN QUERY1033server # [ 126.425117] postgres[1597]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow1034server # [ 126.426575] postgres[1597]: WHERE usename = p_usename;1035server # [ 126.427442] postgres[1597]: END;1036server # [ 126.433566] postgres[1597]: $$ LANGUAGE plpgsql1037server # [ 126.435910] postgres[1597]: SET search_path = ''1038server # [ 126.437715] postgres[1597]: SECURITY DEFINER;1039server # [ 126.445055] postgres[1597]: ::1 2026-10-20 16:56:49.818 UTC [1597] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;1040server # [ 126.447105] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1594]: CREATE FUNCTION1041server # [ 126.447670] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1594]: REVOKE1042server # [ 126.448649] postgres[1597]: ::1 2026-10-20 16:56:49.833 UTC [1597] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;1043server # [ 126.456709] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1594]: GRANT1044server # [ 126.516106] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running stat extension...1045server # [ 126.962822] postgres[1608]: ::1 2026-10-20 16:56:50.323 UTC [1608] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions;1046server # [ 126.994407] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1602]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping1047server # [ 127.019356] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1602]: CREATE SCHEMA1048server # [ 127.025083] postgres[1608]: ::1 2026-10-20 16:56:50.408 UTC [1608] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;1049server # [ 128.221932] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1602]: CREATE EXTENSION1050server # [ 128.291373] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql1051server # [ 128.517296] postgres[1616]: ::1 2026-10-20 16:56:51.894 UTC [1616] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres;1052server # [ 128.528020] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1615]: GRANT1053server # [ 128.534148] postgres[1616]: ::1 2026-10-20 16:56:51.916 UTC [1616] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres;1054server # [ 128.544599] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1615]: GRANT1055server # [ 128.546236] postgres[1616]: ::1 2026-10-20 16:56:51.932 UTC [1616] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres;1056server # [ 128.555079] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1615]: GRANT1057server # [ 128.556504] postgres[1616]: ::1 2026-10-20 16:56:51.942 UTC [1616] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;1058server # [ 128.569768] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1615]: GRANT1059server # [ 128.577085] postgres[1616]: ::1 2026-10-20 16:56:51.958 UTC [1616] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;1060server # [ 128.582787] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1615]: GRANT1061server # [ 128.586249] postgres[1616]: ::1 2026-10-20 16:56:51.970 UTC [1616] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;1062server # [ 128.593607] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1615]: GRANT1063server # [ 128.595044] postgres[1616]: ::1 2026-10-20 16:56:51.981 UTC [1616] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;1064server # [ 128.602103] postgres[1616]: ::1 2026-10-20 16:56:51.984 UTC [1616] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;1065server # [ 128.603696] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1615]: GRANT1066server # [ 128.610012] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1615]: GRANT1067server # [ 128.612547] postgres[1616]: ::1 2026-10-20 16:56:51.998 UTC [1616] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;1068server # [ 128.645096] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1615]: GRANT1069server # [ 128.672905] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1615]: DO1070server # [ 128.674802] postgres[1616]: ::1 2026-10-20 16:56:52.057 UTC [1616] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;1071server # [ 128.680906] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1615]: ALTER ROLE1072server # [ 128.720956] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql1073server # [ 129.058742] postgres[1618]: ::1 2026-10-20 16:56:52.430 UTC [1618] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1074server # [ 129.079546] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: GRANT1075server # [ 129.090272] postgres[1618]: ::1 2026-10-20 16:56:52.468 UTC [1618] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1076server # [ 129.109409] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: GRANT1077server # [ 129.117604] postgres[1618]: ::1 2026-10-20 16:56:52.500 UTC [1618] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1078server # [ 129.145928] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: GRANT1079server # [ 129.165382] postgres[1618]: ::1 2026-10-20 16:56:52.538 UTC [1618] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;1080server # [ 129.183442] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: ALTER TABLE1081server # [ 129.189689] postgres[1618]: ::1 2026-10-20 16:56:52.574 UTC [1618] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;1082server # [ 129.219911] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: ALTER TABLE1083server # [ 129.226342] postgres[1618]: ::1 2026-10-20 16:56:52.607 UTC [1618] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;1084server # [ 129.246401] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: ALTER TABLE1085server # [ 129.248057] postgres[1618]: ::1 2026-10-20 16:56:52.633 UTC [1618] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;1086server # [ 129.265267] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: ALTER TABLE1087server # [ 129.277527] postgres[1618]: ::1 2026-10-20 16:56:52.654 UTC [1618] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;1088server # [ 129.319759] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: ALTER TABLE1089server # [ 129.337680] postgres[1618]: ::1 2026-10-20 16:56:52.707 UTC [1618] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres;1090server # [ 129.352937] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: GRANT1091server # [ 129.356968] postgres[1618]: ::1 2026-10-20 16:56:52.731 UTC [1618] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;1092server # [ 129.381229] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: GRANT1093server # [ 129.382153] postgres[1618]: ::1 2026-10-20 16:56:52.763 UTC [1618] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;1094server # [ 129.398698] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: GRANT1095server # [ 129.402636] postgres[1618]: ::1 2026-10-20 16:56:52.778 UTC [1618] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;1096server # [ 129.413888] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: GRANT1097server # [ 129.421491] postgres[1618]: ::1 2026-10-20 16:56:52.801 UTC [1618] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user;1098server # [ 129.457762] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: ALTER DEFAULT PRIVILEGES1099server # [ 129.467561] postgres[1618]: ::1 2026-10-20 16:56:52.840 UTC [1618] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1100server # [ 129.469602] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: ALTER DEFAULT PRIVILEGES1101server # [ 129.470569] postgres[1618]: ::1 2026-10-20 16:56:52.854 UTC [1618] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user;1102server # [ 129.482372] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1617]: ALTER DEFAULT PRIVILEGES1103server # [ 129.593640] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql1104server # [ 130.119188] postgres[1636]: ::1 2026-10-20 16:56:53.498 UTC [1636] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime;1105server # [ 130.159065] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1633]: CREATE SCHEMA1106server # [ 130.188992] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql1107server # [ 130.622815] postgres[1646]: ::1 2026-10-20 16:56:54.002 UTC [1646] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres;1108server # [ 130.646408] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1641]: GRANT1109server # [ 130.648275] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1641]: GRANT1110server # [ 130.654396] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1641]: GRANT1111server # [ 130.656745] postgres[1646]: ::1 2026-10-20 16:56:54.023 UTC [1646] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;1112server # [ 130.657861] postgres[1646]: ::1 2026-10-20 16:56:54.030 UTC [1646] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;1113server # [ 130.658475] postgres[1646]: ::1 2026-10-20 16:56:54.032 UTC [1646] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;1114server # [ 130.659515] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1641]: GRANT1115server # [ 130.703594] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql1116server # [ 131.011370] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1647]: DO1117server # [ 131.019489] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1647]: DO1118server # [ 131.031032] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1647]: DO1119server # [ 131.074278] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql1120server # [ 131.387529] postgres[1652]: ::1 2026-10-20 16:56:54.770 UTC [1652] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user;1121server # [ 131.432842] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1649]: ALTER DEFAULT PRIVILEGES1122server # [ 131.434533] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1649]: ALTER DEFAULT PRIVILEGES1123server # [ 131.435691] postgres[1652]: ::1 2026-10-20 16:56:54.808 UTC [1652] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1124server # [ 131.441406] postgres[1652]: ::1 2026-10-20 16:56:54.827 UTC [1652] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user;1125server # [ 131.449658] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1649]: ALTER DEFAULT PRIVILEGES1126server # [ 131.507327] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql1127server # [ 131.914914] postgres[1656]: ::1 2026-10-20 16:56:55.286 UTC [1656] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';1128server # [ 131.947252] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1655]: ALTER ROLE1129server # [ 132.012043] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql1130server # [ 132.409768] postgres[1660]: ::1 2026-10-20 16:56:55.776 UTC [1660] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1131server # [ 132.415988] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1132server # [ 132.423350] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: DROP EVENT TRIGGER1133server # [ 132.424902] postgres[1660]: ::1 2026-10-20 16:56:55.804 UTC [1660] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1134server # [ 132.427351] postgres[1660]: ::1 2026-10-20 16:56:55.813 UTC [1660] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1135server # [ 132.435111] postgres[1660]: DECLARE1136server # [ 132.436775] postgres[1660]: cmd record;1137server # [ 132.437884] postgres[1660]: BEGIN1138server # [ 132.439986] postgres[1660]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1139server # [ 132.441469] postgres[1660]: LOOP1140server # [ 132.442434] postgres[1660]: IF cmd.command_tag IN (1141server # [ 132.442756] postgres[1660]: 'CREATE SCHEMA', 'ALTER SCHEMA'1142server # [ 132.443025] postgres[1660]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1143server # [ 132.443615] postgres[1660]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1144server # [ 132.443926] postgres[1660]: , 'CREATE VIEW', 'ALTER VIEW'1145server # [ 132.449524] postgres[1660]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1146server # [ 132.451405] postgres[1660]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1147server # [ 132.456893] postgres[1660]: , 'CREATE TRIGGER'1148server # [ 132.457664] postgres[1660]: , 'CREATE TYPE'1149server # [ 132.461537] postgres[1660]: , 'CREATE RULE'1150server # [ 132.462508] postgres[1660]: , 'COMMENT'1151server # [ 132.463804] postgres[1660]: )1152server # [ 132.473480] postgres[1660]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1153server # [ 132.475529] postgres[1660]: AND cmd.schema_name is distinct from 'pg_temp'1154server # [ 132.478856] postgres[1660]: THEN1155server # [ 132.481275] postgres[1660]: NOTIFY pgrst, 'reload schema';1156server # [ 132.481743] postgres[1660]: END IF;1157server # [ 132.493843] postgres[1660]: END LOOP;1158server # [ 132.495888] postgres[1660]: END; $$ LANGUAGE plpgsql;1159server # [ 132.497778] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1160server # [ 132.499047] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: DROP FUNCTION1161server # [ 132.499502] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: CREATE FUNCTION1162server # [ 132.500128] postgres[1660]: ::1 2026-10-20 16:56:55.869 UTC [1660] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1163server # [ 132.500945] postgres[1660]: DECLARE1164server # [ 132.501496] postgres[1660]: obj record;1165server # [ 132.501902] postgres[1660]: BEGIN1166server # [ 132.502501] postgres[1660]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1167server # [ 132.503244] postgres[1660]: LOOP1168server # [ 132.504560] postgres[1660]: IF obj.object_type IN (1169server # [ 132.505401] postgres[1660]: 'schema'1170server # [ 132.506529] postgres[1660]: , 'table'1171server # [ 132.507048] postgres[1660]: , 'foreign table'1172server # [ 132.507603] postgres[1660]: , 'view'1173server # [ 132.507871] postgres[1660]: , 'materialized view'1174server # [ 132.508489] postgres[1660]: , 'function'1175server # [ 132.509070] postgres[1660]: , 'trigger'1176server # [ 132.509383] postgres[1660]: , 'type'1177server # [ 132.509926] postgres[1660]: , 'rule'1178server # [ 132.510176] postgres[1660]: )1179server # [ 132.510403] postgres[1660]: AND obj.is_temporary IS false -- no pg_temp objects1180server # [ 132.512320] postgres[1660]: THEN1181server # [ 132.513455] postgres[1660]: NOTIFY pgrst, 'reload schema';1182server # [ 132.514337] postgres[1660]: END IF;1183server # [ 132.514776] postgres[1660]: END LOOP;1184server # [ 132.515042] postgres[1660]: END; $$ LANGUAGE plpgsql;1185server # [ 132.515508] postgres[1660]: ::1 2026-10-20 16:56:55.889 UTC [1660] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1186server # [ 132.516119] postgres[1660]: ::1 2026-10-20 16:56:55.901 UTC [1660] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1187server # [ 132.517806] postgres[1660]: ON ddl_command_end1188server # [ 132.518623] postgres[1660]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1189server # [ 132.520115] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: CREATE FUNCTION1190server # [ 132.520980] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping1191server # [ 132.522126] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: DROP EVENT TRIGGER1192server # [ 132.537047] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: CREATE EVENT TRIGGER1193server # [ 132.538057] postgres[1660]: ::1 2026-10-20 16:56:55.923 UTC [1660] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1194server # [ 132.540945] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping1195server # [ 132.542412] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: DROP EVENT TRIGGER1196server # [ 132.550592] postgres[1660]: ::1 2026-10-20 16:56:55.932 UTC [1660] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1197server # [ 132.552970] postgres[1660]: ON sql_drop1198server # [ 132.554192] postgres[1660]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1199server # [ 132.556953] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1657]: CREATE EVENT TRIGGER1200server # [ 132.630085] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql1201server # [ 133.996097] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1668]: DO1202server # [ 134.031330] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql1203server # [ 134.410053] postgres[1686]: ::1 2026-10-20 16:56:57.785 UTC [1686] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public;1204server # [ 134.467943] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: CREATE SCHEMA1205server # [ 134.471279] postgres[1686]: ::1 2026-10-20 16:56:57.840 UTC [1686] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb);1206server # [ 134.474584] postgres[1686]: ::1 2026-10-20 16:56:57.852 UTC [1686] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1207server # [ 134.475607] postgres[1686]: "operationName" text default null,1208server # [ 134.478964] postgres[1686]: query text default null,1209server # [ 134.479592] postgres[1686]: variables jsonb default null,1210server # [ 134.479916] postgres[1686]: extensions jsonb default null1211server # [ 134.480577] postgres[1686]: )1212server # [ 134.482404] postgres[1686]: returns jsonb1213server # [ 134.482835] postgres[1686]: language plpgsql1214server # [ 134.484265] postgres[1686]: as $$1215server # [ 134.486131] postgres[1686]: DECLARE1216server # [ 134.487504] postgres[1686]: server_version float;1217server # [ 134.488093] postgres[1686]: BEGIN1218server # [ 134.490034] postgres[1686]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1219server # [ 134.490732] postgres[1686]:1220server # [ 134.491328] postgres[1686]: IF server_version >= 14 THEN1221server # [ 134.492277] postgres[1686]: RETURN jsonb_build_object(1222server # [ 134.494257] postgres[1686]: 'data', null::jsonb,1223server # [ 134.495343] postgres[1686]: 'errors', array['pg_graphql extension is not enabled.']1224server # [ 134.496814] postgres[1686]: );1225server # [ 134.498806] postgres[1686]: ELSE1226server # [ 134.499566] postgres[1686]: RETURN jsonb_build_object(1227server # [ 134.501518] postgres[1686]: 'data', null::jsonb,1228server # [ 134.502128] postgres[1686]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1229server # [ 134.502927] postgres[1686]: );1230server # [ 134.503828] postgres[1686]: END IF;1231server # [ 134.504162] postgres[1686]: END;1232server # [ 134.504396] postgres[1686]: $$;1233server # [ 134.507267] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping1234server # [ 134.514580] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: DROP FUNCTION1235server # [ 134.515091] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: CREATE FUNCTION1236server # [ 134.515860] postgres[1686]: ::1 2026-10-20 16:56:57.896 UTC [1686] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;1237server # [ 134.529169] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: GRANT1238server # [ 134.534132] postgres[1686]: ::1 2026-10-20 16:56:57.919 UTC [1686] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;1239server # [ 134.547832] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: ALTER DEFAULT PRIVILEGES1240server # [ 134.549696] postgres[1686]: ::1 2026-10-20 16:56:57.930 UTC [1686] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;1241server # [ 134.555739] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: ALTER DEFAULT PRIVILEGES1242server # [ 134.559185] postgres[1686]: ::1 2026-10-20 16:56:57.945 UTC [1686] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;1243server # [ 134.570790] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: ALTER DEFAULT PRIVILEGES1244server # [ 134.573409] postgres[1686]: ::1 2026-10-20 16:56:57.958 UTC [1686] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1245server # [ 134.576850] postgres[1686]: on sequences to postgres, anon, authenticated, service_role;1246server # [ 134.586431] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: ALTER DEFAULT PRIVILEGES1247server # [ 134.592984] postgres[1686]: ::1 2026-10-20 16:56:57.974 UTC [1686] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1248server # [ 134.595798] postgres[1686]: on tables to postgres, anon, authenticated, service_role;1249server # [ 134.599848] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: ALTER DEFAULT PRIVILEGES1250server # [ 134.605287] postgres[1686]: ::1 2026-10-20 16:56:57.987 UTC [1686] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1251server # [ 134.606425] postgres[1686]: on functions to postgres, anon, authenticated, service_role;1252server # [ 134.612253] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: ALTER DEFAULT PRIVILEGES1253server # [ 134.616747] postgres[1686]: ::1 2026-10-20 16:56:58.002 UTC [1686] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()1254server # [ 134.618545] postgres[1686]: RETURNS event_trigger1255server # [ 134.618915] postgres[1686]: LANGUAGE plpgsql1256server # [ 134.619813] postgres[1686]: AS $func$1257server # [ 134.627129] postgres[1686]: DECLARE1258server # [ 134.628748] postgres[1686]: func_is_graphql_resolve bool;1259server # [ 134.629881] postgres[1686]: BEGIN1260server # [ 134.630424] postgres[1686]: func_is_graphql_resolve = (1261server # [ 134.630809] postgres[1686]: SELECT n.proname = 'resolve'1262server # [ 134.631107] postgres[1686]: FROM pg_event_trigger_ddl_commands() AS ev1263server # [ 134.631463] postgres[1686]: LEFT JOIN pg_catalog.pg_proc AS n1264server # [ 134.632225] postgres[1686]: ON ev.objid = n.oid1265server # [ 134.633175] postgres[1686]: );1266server # [ 134.633801] postgres[1686]:1267server # [ 134.634693] postgres[1686]: IF func_is_graphql_resolve1268server # [ 134.635502] postgres[1686]: THEN1269server # [ 134.635832] postgres[1686]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1270server # [ 134.638441] postgres[1686]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1271server # [ 134.639291] postgres[1686]:1272server # [ 134.639687] postgres[1686]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1273server # [ 134.641074] postgres[1686]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1274server # [ 134.642064] postgres[1686]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1275server # [ 134.642673] postgres[1686]:1276server # [ 134.642961] postgres[1686]: DROP FUNCTION IF EXISTS graphql_public.graphql;1277server # [ 134.643626] postgres[1686]: create or replace function graphql_public.graphql(1278server # [ 134.647800] postgres[1686]: "operationName" text default null,1279server # [ 134.651116] postgres[1686]: query text default null,1280server # [ 134.652017] postgres[1686]: variables jsonb default null,1281server # [ 134.652959] postgres[1686]: extensions jsonb default null1282server # [ 134.658586] postgres[1686]: )1283server # [ 134.659605] postgres[1686]: returns jsonb1284server # [ 134.663930] postgres[1686]: language sql1285server # [ 134.666477] postgres[1686]: as $$1286server # [ 134.673368] postgres[1686]: SELECT graphql.resolve(query, coalesce(variables, '{}'));1287server # [ 134.674347] postgres[1686]: $$;1288server # [ 134.674748] postgres[1686]:1289server # [ 134.675365] postgres[1686]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1290server # [ 134.675738] postgres[1686]: END IF;1291server # [ 134.676077] postgres[1686]:1292server # [ 134.679427] postgres[1686]: END;1293server # [ 134.684126] postgres[1686]: $func$;1294server # [ 134.690784] postgres[1686]: ::1 2026-10-20 16:56:58.032 UTC [1686] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;1295server # [ 134.691867] postgres[1686]: ::1 2026-10-20 16:56:58.041 UTC [1686] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')1296server # [ 134.698294] postgres[1686]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access();1297server # [ 134.699354] postgres[1686]: ::1 2026-10-20 16:56:58.056 UTC [1686] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';1298server # [ 134.700563] postgres[1686]: ::1 2026-10-20 16:56:58.073 UTC [1686] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1299server # [ 134.704762] postgres[1686]: RETURNS event_trigger1300server # [ 134.705919] postgres[1686]: LANGUAGE plpgsql1301server # [ 134.706461] postgres[1686]: AS $func$1302server # [ 134.707279] postgres[1686]: DECLARE1303server # [ 134.712993] postgres[1686]: graphql_is_dropped bool;1304server # [ 134.714469] postgres[1686]: BEGIN1305server # [ 134.714996] postgres[1686]: graphql_is_dropped = (1306server # [ 134.715705] postgres[1686]: SELECT ev.schema_name = 'graphql_public'1307server # [ 134.721081] postgres[1686]: FROM pg_event_trigger_dropped_objects() AS ev1308server # [ 134.721858] postgres[1686]: WHERE ev.schema_name = 'graphql_public'1309server # [ 134.723566] postgres[1686]: );1310server # [ 134.726741] postgres[1686]:1311server # [ 134.727378] postgres[1686]: IF graphql_is_dropped1312server # [ 134.729318] postgres[1686]: THEN1313server # [ 134.730003] postgres[1686]: create or replace function graphql_public.graphql(1314server # [ 134.731455] postgres[1686]: "operationName" text default null,1315server # [ 134.733212] postgres[1686]: query text default null,1316server # [ 134.733653] postgres[1686]: variables jsonb default null,1317server # [ 134.735107] postgres[1686]: extensions jsonb default null1318server # [ 134.736916] postgres[1686]: )1319server # [ 134.738074] postgres[1686]: returns jsonb1320server # [ 134.738695] postgres[1686]: language plpgsql1321server # [ 134.739878] postgres[1686]: as $$1322server # [ 134.741839] postgres[1686]: DECLARE1323server # [ 134.743194] postgres[1686]: server_version float;1324server # [ 134.743678] postgres[1686]: BEGIN1325server # [ 134.745149] postgres[1686]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1326server # [ 134.745959] postgres[1686]:1327server # [ 134.747034] postgres[1686]: IF server_version >= 14 THEN1328server # [ 134.747883] postgres[1686]: RETURN jsonb_build_object(1329server # [ 134.757065] postgres[1686]: 'data', null::jsonb,1330server # [ 134.758073] postgres[1686]: 'errors', array['pg_graphql extension is not enabled.']1331server # [ 134.758952] postgres[1686]: );1332server # [ 134.759944] postgres[1686]: ELSE1333server # [ 134.763197] postgres[1686]: RETURN jsonb_build_object(1334server # [ 134.766319] postgres[1686]: 'data', null::jsonb,1335server # [ 134.766752] postgres[1686]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1336server # [ 134.767265] postgres[1686]: );1337server # [ 134.767636] postgres[1686]: END IF;1338server # [ 134.772902] postgres[1686]: END;1339server # [ 134.773863] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: CREATE FUNCTION1340server # [ 134.774729] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping1341server # [ 134.775461] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: DROP EVENT TRIGGER1342server # [ 134.775939] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: CREATE EVENT TRIGGER1343server # [ 134.779025] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: COMMENT1344server # [ 134.782741] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: CREATE FUNCTION1345server # [ 134.783527] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping1346server # [ 134.796304] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: DROP EVENT TRIGGER1347server # [ 134.807885] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: CREATE EVENT TRIGGER1348server # [ 134.813231] postgres[1686]: $$;1349server # [ 134.813782] postgres[1686]: END IF;1350server # [ 134.814075] postgres[1686]:1351server # [ 134.814613] postgres[1686]: END;1352server # [ 134.815903] postgres[1686]: $func$;1353server # [ 134.816258] postgres[1686]: ::1 2026-10-20 16:56:58.136 UTC [1686] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;1354server # [ 134.821415] postgres[1686]: ::1 2026-10-20 16:56:58.140 UTC [1686] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')1355server # [ 134.823870] postgres[1686]: EXECUTE PROCEDURE extensions.set_graphql_placeholder();1356server # [ 134.828149] postgres[1686]: ::1 2026-10-20 16:56:58.155 UTC [1686] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';1357server # [ 134.830899] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1685]: COMMENT1358server # [ 134.842072] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql1359server # [ 135.099643] postgres[1688]: ::1 2026-10-20 16:56:58.468 UTC [1688] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1360server # [ 135.110526] postgres[1688]: ::1 2026-10-20 16:56:58.476 UTC [1688] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1361server # [ 135.111934] postgres[1688]: ::1 2026-10-20 16:56:58.494 UTC [1688] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1362server # [ 135.112363] postgres[1688]: DECLARE1363server # [ 135.123684] postgres[1688]: cmd record;1364server # [ 135.129606] postgres[1688]: BEGIN1365server # [ 135.130295] postgres[1688]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1366server # [ 135.131104] postgres[1688]: LOOP1367server # [ 135.131571] postgres[1688]: IF cmd.command_tag IN (1368server # [ 135.131891] postgres[1688]: 'CREATE SCHEMA', 'ALTER SCHEMA'1369server # [ 135.146409] postgres[1688]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1370server # [ 135.154703] postgres[1688]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1371server # [ 135.159630] postgres[1688]: , 'CREATE VIEW', 'ALTER VIEW'1372server # [ 135.162917] postgres[1688]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1373server # [ 135.163536] postgres[1688]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1374server # [ 135.164032] postgres[1688]: , 'CREATE TRIGGER'1375server # [ 135.164298] postgres[1688]: , 'CREATE TYPE', 'ALTER TYPE'1376server # [ 135.165457] postgres[1688]: , 'CREATE RULE'1377server # [ 135.170437] postgres[1688]: , 'COMMENT'1378server # [ 135.174111] postgres[1688]: )1379server # [ 135.175237] postgres[1688]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1380server # [ 135.177613] postgres[1688]: AND cmd.schema_name is distinct from 'pg_temp'1381server # [ 135.179072] postgres[1688]: THEN1382server # [ 135.179887] postgres[1688]: NOTIFY pgrst, 'reload schema';1383server # [ 135.181479] postgres[1688]: END IF;1384server # [ 135.181914] postgres[1688]: END LOOP;1385server # [ 135.182176] postgres[1688]: END; $$ LANGUAGE plpgsql;1386server # [ 135.190161] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1687]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1387server # [ 135.191425] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1687]: DROP EVENT TRIGGER1388server # [ 135.191964] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1687]: 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, skipping1389server # [ 135.194176] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1687]: DROP FUNCTION1390server # [ 135.195250] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1687]: CREATE FUNCTION1391server # [ 135.196073] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1687]: CREATE FUNCTION1392server # [ 135.197017] postgres[1688]: ::1 2026-10-20 16:56:58.544 UTC [1688] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1393server # [ 135.198559] postgres[1688]: DECLARE1394server # [ 135.198992] postgres[1688]: obj record;1395server # [ 135.199276] postgres[1688]: BEGIN1396server # [ 135.199737] postgres[1688]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1397server # [ 135.201146] postgres[1688]: LOOP1398server # [ 135.201465] postgres[1688]: IF obj.object_type IN (1399server # [ 135.201706] postgres[1688]: 'schema'1400server # [ 135.201925] postgres[1688]: , 'table'1401server # [ 135.202151] postgres[1688]: , 'foreign table'1402server # [ 135.202382] postgres[1688]: , 'view'1403server # [ 135.202584] postgres[1688]: , 'materialized view'1404server # [ 135.203483] postgres[1688]: , 'function'1405server # [ 135.203734] postgres[1688]: , 'trigger'1406server # [ 135.203970] postgres[1688]: , 'type'1407server # [ 135.205678] postgres[1688]: , 'rule'1408server # [ 135.206224] postgres[1688]: )1409server # [ 135.207765] postgres[1688]: AND obj.is_temporary IS false -- no pg_temp objects1410server # [ 135.208183] postgres[1688]: THEN1411server # [ 135.208987] postgres[1688]: NOTIFY pgrst, 'reload schema';1412server # [ 135.210501] postgres[1688]: END IF;1413server # [ 135.211047] postgres[1688]: END LOOP;1414server # [ 135.211911] postgres[1688]: END; $$ LANGUAGE plpgsql;1415server # [ 135.212223] postgres[1688]: ::1 2026-10-20 16:56:58.570 UTC [1688] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1416server # [ 135.217664] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1687]: DROP EVENT TRIGGER1417server # [ 135.219197] postgres[1688]: ::1 2026-10-20 16:56:58.604 UTC [1688] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1418server # [ 135.223288] postgres[1688]: ON ddl_command_end1419server # [ 135.225371] postgres[1688]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1420server # [ 135.229263] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1687]: CREATE EVENT TRIGGER1421server # [ 135.233599] postgres[1688]: ::1 2026-10-20 16:56:58.618 UTC [1688] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1422server # [ 135.240291] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1687]: DROP EVENT TRIGGER1423server # [ 135.241937] postgres[1688]: ::1 2026-10-20 16:56:58.627 UTC [1688] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1424server # [ 135.242371] postgres[1688]: ON sql_drop1425server # [ 135.243097] postgres[1688]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1426server # [ 135.251232] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1687]: CREATE EVENT TRIGGER1427server # [ 135.298321] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql1428server # [ 135.785927] postgres[1698]: ::1 2026-10-20 16:56:59.168 UTC [1698] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;1429server # [ 135.844124] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1689]: ALTER ROLE1430server # [ 135.901470] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql1431server # [ 136.395597] postgres[1710]: ::1 2026-10-20 16:56:59.766 UTC [1710] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1432server # [ 136.405850] postgres[1710]: returns event_trigger1433server # [ 136.406413] postgres[1710]: language plpgsql1434server # [ 136.406733] postgres[1710]: AS $func$1435server # [ 136.406991] postgres[1710]: DECLARE1436server # [ 136.407245] postgres[1710]: func_is_graphql_resolve bool;1437server # [ 136.407480] postgres[1710]: BEGIN1438server # [ 136.414173] postgres[1710]: func_is_graphql_resolve = (1439server # [ 136.416925] postgres[1710]: SELECT n.proname = 'resolve'1440server # [ 136.417470] postgres[1710]: FROM pg_event_trigger_ddl_commands() AS ev1441server # [ 136.418330] postgres[1710]: LEFT JOIN pg_catalog.pg_proc AS n1442server # [ 136.418788] postgres[1710]: ON ev.objid = n.oid1443server # [ 136.419443] postgres[1710]: );1444server # [ 136.419866] postgres[1710]:1445server # [ 136.420123] postgres[1710]: IF func_is_graphql_resolve1446server # [ 136.425924] postgres[1710]: THEN1447server # [ 136.426657] postgres[1710]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1448server # [ 136.427450] postgres[1710]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1449server # [ 136.427923] postgres[1710]:1450server # [ 136.433453] postgres[1710]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1451server # [ 136.434994] postgres[1710]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1452server # [ 136.436132] postgres[1710]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1453server # [ 136.442991] postgres[1710]:1454server # [ 136.447759] postgres[1710]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1455server # [ 136.452311] postgres[1710]: DROP FUNCTION IF EXISTS graphql_public.graphql;1456server # [ 136.454009] postgres[1710]: create or replace function graphql_public.graphql(1457server # [ 136.454474] postgres[1710]: "operationName" text default null,1458server # [ 136.454946] postgres[1710]: query text default null,1459server # [ 136.455412] postgres[1710]: variables jsonb default null,1460server # [ 136.456105] postgres[1710]: extensions jsonb default null1461server # [ 136.461056] postgres[1710]: )1462server # [ 136.461625] postgres[1710]: returns jsonb1463server # [ 136.461922] postgres[1710]: language sql1464server # [ 136.462183] postgres[1710]: as $$1465server # [ 136.462534] postgres[1710]: -- This changed1466server # [ 136.463222] postgres[1710]: select graphql.resolve(1467server # [ 136.463501] postgres[1710]: query := query,1468server # [ 136.464000] postgres[1710]: variables := coalesce(variables, '{}'),1469server # [ 136.471802] postgres[1710]: "operationName" := "operationName",1470server # [ 136.474453] postgres[1710]: extensions := extensions1471server # [ 136.477179] postgres[1710]: );1472server # [ 136.478378] postgres[1710]: $$;1473server # [ 136.479126] postgres[1710]:1474server # [ 136.479411] postgres[1710]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1475server # [ 136.480095] postgres[1710]: END IF;1476server # [ 136.480520] postgres[1710]:1477server # [ 136.486715] postgres[1710]: END;1478server # [ 136.487225] postgres[1710]: $func$;1479server # [ 136.515728] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1703]: CREATE FUNCTION1480server # [ 136.521094] postgres[1710]: ::1 2026-10-20 16:56:59.900 UTC [1710] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1481server # [ 136.522470] postgres[1710]: RETURNS event_trigger1482server # [ 136.523376] postgres[1710]: LANGUAGE plpgsql1483server # [ 136.524101] postgres[1710]: AS $func$1484server # [ 136.530363] postgres[1710]: DECLARE1485server # [ 136.530917] postgres[1710]: graphql_is_dropped bool;1486server # [ 136.531237] postgres[1710]: BEGIN1487server # [ 136.531479] postgres[1710]: graphql_is_dropped = (1488server # [ 136.531721] postgres[1710]: SELECT ev.schema_name = 'graphql_public'1489server # [ 136.531982] postgres[1710]: FROM pg_event_trigger_dropped_objects() AS ev1490server # [ 136.537412] postgres[1710]: WHERE ev.schema_name = 'graphql_public'1491server # [ 136.539014] postgres[1710]: );1492server # [ 136.539824] postgres[1710]:1493server # [ 136.541083] postgres[1710]: IF graphql_is_dropped1494server # [ 136.541999] postgres[1710]: THEN1495server # [ 136.543533] postgres[1710]: create or replace function graphql_public.graphql(1496server # [ 136.553187] postgres[1710]: "operationName" text default null,1497server # [ 136.554459] postgres[1710]: query text default null,1498server # [ 136.554831] postgres[1710]: variables jsonb default null,1499server # [ 136.555115] postgres[1710]: extensions jsonb default null1500server # [ 136.555646] postgres[1710]: )1501server # [ 136.555911] postgres[1710]: returns jsonb1502server # [ 136.556145] postgres[1710]: language plpgsql1503server # [ 136.556394] postgres[1710]: as $$1504server # [ 136.561858] postgres[1710]: DECLARE1505server # [ 136.562537] postgres[1710]: server_version float;1506server # [ 136.562856] postgres[1710]: BEGIN1507server # [ 136.563098] postgres[1710]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1508server # [ 136.563705] postgres[1710]:1509server # [ 136.563981] postgres[1710]: IF server_version >= 14 THEN1510server # [ 136.564253] postgres[1710]: RETURN jsonb_build_object(1511server # [ 136.573917] postgres[1710]: 'errors', jsonb_build_array(1512server # [ 136.574615] postgres[1710]: jsonb_build_object(1513server # [ 136.574949] postgres[1710]: 'message', 'pg_graphql extension is not enabled.'1514server # [ 136.575250] postgres[1710]: )1515server # [ 136.575506] postgres[1710]: )1516server # [ 136.575859] postgres[1710]: );1517server # [ 136.576084] postgres[1710]: ELSE1518server # [ 136.577073] postgres[1710]: RETURN jsonb_build_object(1519server # [ 136.577393] postgres[1710]: 'errors', jsonb_build_array(1520server # [ 136.577966] postgres[1710]: jsonb_build_object(1521server # [ 136.578662] postgres[1710]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1522server # [ 136.579361] postgres[1710]: )1523server # [ 136.580178] postgres[1710]: )1524server # [ 136.582904] postgres[1710]: );1525server # [ 136.583336] postgres[1710]: END IF;1526server # [ 136.583762] postgres[1710]: END;1527server # [ 136.584076] postgres[1710]: $$;1528server # [ 136.590353] postgres[1710]: END IF;1529server # [ 136.597115] postgres[1710]:1530server # [ 136.598257] postgres[1710]: END;1531server # [ 136.599069] postgres[1710]: $func$;1532server # [ 136.600004] postgres[1710]: ::1 2026-10-20 16:56:59.936 UTC [1710] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1533server # [ 136.600509] postgres[1710]: "operationName" text default null,1534server # [ 136.605799] postgres[1710]: query text default null,1535server # [ 136.606578] postgres[1710]: variables jsonb default null,1536server # [ 136.607097] postgres[1710]: extensions jsonb default null1537server # [ 136.607384] postgres[1710]: )1538server # [ 136.609287] postgres[1710]: returns jsonb1539server # [ 136.610374] postgres[1710]: language plpgsql1540server # [ 136.611669] postgres[1710]: as $$1541server # [ 136.618283] postgres[1710]: DECLARE1542server # [ 136.625026] postgres[1710]: server_version float;1543server # [ 136.625923] postgres[1710]: BEGIN1544server # [ 136.626643] postgres[1710]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1545server # [ 136.633963] postgres[1710]:1546server # [ 136.635775] postgres[1710]: IF server_version >= 14 THEN1547server # [ 136.638119] postgres[1710]: RETURN jsonb_build_object(1548server # [ 136.639533] postgres[1710]: 'errors', jsonb_build_array(1549server # [ 136.647709] postgres[1710]: jsonb_build_object(1550server # [ 136.648904] postgres[1710]: 'message', 'pg_graphql extension is not enabled.'1551server # [ 136.650837] postgres[1710]: )1552server # [ 136.651911] postgres[1710]: )1553server # [ 136.658527] postgres[1710]: );1554server # [ 136.666308] postgres[1710]: ELSE1555server # [ 136.671313] postgres[1710]: RETURN jsonb_build_object(1556server # [ 136.677604] postgres[1710]: 'errors', jsonb_build_array(1557server # [ 136.678616] postgres[1710]: jsonb_build_object(1558server # [ 136.685373] postgres[1710]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1559server # [ 136.686723] postgres[1710]: )1560server # [ 136.693597] postgres[1710]: )1561server # [ 136.695023] postgres[1710]: );1562server # [ 136.697046] postgres[1710]: END IF;1563server # [ 136.699151] postgres[1710]: END;1564server # [ 136.699602] postgres[1710]: $$;1565server # [ 136.701449] postgres[1710]: ::1 2026-10-20 16:56:59.964 UTC [1710] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1566server # [ 136.703384] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1703]: CREATE FUNCTION1567server # [ 136.703993] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1703]: CREATE FUNCTION1568server # [ 136.709854] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1703]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping1569server # [ 136.711408] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1703]: DROP EXTENSION1570server # [ 138.270674] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1703]: DO1571server # [ 138.331780] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql1572server # [ 138.681003] postgres[1722]: ::1 2026-10-20 16:57:02.040 UTC [1722] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres;1573server # [ 138.713446] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1721]: GRANT ROLE1574server # [ 138.742345] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql1575server # [ 139.184925] postgres[1731]: ::1 2026-10-20 16:57:02.541 UTC [1731] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1576server # [ 139.205377] postgres[1731]: returns event_trigger1577server # [ 139.206757] postgres[1731]: language plpgsql1578server # [ 139.207374] postgres[1731]: AS $func$1579server # [ 139.212751] postgres[1731]: DECLARE1580server # [ 139.214905] postgres[1731]: func_is_graphql_resolve bool;1581server # [ 139.215689] postgres[1731]: BEGIN1582server # [ 139.215998] postgres[1731]: func_is_graphql_resolve = (1583server # [ 139.225844] postgres[1731]: SELECT n.proname = 'resolve'1584server # [ 139.226769] postgres[1731]: FROM pg_event_trigger_ddl_commands() AS ev1585server # [ 139.233535] postgres[1731]: LEFT JOIN pg_catalog.pg_proc AS n1586server # [ 139.234154] postgres[1731]: ON ev.objid = n.oid1587server # [ 139.234441] postgres[1731]: );1588server # [ 139.234681] postgres[1731]:1589server # [ 139.234916] postgres[1731]: IF func_is_graphql_resolve1590server # [ 139.235138] postgres[1731]: THEN1591server # [ 139.235848] postgres[1731]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1592server # [ 139.242358] postgres[1731]: DROP FUNCTION IF EXISTS graphql_public.graphql;1593server # [ 139.243097] postgres[1731]: create or replace function graphql_public.graphql(1594server # [ 139.243831] postgres[1731]: "operationName" text default null,1595server # [ 139.250217] postgres[1731]: query text default null,1596server # [ 139.256124] postgres[1731]: variables jsonb default null,1597server # [ 139.259164] postgres[1731]: extensions jsonb default null1598server # [ 139.269609] postgres[1731]: )1599server # [ 139.272308] postgres[1731]: returns jsonb1600server # [ 139.277295] postgres[1731]: language sql1601server # [ 139.278212] postgres[1731]: as $$1602server # [ 139.279375] postgres[1731]: select graphql.resolve(1603server # [ 139.289433] postgres[1731]: query := query,1604server # [ 139.290643] postgres[1731]: variables := coalesce(variables, '{}'),1605server # [ 139.291144] postgres[1731]: "operationName" := "operationName",1606server # [ 139.291590] postgres[1731]: extensions := extensions1607server # [ 139.292234] postgres[1731]: );1608server # [ 139.293514] postgres[1731]: $$;1609server # [ 139.295152] postgres[1731]:1610server # [ 139.297312] postgres[1731]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1611server # [ 139.298536] postgres[1731]: -- function in the extension so we need to grant permissions on existing entities AND1612server # [ 139.299133] postgres[1731]: -- update default permissions to any others that are created after `graphql.resolve`1613server # [ 139.299783] postgres[1731]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1614server # [ 139.300330] postgres[1731]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1615server # [ 139.305653] postgres[1731]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1616server # [ 139.306741] postgres[1731]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1617server # [ 139.307526] postgres[1731]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1618server # [ 139.317758] postgres[1731]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1619server # [ 139.318479] postgres[1731]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1620server # [ 139.318886] postgres[1731]: END IF;1621server # [ 139.319131] postgres[1731]:1622server # [ 139.319364] postgres[1731]: END;1623server # [ 139.326547] postgres[1731]: $func$;1624server # [ 139.337706] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1725]: CREATE FUNCTION1625server # [ 139.345975] postgres[1731]: ::1 2026-10-20 16:57:02.717 UTC [1731] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1626server # [ 139.521276] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1725]: DROP EXTENSION1627server # [ 141.057708] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1725]: DO1628server # [ 141.090669] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql1629server # [ 142.218108] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1749]: DO1630server # [ 143.032117] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1749]: DO1631server # [ 143.095018] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql1632server # [ 143.462129] postgres[1776]: ::1 2026-10-20 16:57:06.837 UTC [1776] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s';1633server # [ 143.479249] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1773]: ALTER ROLE1634server # [ 143.507723] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql1635server # [ 143.846629] postgres[1778]: ::1 2026-10-20 16:57:07.222 UTC [1778] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator;1636server # [ 143.870559] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1777]: REVOKE ROLE1637server # [ 143.941520] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql1638server # [ 146.593713] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1782]: DO1639server # [ 146.631902] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql1640server # [ 146.899280] postgres[1810]: ::1 2026-10-20 16:57:10.277 UTC [1810] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres;1641server # [ 146.923454] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1809]: GRANT ROLE1642server # [ 146.951518] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql1643server # [ 147.213707] postgres[1812]: ::1 2026-10-20 16:57:10.588 UTC [1812] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option;1644server # [ 147.242885] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1811]: GRANT1645server # [ 147.248663] postgres[1812]: ::1 2026-10-20 16:57:10.632 UTC [1812] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option;1646server # [ 147.273051] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1811]: GRANT1647server # [ 147.273864] postgres[1812]: ::1 2026-10-20 16:57:10.656 UTC [1812] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option;1648server # [ 147.277873] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1811]: GRANT1649server # [ 147.281060] postgres[1812]: ::1 2026-10-20 16:57:10.666 UTC [1812] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;1650server # [ 147.292055] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1811]: ALTER DEFAULT PRIVILEGES1651server # [ 147.297627] postgres[1812]: ::1 2026-10-20 16:57:10.680 UTC [1812] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;1652server # [ 147.307974] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1811]: ALTER DEFAULT PRIVILEGES1653server # [ 147.309701] postgres[1812]: ::1 2026-10-20 16:57:10.690 UTC [1812] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;1654server # [ 147.315324] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1811]: ALTER DEFAULT PRIVILEGES1655server # [ 147.360061] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql1656server # [ 147.746067] postgres[1817]: ::1 2026-10-20 16:57:11.122 UTC [1817] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres;1657server # [ 147.769461] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1813]: GRANT ROLE1658server # [ 147.838512] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql1659server # [ 148.308009] postgres[1824]: ::1 2026-10-20 16:57:11.681 UTC [1824] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin;1660server # [ 148.334753] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1819]: GRANT ROLE1661server # [ 148.386773] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql1662server # [ 148.811610] postgres[1833]: ::1 2026-10-20 16:57:12.194 UTC [1833] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit;1663server # [ 148.839068] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1828]: ALTER ROLE1664server # [ 148.845267] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1828]: ALTER ROLE1665server # [ 148.853184] postgres[1833]: ::1 2026-10-20 16:57:12.212 UTC [1833] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit;1666server # [ 148.855300] postgres[1833]: ::1 2026-10-20 16:57:12.225 UTC [1833] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit;1667server # [ 148.858330] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1828]: ALTER ROLE1668server # [ 148.894787] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1828]: DO1669server # [ 148.944277] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql1670server # [ 149.331469] postgres[1844]: ::1 2026-10-20 16:57:12.710 UTC [1844] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin;1671server # [ 149.351927] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1838]: GRANT ROLE1672server # [ 149.363310] postgres[1844]: ::1 2026-10-20 16:57:12.740 UTC [1844] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin;1673server # [ 149.381155] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1838]: REVOKE ROLE1674server # [ 149.407538] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql1675server # [ 149.798060] postgres[1849]: ::1 2026-10-20 16:57:13.166 UTC [1849] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1676server # [ 149.800251] postgres[1849]: returns event_trigger1677server # [ 149.808659] postgres[1849]: language plpgsql1678server # [ 149.819062] postgres[1849]: AS $func$1679server # [ 149.825932] postgres[1849]: DECLARE1680server # [ 149.827667] postgres[1849]: func_is_graphql_resolve bool;1681server # [ 149.834265] postgres[1849]: BEGIN1682server # [ 149.835858] postgres[1849]: func_is_graphql_resolve = (1683server # [ 149.842366] postgres[1849]: SELECT n.proname = 'resolve'1684server # [ 149.842992] postgres[1849]: FROM pg_event_trigger_ddl_commands() AS ev1685server # [ 149.843562] postgres[1849]: LEFT JOIN pg_catalog.pg_proc AS n1686server # [ 149.850674] postgres[1849]: ON ev.objid = n.oid1687server # [ 149.857716] postgres[1849]: );1688server # [ 149.860212] postgres[1849]:1689server # [ 149.861847] postgres[1849]: IF func_is_graphql_resolve1690server # [ 149.862943] postgres[1849]: THEN1691server # [ 149.863478] postgres[1849]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1692server # [ 149.865143] postgres[1849]: DROP FUNCTION IF EXISTS graphql_public.graphql;1693server # [ 149.865972] postgres[1849]: create or replace function graphql_public.graphql(1694server # [ 149.867818] postgres[1849]: "operationName" text default null,1695server # [ 149.869183] postgres[1849]: query text default null,1696server # [ 149.869824] postgres[1849]: variables jsonb default null,1697server # [ 149.871817] postgres[1849]: extensions jsonb default null1698server # [ 149.874142] postgres[1849]: )1699server # [ 149.881445] postgres[1849]: returns jsonb1700server # [ 149.882190] postgres[1849]: language sql1701server # [ 149.883107] postgres[1849]: as $$1702server # [ 149.883460] postgres[1849]: select graphql.resolve(1703server # [ 149.883831] postgres[1849]: query := query,1704server # [ 149.887874] postgres[1849]: variables := coalesce(variables, '{}'),1705server # [ 149.894087] postgres[1849]: "operationName" := "operationName",1706server # [ 149.895216] postgres[1849]: extensions := extensions1707server # [ 149.896153] postgres[1849]: );1708server # [ 149.905037] postgres[1849]: $$;1709server # [ 149.905753] postgres[1849]:1710server # [ 149.906393] postgres[1849]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1711server # [ 149.907577] postgres[1849]: -- function in the extension so we need to grant permissions on existing entities AND1712server # [ 149.914160] postgres[1849]: -- update default permissions to any others that are created after `graphql.resolve`1713server # [ 149.924801] postgres[1849]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1714server # [ 149.926935] postgres[1849]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1715server # [ 149.929924] postgres[1849]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1716server # [ 149.932761] postgres[1849]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1717server # [ 149.934590] postgres[1849]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1718server # [ 149.936007] postgres[1849]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1719server # [ 149.940608] postgres[1849]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1720server # [ 149.949314] postgres[1849]:1721server # [ 149.953926] postgres[1849]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles1722server # [ 149.960108] postgres[1849]: grant usage on schema graphql_public to postgres with grant option;1723server # [ 149.963033] postgres[1849]: grant usage on schema graphql to postgres with grant option;1724server # [ 149.966619] postgres[1849]: END IF;1725server # [ 149.972223] postgres[1849]:1726server # [ 149.982659] postgres[1849]: END;1727server # [ 149.990180] postgres[1849]: $func$;1728server # [ 149.991695] postgres[1849]: ::1 2026-10-20 16:57:13.333 UTC [1849] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1729server # [ 150.016611] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1845]: CREATE FUNCTION1730server # [ 150.093697] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1845]: DROP EXTENSION1731server # [ 152.096710] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1845]: DO1732server # [ 152.140060] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql1733server # [ 152.547692] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1868]: DO1734server # [ 152.594078] postgres[1871]: ::1 2026-10-20 16:57:15.918 UTC [1871] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger1735server # [ 152.605933] postgres[1871]: LANGUAGE plpgsql1736server # [ 152.607071] postgres[1871]: AS $$1737server # [ 152.608110] postgres[1871]: BEGIN1738server # [ 152.614950] postgres[1871]: IF EXISTS (1739server # [ 152.616179] postgres[1871]: SELECT1740server # [ 152.622097] postgres[1871]: FROM pg_event_trigger_ddl_commands() AS ev1741server # [ 152.623984] postgres[1871]: JOIN pg_extension AS ext1742server # [ 152.637168] postgres[1871]: ON ev.objid = ext.oid1743server # [ 152.638237] postgres[1871]: WHERE ext.extname = 'pg_cron'1744server # [ 152.645379] postgres[1871]: )1745server # [ 152.646092] postgres[1871]: THEN1746server # [ 152.647137] postgres[1871]: grant usage on schema cron to postgres with grant option;1747server # [ 152.649605] postgres[1871]:1748server # [ 152.650056] postgres[1871]: alter default privileges in schema cron grant all on tables to postgres with grant option;1749server # [ 152.650364] postgres[1871]: alter default privileges in schema cron grant all on functions to postgres with grant option;1750server # [ 152.651931] postgres[1871]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1751server # [ 152.653124] postgres[1871]:1752server # [ 152.654115] postgres[1871]: alter default privileges for user supabase_admin in schema cron grant all1753server # [ 152.655370] postgres[1871]: on sequences to postgres with grant option;1754server # [ 152.658599] postgres[1871]: alter default privileges for user supabase_admin in schema cron grant all1755server # [ 152.662261] postgres[1871]: on tables to postgres with grant option;1756server # [ 152.663000] postgres[1871]: alter default privileges for user supabase_admin in schema cron grant all1757server # [ 152.663862] postgres[1871]: on functions to postgres with grant option;1758server # [ 152.664214] postgres[1871]:1759server # [ 152.666314] postgres[1871]: grant all privileges on all tables in schema cron to postgres with grant option;1760server # [ 152.667114] postgres[1871]: revoke all on table cron.job from postgres;1761server # [ 152.668974] postgres[1871]: grant select on table cron.job to postgres with grant option;1762server # [ 152.671977] postgres[1871]: END IF;1763server # [ 152.674180] postgres[1871]: END;1764server # [ 152.674478] postgres[1871]: $$;1765server # [ 152.717563] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1868]: CREATE FUNCTION1766server # [ 152.718529] postgres[1871]: ::1 2026-10-20 16:57:16.101 UTC [1871] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access;1767server # [ 152.739904] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1868]: DROP EVENT TRIGGER1768server # [ 152.742692] postgres[1871]: ::1 2026-10-20 16:57:16.126 UTC [1871] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;1769server # [ 152.767785] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1868]: ALTER FUNCTION1770server # [ 152.773052] postgres[1871]: ::1 2026-10-20 16:57:16.158 UTC [1871] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end1771server # [ 152.774501] postgres[1871]: WHEN TAG IN ('CREATE EXTENSION')1772server # [ 152.775993] postgres[1871]: EXECUTE FUNCTION extensions.grant_pg_cron_access();1773server # [ 152.801633] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1868]: CREATE EVENT TRIGGER1774server # [ 152.843317] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql1775server # [ 153.139333] postgres[1878]: ::1 2026-10-20 16:57:16.522 UTC [1878] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s';1776server # [ 153.175644] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1877]: ALTER ROLE1777server # [ 153.221248] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql1778server # [ 153.466742] postgres[1880]: ::1 2026-10-20 16:57:16.847 UTC [1880] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin;1779server # [ 153.522120] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1879]: ALTER FUNCTION1780server # [ 153.523253] postgres[1880]: ::1 2026-10-20 16:57:16.897 UTC [1880] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;1781server # [ 153.538478] postgres[1880]: ::1 2026-10-20 16:57:16.913 UTC [1880] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;1782server # [ 153.539521] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1879]: ALTER FUNCTION1783server # [ 153.546339] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1879]: ALTER FUNCTION1784server # [ 153.602539] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql1785server # [ 153.975255] postgres[1886]: ::1 2026-10-20 16:57:17.358 UTC [1886] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres;1786server # [ 154.002578] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1884]: GRANT ROLE1787server # [ 154.059865] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql1788server # [ 155.223329] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1887]: DO1789server # [ 155.283794] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql1790server # [ 155.843267] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1901]: DO1791server # [ 155.855475] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1901]: DO1792server # [ 155.908289] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql1793server # [ 156.418306] postgres[1916]: ::1 2026-10-20 16:57:19.788 UTC [1916] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none;1794server # [ 156.445925] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1915]: ALTER ROLE1795server # [ 156.447864] postgres[1916]: ::1 2026-10-20 16:57:19.816 UTC [1916] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none;1796server # [ 156.458214] postgres[1916]: ::1 2026-10-20 16:57:19.827 UTC [1916] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none;1797server # [ 156.476052] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1915]: ALTER ROLE1798server # [ 156.491482] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1915]: ALTER ROLE1799server # [ 156.514140] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql1800server # [ 156.783106] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1917]: DO1801server # [ 156.828753] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql1802server # [ 157.118127] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1919]: DO1803server # [ 157.128972] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql1804server # [ 157.547369] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1921]: CREATE FUNCTION1805server # [ 157.562473] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1921]: DO1806server # [ 157.662603] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql1807server # [ 158.134772] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1927]: ALTER FUNCTION1808server # [ 158.148808] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1927]: GRANT1809server # [ 158.206158] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql1810server # [ 158.659854] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1935]: DROP EVENT TRIGGER1811server # [ 158.719597] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1935]: ALTER FUNCTION1812server # [ 158.761144] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1935]: CREATE EVENT TRIGGER1813server # [ 158.849137] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql1814server # [ 159.159251] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1948]: DO1815server # [ 159.190720] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql1816server # [ 159.646207] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1953]: CREATE FUNCTION1817server # [ 159.663897] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1953]: GRANT1818server # [ 159.705410] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql1819server # [ 160.079121] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1959]: REVOKE ROLE1820server # [ 160.154433] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1959]: DO1821server # [ 160.167822] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1959]: DO1822server # [ 160.178755] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1959]: REVOKE ROLE1823server # [ 160.190958] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1959]: REVOKE1824server # [ 160.214868] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1959]: DO1825server # [ 160.267503] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql1826server # [ 160.513962] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1961]: DO1827server # [ 160.543997] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql1828server # [ 160.858423] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1963]: DO1829server # [ 160.890753] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql1830server # [ 161.513989] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1965]: DO1831server # [ 161.542505] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql1832server # [ 161.925817] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1981]: ALTER ROLE1833server # [ 161.966445] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql1834server # [ 162.325483] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1990]: GRANT ROLE1835server # [ 162.343241] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1990]: DO1836server # [ 162.382776] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql1837server # [ 162.665571] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1995]: GRANT1838server # [ 162.685982] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql1839server # [ 162.965321] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1997]: CREATE FUNCTION1840server # [ 162.973274] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1997]: REVOKE1841server # [ 162.985674] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1997]: REVOKE1842server # [ 162.997219] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1997]: GRANT1843server # [ 163.037271] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql1844server # [ 163.526848] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1999]: DO1845server # [ 163.534430] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql1846server # [ 164.002584] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2005]: ALTER ROLE1847server # [ 164.059086] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql1848server # [ 164.627447] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2014]: DROP EXTENSION1849server # [ 164.672312] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql1850server # [ 165.032062] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2028]: CREATE FUNCTION1851server # [ 165.045724] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2028]: DROP EVENT TRIGGER1852server # [ 165.059676] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2028]: CREATE EVENT TRIGGER1853server # [ 165.160907] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql1854server # [ 165.568362] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2033]: DO1855server # [ 165.621410] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2033]: CREATE FUNCTION1856server # [ 165.688148] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql1857server # [ 166.067168] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2037]: CREATE FUNCTION1858server # [ 166.078567] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2037]: CREATE FUNCTION1859server # [ 166.121662] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql1860server # [ 166.388887] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2039]: CREATE FUNCTION1861server # [ 166.399890] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2039]: CREATE FUNCTION1862server # [ 166.417147] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2039]: CREATE FUNCTION1863server # [ 166.433797] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2039]: CREATE FUNCTION1864server # [ 166.444824] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2039]: CREATE FUNCTION1865server # [ 166.456276] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2039]: CREATE FUNCTION1866server # [ 166.514473] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Running postgresql schema...1867server # [ 166.814045] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER DATABASE1868server # [ 166.815168] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER DATABASE1869server # [ 166.965668] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER ROLE1870server # [ 167.074420] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER ROLE1871server # [ 167.231067] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER ROLE1872server # [ 167.347373] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER ROLE1873server # [ 167.447467] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER ROLE1874server # [ 167.544116] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER ROLE1875server # [ 167.645145] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER ROLE1876server # [ 167.832125] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER ROLE1877server # [ 167.976077] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER ROLE1878server # [ 167.991485] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[2041]: ALTER ROLE1879server # [ 168.086051] gvqawhp9i0m97yq8vqndswgd8cq9jawd-supabase-db-init[1498]: Database initialization complete1880server # [ 168.154459] systemd[1]: Finished Supabase Database Initialization.1881server # [ 168.165171] systemd[1]: Reached target Multi-User System.1882server # [ 168.171726] systemd[1]: Startup finished in 19.649s (kernel) + 2min 28.517s (userspace) = 2min 48.167s.1883server: (finished: waiting for unit supabase-db-init.service, in 170.81 seconds)1884subtest: Preconditions1885server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select rolsuper from pg_roles where rolname = 'postgres'"1886server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select rolsuper from pg_roles where rolname = 'postgres'", in 0.76 seconds)1887server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select current_user"1888server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select current_user", in 0.53 seconds)1889(finished: subtest: Preconditions, in 1.30 seconds)1890subtest: A non-superuser installs amcheck on PG 15, pinned to pg_catalog1891server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension amcheck"1892server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension amcheck", in 1.33 seconds)1893server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'"1894server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'", in 0.68 seconds)1895PG 15 amcheck: 1.3,pg_catalog1896(finished: subtest: A non-superuser installs amcheck on PG 15, pinned to pg_catalog, in 2.01 seconds)1897subtest: PG 15 grants reach postgres only1898server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname"1899server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname", in 0.84 seconds)1900(finished: subtest: PG 15 grants reach postgres only, in 0.84 seconds)1901subtest: amcheck dropped before upgrade, mirroring EXTENSIONS_TO_DISABLE1902server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "drop extension if exists amcheck cascade"1903server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "drop extension if exists amcheck cascade", in 0.57 seconds)1904(finished: subtest: amcheck dropped before upgrade, mirroring EXTENSIONS_TO_DISABLE, in 0.57 seconds)1905subtest: switch to postgresql 171906server # Checking switch inhibitors... done1907server # stopping the following units: postgresql.service, supabase-db-init.service1908server # [ 183.385334] nixos[2140]: switching to system configuration /nix/store/yh0by73fiaw16qx96jj4qkkdzj47758g-nixos-system-server-test1909server # [ 183.415512] systemd[1]: Stopped target Local File Systems.1910server # [ 183.442981] systemd[1]: supabase-db-init.service: Deactivated successfully.1911server # [ 183.446517] systemd[1]: Stopped Supabase Database Initialization.1912server # [ 183.449092] systemd[1]: supabase-db-init.service: Consumed 7.984s CPU time, 3.5M memory peak, 88.8K incoming IP traffic, 131.3K outgoing IP traffic.1913server # [ 183.483460] systemd[1]: Stopped target Remote File Systems.1914server # [ 183.508711] postgres[1442]: 2026-10-20 16:57:46.884 UTC [1442] LOG: received fast shutdown request1915server # [ 183.514083] systemd[1]: Stopping PostgreSQL Database Server...1916server # [ 183.525766] postgres[1442]: 2026-10-20 16:57:46.908 UTC [1442] LOG: aborting any active transactions1917server # [ 183.560177] postgres[1492]: 2026-10-20 16:57:46.924 UTC [1492] FATAL: terminating background worker "TimescaleDB Background Worker Launcher" due to administrator command1918server # [ 183.575525] postgres[1495]: 2026-10-20 16:57:46.931 UTC [1495] LOG: pg_cron scheduler shutting down1919server # [ 183.707303] postgres[1442]: 2026-10-20 16:57:47.090 UTC [1442] LOG: background worker "pg_net 0.20.4 worker" (PID 1524) exited with exit code 11920server # [ 183.773572] postgres[1442]: 2026-10-20 16:57:47.159 UTC [1442] LOG: background worker "TimescaleDB Background Worker Launcher" (PID 1492) exited with exit code 11921server # [ 183.777306] postgres[1442]: 2026-10-20 16:57:47.162 UTC [1442] LOG: background worker "pg_cron launcher" (PID 1495) exited with exit code 11922server # [ 183.779282] postgres[1442]: 2026-10-20 16:57:47.162 UTC [1442] LOG: background worker "logical replication launcher" (PID 1496) exited with exit code 11923server # [ 183.791962] postgres[1485]: 2026-10-20 16:57:47.165 UTC [1485] LOG: shutting down1924server # [ 183.797892] postgres[1485]: 2026-10-20 16:57:47.183 UTC [1485] LOG: checkpoint starting: shutdown immediate1925server # [ 184.173085] postgres[1485]: 2026-10-20 16:57:47.558 UTC [1485] LOG: checkpoint complete: wrote 267 buffers (1.6%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.120 s, sync=0.197 s, total=0.393 s; sync files=136, longest=0.012 s, average=0.002 s; distance=1955 kB, estimate=1955 kB1926server # [ 184.326068] postgres[1442]: 2026-10-20 16:57:47.712 UTC [1442] LOG: database system is shut down1927server # [ 184.420795] systemd[1]: postgresql.service: Deactivated successfully.1928server # [ 184.423960] systemd[1]: Stopped PostgreSQL Database Server.1929server # [ 184.426107] systemd[1]: postgresql.service: Consumed 38.035s CPU time, 123.5M memory peak, 54.8M written to disk, 135.6K incoming IP traffic, 93.1K outgoing IP traffic.1930server # activating the configuration...1931server # [ 185.884371] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31932server # setting up /etc...1933server # [ 192.190646] systemd[1]: Reload requested from client PID 2140 ('.switch-to-conf') (unit backdoor.service)...1934server # [ 192.225313] systemd[1]: Reloading...1935server # [ 198.465558] systemd[1]: Reloading finished in 6248 ms.1936server # restarting sysinit-reactivation.target1937server # [ 198.880981] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....1938server # [ 200.440867] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..1939server # [ 200.468332] systemd[1]: Reached target Reactivate sysinit units.1940server # reloading the following units: dbus.service1941server # [ 200.529587] systemd[1]: Reloading D-Bus System Message Bus...1942server # [ 201.125088] dbus-daemon[632]: Unknown username "systemd-timesync" in message bus configuration file1943server # [ 201.377795] dbus-daemon[632]: [system] Reloaded configuration1944server # [ 201.384022] dbus-send[2339]: method return time=1792515484.766022 sender=org.freedesktop.DBus -> destination=:1.5 serial=3 reply_serial=21945server # [ 201.601436] dbus-daemon[632]: Unknown username "systemd-timesync" in message bus configuration file1946server # [ 201.862490] dbus-daemon[632]: [system] Reloaded configuration1947server # [ 201.881597] systemd[1]: Reloaded D-Bus System Message Bus.1948server # starting the following units: postgresql.service, supabase-db-init.service1949server # [ 202.055214] systemd[1]: Starting PostgreSQL Major Version Migration...1950server # [ 202.127760] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore).1951server # [ 202.194736] systemd[1]: Starting Create SUID/SGID Wrappers...1952server # [ 202.218881] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).1953server # [ 202.261159] systemd[1]: Reached target Local File Systems.1954server # [ 202.262927] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met.1955server # [ 202.278665] 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).1956server # [ 202.292089] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).1957server # [ 202.308888] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).1958server # [ 202.311953] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).1959server # [ 202.682345] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).1960server # [ 202.758141] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki).1961server # [ 202.814755] systemd[1]: Reached target Remote File Systems.1962server # [ 202.828239] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2361]: Starting pg_upgrade from 15 to 171963server # [ 204.555925] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: The files belonging to this database system will be owned by user "postgres".1964server # [ 204.559148] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: This user must also own the server process.1965server # [ 204.683467] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: The database cluster will be initialized with locale "en_US.UTF-8".1966server # [ 204.685267] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: The default database encoding has accordingly been set to "UTF8".1967server # [ 204.689873] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: The default text search configuration will be set to "english".1968server # [ 204.691113] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: Data page checksums are enabled.1969server # [ 204.692137] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: fixing permissions on existing directory /var/lib/postgresql/data-17 ... ok1970server # [ 204.710765] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: creating subdirectories ... ok1971server # [ 204.712989] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: selecting dynamic shared memory implementation ... posix1972server # [ 206.291735] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: selecting default "max_connections" ... 1001973server # [ 207.479990] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: selecting default "shared_buffers" ... 128MB1974server # [ 210.968457] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1975server # [ 210.979513] systemd[1]: Finished Create SUID/SGID Wrappers.1976server # [ 210.994115] systemd[1]: suid-sgid-wrappers.service: Consumed 3.321s CPU time, 3.2M memory peak.1977server # [ 211.046082] systemd[1]: Starting linger-users.service...1978server # [ 211.527489] systemd[1]: linger-users.service: Deactivated successfully.1979server # [ 211.553103] systemd[1]: Finished linger-users.service.1980server # [ 214.462663] systemd[1]: Starting Virtual Console Setup...1981server # [ 214.971421] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1982server # [ 214.991176] systemd[1]: Stopped Virtual Console Setup.1983server # [ 215.170936] systemd[1]: Starting Virtual Console Setup...1984server # [ 220.426278] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1985server # [ 220.490479] systemd[1]: Finished Virtual Console Setup.1986server # [ 220.683825] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: selecting default time zone ... UTC1987server # [ 220.711557] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: creating configuration files ... ok1988server # [ 224.649822] systemd-logind[650]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1989server # [ 224.741032] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: running bootstrap script ... ok1990server # [ 230.153867] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: performing post-bootstrap initialization ... ok1991server # [ 231.623519] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: syncing data to disk ... ok1992server # [ 231.625768] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: initdb: warning: enabling "trust" authentication for local connections1993server # [ 231.629416] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: 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.1994server # [ 231.633759] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: Success. You can now start the database server using:1995server # [ 231.635563] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2365]: /nix/store/nck0frhhbpmlgfbsyzzr2r2j5v80fv7v-postgresql-and-plugins-17.11/bin/pg_ctl -D /var/lib/postgresql/data-17 -l logfile start1996server # [ 236.013715] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Performing Consistency Checks1997server # [ 236.090017] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: -----------------------------1998server # [ 236.115045] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking cluster versions ok1999server # [ 239.210892] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking database user is the install user ok2000server # [ 239.272874] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking database connection settings ok2001server # [ 239.357176] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking for prepared transactions ok2002server # [ 239.362695] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking for contrib/isn with bigint-passing mismatch ok2003server # [ 239.990829] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking data type usage ok2004server # [ 240.185961] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking for not-null constraint inconsistencies ok2005server # [ 240.838968] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Creating dump of global objects ok2006server # [ 243.242304] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Creating dump of database schemas ok2007server # [ 246.501151] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking for presence of required libraries ok2008server # [ 246.601082] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking database user is the install user ok2009server # [ 246.686765] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking for prepared transactions ok2010server # [ 246.690946] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking for new cluster tablespace directories ok2011server # [ 246.701331] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: If pg_upgrade fails after this point, you must re-initdb the2012server # [ 246.702788] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: new cluster before continuing.2013server # [ 246.703571] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Performing Upgrade2014server # [ 246.711709] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: ------------------2015server # [ 246.769575] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Setting locale and encoding for new cluster ok2016server # [ 248.982962] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Analyzing all rows in the new cluster ok2017server # [ 250.023104] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Freezing all rows in the new cluster ok2018server # [ 250.343802] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Deleting files from new pg_xact ok2019server # [ 250.489921] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Copying old pg_xact to new server ok2020server # [ 250.790818] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Setting oldest XID for new cluster ok2021server # [ 251.753601] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Setting next transaction ID and epoch for new cluster ok2022server # [ 251.757058] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Deleting files from new pg_multixact/offsets ok2023server # [ 251.901805] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Copying old pg_multixact/offsets to new server ok2024server # [ 251.905066] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Deleting files from new pg_multixact/members ok2025server # [ 252.050799] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Copying old pg_multixact/members to new server ok2026server # [ 252.362321] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Setting next multixact ID and offset for new cluster ok2027server # [ 252.643551] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Resetting WAL archives ok2028server # [ 254.747358] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Setting frozenxid and minmxid counters in new cluster ok2029server # [ 255.622023] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Restoring global objects in the new cluster ok2030server # [ 258.817054] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Restoring database schemas in the new cluster ok2031server # [ 259.642391] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Copying user relation files ok2032server # [ 259.956089] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Setting next OID for new cluster ok2033server # [ 261.680174] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Sync data directory to disk ok2034server # [ 261.683439] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Creating script to delete old cluster ok2035server # [ 265.493633] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Checking for extension updates notice2036server # [ 265.499693] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Your installation contains extensions that should be updated2037server # [ 265.503054] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: with the ALTER EXTENSION command. The file2038server # [ 265.506624] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: update_extensions.sql2039server # [ 265.509806] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: when executed by psql by the database superuser will update2040server # [ 265.511791] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: these extensions.2041server # [ 265.816986] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Upgrade Complete2042server # [ 265.819181] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: ----------------2043server # [ 265.819868] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Optimizer statistics are not transferred by pg_upgrade.2044server # [ 265.820595] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Once you start the new server, consider running:2045server # [ 265.822581] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: /nix/store/nck0frhhbpmlgfbsyzzr2r2j5v80fv7v-postgresql-and-plugins-17.11/bin/vacuumdb -U supabase_admin --all --analyze-in-stages2046server # [ 265.823500] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: Running this script will delete the old cluster's data files:2047server # [ 265.825836] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2575]: ./delete_old_cluster.sh2048server # [ 265.853120] cmamnbdfawllk1x2hmmpf5fncf6h5j7r-postgresql-migrate[2361]: pg_upgrade completed successfully2049server # [ 265.882138] systemd[1]: Finished PostgreSQL Major Version Migration.2050server # [ 265.916400] systemd[1]: Starting PostgreSQL Database Server...2051server # [ 267.074515] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[2741]: Validating PostgreSQL configuration...2052server # [ 267.343911] m0jggf34m1gnc72c2h1iyhlcjlgndqj1-postgresql-init[2753]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault2053server # [ 267.882439] postgres[2755]: 2026-10-20 16:59:11.259 UTC [2755] LOG: pgaudit extension initialized2054server # [ 268.134569] postgres[2755]: 2026-10-20 16:59:11.518 UTC [2755] LOG: pgsodium primary server secret key loaded2055server # [ 268.312936] postgres[2755]: 2026-10-20 16:59:11.698 UTC [2755] LOG: vault primary server secret key loaded2056server # [ 268.523841] postgres[2755]: 2026-10-20 16:59:11.909 UTC [2755] LOG: starting PostgreSQL 17.11 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit2057server # [ 268.533982] postgres[2755]: 2026-10-20 16:59:11.920 UTC [2755] LOG: listening on IPv4 address "0.0.0.0", port 54322058server # [ 268.536902] postgres[2755]: 2026-10-20 16:59:11.920 UTC [2755] LOG: listening on IPv6 address "::", port 54322059server # [ 268.550441] postgres[2755]: 2026-10-20 16:59:11.935 UTC [2755] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"2060server # [ 268.611962] postgres[2760]: 2026-10-20 16:59:11.994 UTC [2760] LOG: database system was shut down at 2026-10-20 16:59:09 UTC2061server # [ 268.708123] postgres[2755]: 2026-10-20 16:59:12.092 UTC [2755] LOG: database system is ready to accept connections2062server # [ 268.742531] systemd[1]: Started PostgreSQL Database Server.2063server # [ 268.790631] systemd[1]: Starting Supabase Database Initialization...2064server # [ 268.855631] postgres[2764]: 2026-10-20 16:59:12.228 UTC [2764] LOG: pg_cron scheduler started2065server # [ 268.989053] systemd[1]: Finished Supabase Database Initialization.2066server # the following new units were started: postgresql-migrate.service, sys-devices-platform-4010000000.pcie-pci0000:00-0000:00:0b.0-virtio9-virtio\x2dports-vport9p0.device, sys-devices-virtual-input-mice.device, sys-devices-virtual-misc-rfkill.device, sys-devices-virtual-misc-tun.device, sys-devices-virtual-mtd-mtd0ro.device, sysinit-reactivation.target, systemd-rfkill.socket, systemd-tmpfiles-resetup.service, systemd-vconsole-setup.service2067server # [ 269.286618] nixos[2140]: finished switching to system configuration /nix/store/yh0by73fiaw16qx96jj4qkkdzj47758g-nixos-system-server-test2068server: waiting for unit postgresql.service2069server: (finished: waiting for unit postgresql.service, in 0.51 seconds)2070(finished: subtest: switch to postgresql 17, in 95.29 seconds)2071subtest: amcheck recreated fresh on PG 17, mirroring the EXTENSIONS_TO_DISABLE fix2072server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension if not exists amcheck cascade"2073server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension if not exists amcheck cascade", in 1.05 seconds)2074server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select default_version from pg_available_extensions where name = 'amcheck'"2075server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select default_version from pg_available_extensions where name = 'amcheck'", in 0.72 seconds)2076server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'"2077server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'", in 0.34 seconds)2078server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname"2079server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname", in 0.38 seconds)2080(finished: subtest: amcheck recreated fresh on PG 17, mirroring the EXTENSIONS_TO_DISABLE fix, in 2.49 seconds)2081subtest: The support workflow still works after the upgrade2082server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create table amcheck_heap(i int primary key) using heap; insert into amcheck_heap select generate_series(1, 100)"2083server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create table amcheck_heap(i int primary key) using heap; insert into amcheck_heap select generate_series(1, 100)", in 0.40 seconds)2084server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass)"2085server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass)", in 0.38 seconds)2086server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass, false, false)"2087server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass, false, false)", in 0.35 seconds)2088server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('auth.users_pkey'::regclass)"2089server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('auth.users_pkey'::regclass)", in 0.35 seconds)2090(finished: subtest: The support workflow still works after the upgrade, in 1.48 seconds)2091(finished: run the VM test script, in 274.94 seconds)2092test script finished in 275.24s2093cleanup2094kill machine (pid 9)2095qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13)2096vde_switch: EOF data port: Interrupted system call2097kill vlan (pid 7)2098(finished: cleanup, in 0.00 seconds)2099vde_switch: Caught signal 15, cleaning up and exiting