these 2 derivations will be built: /nix/store/d103jd2wj6h4phc3rx8jla93ypsc5hra-nixos-test-driver-plpgsql_check.drv /nix/store/24kmrrhirj64c244h26zw4glglsmdir4-vm-test-run-plpgsql_check.drv building '/nix/store/d103jd2wj6h4phc3rx8jla93ypsc5hra-nixos-test-driver-plpgsql_check.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/d103jd2wj6h4phc3rx8jla93ypsc5hra-nixos-test-driver-plpgsql_check.drv' nixos-test-driver-plpgsql_check> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-plpgsql_check> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-plpgsql_check> Success: no issues found in 1 source file nixos-test-driver-plpgsql_check> additionally exposed symbols: nixos-test-driver-plpgsql_check> , nixos-test-driver-plpgsql_check> , nixos-test-driver-plpgsql_check> 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, debug nixos-test-driver-plpgsql_check> Linting test script (enable/disable: config.skipLint) nixos-test-driver-plpgsql_check> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint building '/nix/store/24kmrrhirj64c244h26zw4glglsmdir4-vm-test-run-plpgsql_check.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/24kmrrhirj64c244h26zw4glglsmdir4-vm-test-run-plpgsql_check.drv' vm-test-run-plpgsql_check> Machine state will be reset. To keep it, pass --keep-vm-state vm-test-run-plpgsql_check> start all VLans vm-test-run-plpgsql_check> start vlan vm-test-run-plpgsql_check> running vlan (pid 7; ctl /build/vde1.ctl) vm-test-run-plpgsql_check> (finished: start all VLans, in 0.00 seconds) vm-test-run-plpgsql_check> Test will time out and terminate in 3600 seconds vm-test-run-plpgsql_check> run the VM test script vm-test-run-plpgsql_check> additionally exposed symbols: vm-test-run-plpgsql_check> server, vm-test-run-plpgsql_check> vlan1, vm-test-run-plpgsql_check> 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, debug vm-test-run-plpgsql_check> start all VMs vm-test-run-plpgsql_check> server: starting vm vm-test-run-plpgsql_check> mke2fs 1.47.3 (8-Jul-2025) vm-test-run-plpgsql_check> qemu-system-aarch64: Could not access KVM kernel module: No such file or directory vm-test-run-plpgsql_check> qemu-system-aarch64: failed to initialize kvm: No such file or directory vm-test-run-plpgsql_check> qemu-system-aarch64: falling back to tcg vm-test-run-plpgsql_check> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-plpgsql_check> server # Formatting '/build/vm-state-server/tmp.sQOp5Pt3na', fmt=raw size=1073741824 vm-test-run-plpgsql_check> server # Discarding device blocks: 0/262144 done vm-test-run-plpgsql_check> server # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-plpgsql_check> server # Filesystem UUID: 27db171b-9288-49ef-9711-719366f2c4e4 vm-test-run-plpgsql_check> server: QEMU running (pid 9) vm-test-run-plpgsql_check> server # Superblock backups stored on blocks: vm-test-run-plpgsql_check> server # 32768, 98304, 163840, 229376 vm-test-run-plpgsql_check> server # vm-test-run-plpgsql_check> server # Allocating group tables: 0/8 done vm-test-run-plpgsql_check> server # Writing inode tables: 0/8 done vm-test-run-plpgsql_check> server # Creating journal (8192 blocks): done vm-test-run-plpgsql_check> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-plpgsql_check> server # vm-test-run-plpgsql_check> server # Virtualisation disk image created. vm-test-run-plpgsql_check> (finished: start all VMs, in 0.16 seconds) vm-test-run-plpgsql_check> server: waiting for unit supabase-db-init.service vm-test-run-plpgsql_check> server: waiting for the VM to finish booting vm-test-run-plpgsql_check> server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510] vm-test-run-plpgsql_check> server # [ 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 2025 vm-test-run-plpgsql_check> server # [ 0.000000] KASLR enabled vm-test-run-plpgsql_check> server # [ 0.000000] random: crng init done vm-test-run-plpgsql_check> server # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-plpgsql_check> server # [ 0.000000] efi: UEFI not found. vm-test-run-plpgsql_check> server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-plpgsql_check> server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plpgsql_check> server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f602200-0x13f60593f] vm-test-run-plpgsql_check> server # [ 0.000000] Zone ranges: vm-test-run-plpgsql_check> server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] vm-test-run-plpgsql_check> server # [ 0.000000] DMA32 empty vm-test-run-plpgsql_check> server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-plpgsql_check> server # [ 0.000000] Device empty vm-test-run-plpgsql_check> server # [ 0.000000] Movable zone start for each node vm-test-run-plpgsql_check> server # [ 0.000000] Early memory node ranges vm-test-run-plpgsql_check> server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plpgsql_check> server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plpgsql_check> server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -1 vm-test-run-plpgsql_check> server # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-plpgsql_check> server # [ 0.000000] psci: PSCIv1.1 detected in firmware. vm-test-run-plpgsql_check> server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-plpgsql_check> server # [ 0.000000] psci: Trusted OS migration not required vm-test-run-plpgsql_check> server # [ 0.000000] psci: SMC Calling Convention v1.0 vm-test-run-plpgsql_check> server # [ 0.000000] percpu: Embedded 88 pages/cpu s180056 r65536 d114856 u360448 vm-test-run-plpgsql_check> server # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-plpgsql_check> server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm) vm-test-run-plpgsql_check> server # [ 0.000000] CPU features: detected: GIC system register CPU interface vm-test-run-plpgsql_check> server # [ 0.000000] CPU features: detected: HCRX_EL2 register vm-test-run-plpgsql_check> server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2) vm-test-run-plpgsql_check> server # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-plpgsql_check> server # [ 0.000000] alternatives: applying boot alternatives vm-test-run-plpgsql_check> server # [ 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/idb351h5qlivypn8hrp1v6xw5sw1zn1i-nixos-system-server-test/init regInfo=/nix/store/sy946xksjvrpgkjw750jpmzq8pmj8xqx-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-plpgsql_check> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/sy946xksjvrpgkjw750jpmzq8pmj8xqx-closure-info/registration", will be passed to user space. vm-test-run-plpgsql_check> server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-plpgsql_check> server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 vm-test-run-plpgsql_check> server # [ 0.000000] Policy zone: Normal vm-test-run-plpgsql_check> server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-plpgsql_check> server # [ 0.000000] software IO TLB: area num 2. vm-test-run-plpgsql_check> server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) vm-test-run-plpgsql_check> server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm-test-run-plpgsql_check> server # [ 0.000000] allocated 8388608 bytes of page_ext vm-test-run-plpgsql_check> server # [ 0.000000] ftrace: allocating 72257 entries in 283 pages vm-test-run-plpgsql_check> server # [ 0.000000] ftrace: allocated 283 pages with 5 groups vm-test-run-plpgsql_check> server # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-plpgsql_check> server # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-plpgsql_check> server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. vm-test-run-plpgsql_check> server # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-plpgsql_check> server # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-plpgsql_check> server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-plpgsql_check> server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm-test-run-plpgsql_check> server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-plpgsql_check> server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-plpgsql_check> server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-plpgsql_check> server # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-plpgsql_check> server # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-plpgsql_check> server # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-plpgsql_check> server # [ 0.000000] GICv3: GICv3 features: 16 PPIs vm-test-run-plpgsql_check> server # [ 0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 vm-test-run-plpgsql_check> server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-plpgsql_check> server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-plpgsql_check> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100ae0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-plpgsql_check> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100af0000 (flat, esz 8, psz 64K, shr 1) vm-test-run-plpgsql_check> server # [ 0.000000] GICv3: using LPI property table @0x0000000100b00000 vm-test-run-plpgsql_check> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b10000 vm-test-run-plpgsql_check> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-plpgsql_check> server # [ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (virt). vm-test-run-plpgsql_check> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-plpgsql_check> server # [ 0.000040] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-plpgsql_check> server # [ 0.004272] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-plpgsql_check> server # [ 0.015046] Console: colour dummy device 80x25 vm-test-run-plpgsql_check> server # [ 0.016592] printk: legacy console [tty0] enabled vm-test-run-plpgsql_check> server # [ 0.022284] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-plpgsql_check> server # [ 0.022715] pid_max: default: 32768 minimum: 301 vm-test-run-plpgsql_check> server # [ 0.024616] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-plpgsql_check> server # [ 0.026247] landlock: Up and running. vm-test-run-plpgsql_check> server # [ 0.026293] Yama: becoming mindful. vm-test-run-plpgsql_check> server # [ 0.029475] LSM support for eBPF active vm-test-run-plpgsql_check> server # [ 0.032722] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.032844] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.064079] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-plpgsql_check> server # [ 0.076020] rcu: Hierarchical SRCU implementation. vm-test-run-plpgsql_check> server # [ 0.076118] rcu: Max phase no-delay instances is 1000. vm-test-run-plpgsql_check> server # [ 0.077554] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-plpgsql_check> server # [ 0.085655] fsl-mc MSI: its@8080000 domain created vm-test-run-plpgsql_check> server # [ 0.087636] EFI services will not be available. vm-test-run-plpgsql_check> server # [ 0.090300] smp: Bringing up secondary CPUs ... vm-test-run-plpgsql_check> server # [ 0.095549] Detected PIPT I-cache on CPU1 vm-test-run-plpgsql_check> server # [ 0.096811] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-plpgsql_check> server # [ 0.097732] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000 vm-test-run-plpgsql_check> server # [ 0.099587] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-plpgsql_check> server # [ 0.103739] smp: Brought up 1 node, 2 CPUs vm-test-run-plpgsql_check> server # [ 0.103889] SMP: Total of 2 processors activated. vm-test-run-plpgsql_check> server # [ 0.103936] CPU: All CPU(s) started at EL1 vm-test-run-plpgsql_check> server # [ 0.104101] CPU features: detected: Branch Target Identification vm-test-run-plpgsql_check> server # [ 0.104153] CPU features: detected: 32-bit EL0 Support vm-test-run-plpgsql_check> server # [ 0.104180] CPU features: detected: 32-bit EL1 Support vm-test-run-plpgsql_check> server # [ 0.104202] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-plpgsql_check> server # [ 0.104234] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-plpgsql_check> server # [ 0.104280] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-plpgsql_check> server # [ 0.104347] CPU features: detected: Common not Private translations vm-test-run-plpgsql_check> server # [ 0.104376] CPU features: detected: CRC32 instructions vm-test-run-plpgsql_check> server # [ 0.104404] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-plpgsql_check> server # [ 0.104435] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-plpgsql_check> server # [ 0.104464] CPU features: detected: Data independent timing control (DIT) vm-test-run-plpgsql_check> server # [ 0.104493] CPU features: detected: E0PD vm-test-run-plpgsql_check> server # [ 0.104515] CPU features: detected: Enhanced Counter Virtualization vm-test-run-plpgsql_check> server # [ 0.104543] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-plpgsql_check> server # [ 0.104570] CPU features: detected: Enhanced Privileged Access Never vm-test-run-plpgsql_check> server # [ 0.104595] CPU features: detected: Enhanced Virtualization Traps vm-test-run-plpgsql_check> server # [ 0.104622] CPU features: detected: Fine Grained Traps vm-test-run-plpgsql_check> server # [ 0.104682] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-plpgsql_check> server # [ 0.104774] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-plpgsql_check> server # [ 0.104819] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-plpgsql_check> server # [ 0.104845] CPU features: detected: LSE atomic instructions vm-test-run-plpgsql_check> server # [ 0.104870] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-plpgsql_check> server # [ 0.104898] CPU features: detected: Privileged Access Never vm-test-run-plpgsql_check> server # [ 0.104927] CPU features: detected: RAS Extension Support vm-test-run-plpgsql_check> server # [ 0.104951] CPU features: detected: Random Number Generator vm-test-run-plpgsql_check> server # [ 0.104972] CPU features: detected: Speculation barrier (SB) vm-test-run-plpgsql_check> server # [ 0.104997] CPU features: detected: Stage-2 Force Write-Back vm-test-run-plpgsql_check> server # [ 0.105023] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-plpgsql_check> server # [ 0.105049] CPU features: detected: TLB range maintenance instructions vm-test-run-plpgsql_check> server # [ 0.105076] CPU features: detected: WFx with timeout vm-test-run-plpgsql_check> server # [ 0.105118] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-plpgsql_check> server # [ 0.105146] CPU features: detected: Scalable Vector Extension vm-test-run-plpgsql_check> server # [ 0.111648] alternatives: applying system-wide alternatives vm-test-run-plpgsql_check> server # [ 0.127899] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-plpgsql_check> server # [ 0.128544] SVE: maximum available vector length 256 bytes per vector vm-test-run-plpgsql_check> server # [ 0.128645] SVE: default vector length 64 bytes per vector vm-test-run-plpgsql_check> server # [ 0.143296] Memory: 3922876K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-plpgsql_check> server # [ 0.165987] devtmpfs: initialized vm-test-run-plpgsql_check> server # [ 0.195452] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-plpgsql_check> server # [ 0.196002] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.199131] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-plpgsql_check> server # [ 0.199279] 0 pages in range for non-PLT usage vm-test-run-plpgsql_check> server # [ 0.199366] 509248 pages in range for PLT usage vm-test-run-plpgsql_check> server # [ 0.202472] pinctrl core: initialized pinctrl subsystem vm-test-run-plpgsql_check> server # [ 0.213211] DMI not present or invalid. vm-test-run-plpgsql_check> server # [ 0.236668] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-plpgsql_check> server # [ 0.248496] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-plpgsql_check> server # [ 0.250070] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-plpgsql_check> server # [ 0.251113] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-plpgsql_check> server # [ 0.251361] audit: initializing netlink subsys (disabled) vm-test-run-plpgsql_check> server # [ 0.253675] audit: type=2000 audit(0.200:1): state=initialized audit_enabled=0 res=1 vm-test-run-plpgsql_check> server # [ 0.259782] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-plpgsql_check> server # [ 0.259842] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-plpgsql_check> server # [ 0.259902] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-plpgsql_check> server # [ 0.259932] thermal_sys: Registered thermal governor 'user_space' vm-test-run-plpgsql_check> server # [ 0.259960] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-plpgsql_check> server # [ 0.260691] cpuidle: using governor ladder vm-test-run-plpgsql_check> server # [ 0.260970] cpuidle: using governor menu vm-test-run-plpgsql_check> server # [ 0.263124] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-plpgsql_check> server # [ 0.264526] ASID allocator initialised with 65536 entries vm-test-run-plpgsql_check> server # [ 0.271441] Serial: AMBA PL011 UART driver vm-test-run-plpgsql_check> server # [ 0.320729] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-plpgsql_check> server # [ 0.322221] printk: legacy console [ttyAMA0] enabled vm-test-run-plpgsql_check> server # [ 0.359824] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-plpgsql_check> server # [ 0.360036] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-plpgsql_check> server # [ 0.360146] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-plpgsql_check> server # [ 0.361328] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-plpgsql_check> server # [ 0.361580] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-plpgsql_check> server # [ 0.362772] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-plpgsql_check> server # [ 0.363041] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-plpgsql_check> server # [ 0.363137] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-plpgsql_check> server # [ 0.375613] fbcon: Taking over console vm-test-run-plpgsql_check> server # [ 0.376490] ACPI: Interpreter disabled. vm-test-run-plpgsql_check> server # [ 0.383920] iommu: Default domain type: Translated vm-test-run-plpgsql_check> server # [ 0.384069] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-plpgsql_check> server # [ 0.387739] SCSI subsystem initialized vm-test-run-plpgsql_check> server # [ 0.390092] usbcore: registered new interface driver usbfs vm-test-run-plpgsql_check> server # [ 0.390446] usbcore: registered new interface driver hub vm-test-run-plpgsql_check> server # [ 0.390937] usbcore: registered new device driver usb vm-test-run-plpgsql_check> server # [ 0.393199] pps_core: LinuxPPS API ver. 1 registered vm-test-run-plpgsql_check> server # [ 0.393316] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-plpgsql_check> server # [ 0.393494] PTP clock support registered vm-test-run-plpgsql_check> server # [ 0.393899] EDAC MC: Ver: 3.0.0 vm-test-run-plpgsql_check> server # [ 0.396102] scmi_core: SCMI protocol bus registered vm-test-run-plpgsql_check> server # [ 0.399551] FPGA manager framework vm-test-run-plpgsql_check> server # [ 0.400779] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-plpgsql_check> server # [ 0.409537] vgaarb: loaded vm-test-run-plpgsql_check> server # [ 0.413660] clocksource: Switched to clocksource arch_sys_counter vm-test-run-plpgsql_check> server # [ 0.416395] VFS: Disk quotas dquot_6.6.0 vm-test-run-plpgsql_check> server # [ 0.416669] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-plpgsql_check> server # [ 0.421585] netfs: FS-Cache loaded vm-test-run-plpgsql_check> server # [ 0.423987] pnp: PnP ACPI: disabled vm-test-run-plpgsql_check> server # [ 0.452813] NET: Registered PF_INET protocol family vm-test-run-plpgsql_check> server # [ 0.454720] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.571289] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.572027] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.572759] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.574339] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.575280] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-plpgsql_check> server # [ 0.576871] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.577313] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.577936] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plpgsql_check> server # [ 0.580091] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-plpgsql_check> server # [ 0.580672] NET: Registered PF_XDP protocol family vm-test-run-plpgsql_check> server # [ 0.581140] PCI: CLS 0 bytes, default 64 vm-test-run-plpgsql_check> server # [ 0.583888] kvm [1]: HYP mode not available vm-test-run-plpgsql_check> server # [ 0.586536] Trying to unpack rootfs image as initramfs... vm-test-run-plpgsql_check> server # [ 0.689128] Initialise system trusted keyrings vm-test-run-plpgsql_check> server # [ 0.691305] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-plpgsql_check> server # [ 0.695184] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-plpgsql_check> server # [ 0.696896] 9p: Installing v9fs 9p2000 file system support vm-test-run-plpgsql_check> server # [ 0.758163] Key type asymmetric registered vm-test-run-plpgsql_check> server # [ 0.758389] Asymmetric key parser 'x509' registered vm-test-run-plpgsql_check> server # [ 0.759270] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-plpgsql_check> server # [ 0.760349] io scheduler mq-deadline registered vm-test-run-plpgsql_check> server # [ 0.760505] io scheduler kyber registered vm-test-run-plpgsql_check> server # [ 0.790546] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-plpgsql_check> server # [ 0.794541] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-plpgsql_check> server # [ 0.798584] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-plpgsql_check> server # [ 0.799456] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-plpgsql_check> server # [ 0.800525] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-plpgsql_check> server # [ 0.800987] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-plpgsql_check> server # [ 0.802172] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-plpgsql_check> server # [ 0.802867] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-plpgsql_check> server # [ 0.804452] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-plpgsql_check> server # [ 0.805110] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-plpgsql_check> server # [ 0.805529] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-plpgsql_check> server # [ 0.805733] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-plpgsql_check> server # [ 0.805840] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-plpgsql_check> server # [ 0.807486] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.811475] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.811817] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plpgsql_check> server # [ 0.812375] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.812685] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plpgsql_check> server # [ 0.812848] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plpgsql_check> server # [ 0.813457] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.813850] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plpgsql_check> server # [ 0.813951] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.814058] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plpgsql_check> server # [ 0.814521] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.814764] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plpgsql_check> server # [ 0.814876] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.815007] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plpgsql_check> server # [ 0.816046] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.816245] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plpgsql_check> server # [ 0.816355] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.816711] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plpgsql_check> server # [ 0.817194] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.817349] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plpgsql_check> server # [ 0.817440] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.817549] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plpgsql_check> server # [ 0.818477] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.818741] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-plpgsql_check> server # [ 0.818857] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.818996] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plpgsql_check> server # [ 0.819906] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.820348] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plpgsql_check> server # [ 0.820758] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.821235] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plpgsql_check> server # [ 0.821470] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plpgsql_check> server # [ 0.823113] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.823362] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.823585] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plpgsql_check> server # [ 0.824123] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.824606] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.824714] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plpgsql_check> server # [ 0.825254] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.825552] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.827231] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.827447] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plpgsql_check> server # [ 0.827648] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.827766] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plpgsql_check> server # [ 0.828507] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plpgsql_check> server # [ 0.828665] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plpgsql_check> server # [ 0.828761] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plpgsql_check> server # [ 0.828869] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plpgsql_check> server # [ 0.830854] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-plpgsql_check> server # [ 0.831123] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-plpgsql_check> server # [ 0.831384] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-plpgsql_check> server # [ 0.831868] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-plpgsql_check> server # [ 0.832464] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-plpgsql_check> server # [ 0.832832] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-plpgsql_check> server # [ 0.833409] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-plpgsql_check> server # [ 0.833551] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-plpgsql_check> server # [ 0.833895] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-plpgsql_check> server # [ 0.834953] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-plpgsql_check> server # [ 0.835111] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-plpgsql_check> server # [ 0.835246] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-plpgsql_check> server # [ 0.835527] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-plpgsql_check> server # [ 0.836141] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-plpgsql_check> server # [ 0.836453] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-plpgsql_check> server # [ 0.836652] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-plpgsql_check> server # [ 0.836851] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-plpgsql_check> server # [ 0.837171] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-plpgsql_check> server # [ 0.837702] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-plpgsql_check> server # [ 0.838252] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-plpgsql_check> server # [ 0.838810] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-plpgsql_check> server # [ 0.838940] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-plpgsql_check> server # [ 0.839254] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-plpgsql_check> server # [ 0.839397] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-plpgsql_check> server # [ 0.839505] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-plpgsql_check> server # [ 0.839650] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-plpgsql_check> server # [ 0.839787] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-plpgsql_check> server # [ 0.839913] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-plpgsql_check> server # [ 0.840039] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-plpgsql_check> server # [ 0.840175] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-plpgsql_check> server # [ 0.840329] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-plpgsql_check> server # [ 0.840471] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-plpgsql_check> server # [ 0.840577] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-plpgsql_check> server # [ 0.840699] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-plpgsql_check> server # [ 0.841148] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-plpgsql_check> server # [ 0.842230] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-plpgsql_check> server # [ 0.842373] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-plpgsql_check> server # [ 0.843344] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-plpgsql_check> server # [ 0.914159] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-plpgsql_check> server # [ 0.917703] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-plpgsql_check> server # [ 0.921917] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-plpgsql_check> server # [ 0.924751] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-plpgsql_check> server # [ 0.927803] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-plpgsql_check> server # [ 0.929847] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-plpgsql_check> server # [ 0.932588] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-plpgsql_check> server # [ 0.934444] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-plpgsql_check> server # [ 0.935986] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-plpgsql_check> server # [ 0.939842] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-plpgsql_check> server # [ 0.942530] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-plpgsql_check> server # [ 0.963395] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-plpgsql_check> server # [ 0.975165] msm_serial: driver initialized vm-test-run-plpgsql_check> server # [ 0.976243] SuperH (H)SCI(F) driver initialized vm-test-run-plpgsql_check> server # [ 0.976697] STM32 USART driver initialized vm-test-run-plpgsql_check> server # [ 1.034249] loop: module loaded vm-test-run-plpgsql_check> server # [ 1.035157] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-plpgsql_check> server # [ 1.038932] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-plpgsql_check> server # [ 1.044914] Freeing initrd memory: 10684K vm-test-run-plpgsql_check> server # [ 1.052523] megasas: 07.727.03.00-rc1 vm-test-run-plpgsql_check> server # [ 1.058427] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-plpgsql_check> server # [ 1.060735] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plpgsql_check> server # [ 1.061793] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plpgsql_check> server # [ 1.063731] Using buffer write method vm-test-run-plpgsql_check> server # [ 1.064315] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-plpgsql_check> server # [ 1.065715] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plpgsql_check> server # [ 1.066477] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plpgsql_check> server # [ 1.068423] Using buffer write method vm-test-run-plpgsql_check> server # [ 1.068652] Concatenating MTD devices: vm-test-run-plpgsql_check> server # [ 1.068735] (0): "0.flash" vm-test-run-plpgsql_check> server # [ 1.068795] (1): "0.flash" vm-test-run-plpgsql_check> server # [ 1.068889] into device "0.flash" vm-test-run-plpgsql_check> server # [ 1.094886] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-plpgsql_check> server # [ 1.108239] thunder_xcv, ver 1.0 vm-test-run-plpgsql_check> server # [ 1.108533] thunder_bgx, ver 1.0 vm-test-run-plpgsql_check> server # [ 1.108732] nicpf, ver 1.0 vm-test-run-plpgsql_check> server # [ 1.111682] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-plpgsql_check> server # [ 1.111860] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-plpgsql_check> server # [ 1.112284] hclge is initializing vm-test-run-plpgsql_check> server # [ 1.112492] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-plpgsql_check> server # [ 1.112574] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-plpgsql_check> server # [ 1.112764] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-plpgsql_check> server # [ 1.112974] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-plpgsql_check> server # [ 1.113256] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-plpgsql_check> server # [ 1.113352] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-plpgsql_check> server # [ 1.113540] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-plpgsql_check> server # [ 1.113752] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-plpgsql_check> server # [ 1.115197] sky2: driver version 1.30 vm-test-run-plpgsql_check> server # [ 1.123419] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-plpgsql_check> server # [ 1.124044] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-plpgsql_check> server # [ 1.124631] usbcore: registered new interface driver usb-storage vm-test-run-plpgsql_check> server # [ 1.125274] usbcore: registered new interface driver usbserial_generic vm-test-run-plpgsql_check> server # [ 1.125688] usbserial: USB Serial support registered for generic vm-test-run-plpgsql_check> server # [ 1.127669] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-plpgsql_check> server # [ 1.134397] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-plpgsql_check> server # [ 1.135240] rtc-pl031 9010000.pl031: setting system clock to 2026-10-11T11:35:10 UTC (1791718510) vm-test-run-plpgsql_check> server # [ 1.136985] i2c_dev: i2c /dev entries driver vm-test-run-plpgsql_check> server # [ 1.138092] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-plpgsql_check> server # [ 1.144819] hub 1-0:1.0: USB hub found vm-test-run-plpgsql_check> server # [ 1.145399] hub 1-0:1.0: 6 ports detected vm-test-run-plpgsql_check> server # [ 1.152009] sdhci: Secure Digital Host Controller Interface driver vm-test-run-plpgsql_check> server # [ 1.152181] sdhci: Copyright(c) Pierre Ossman vm-test-run-plpgsql_check> server # [ 1.153588] Synopsys Designware Multimedia Card Interface Driver vm-test-run-plpgsql_check> server # [ 1.155562] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-plpgsql_check> server # [ 1.163134] hid: raw HID events driver (C) Jiri Kosina vm-test-run-plpgsql_check> server # [ 1.165086] usbcore: registered new interface driver usbhid vm-test-run-plpgsql_check> server # [ 1.165211] usbhid: USB HID core driver vm-test-run-plpgsql_check> server # [ 1.175189] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-plpgsql_check> server # [ 1.188161] drop_monitor: Initializing network drop monitor service vm-test-run-plpgsql_check> server # [ 1.189451] NET: Registered PF_INET6 protocol family vm-test-run-plpgsql_check> server # [ 1.203337] Segment Routing with IPv6 vm-test-run-plpgsql_check> server # [ 1.203654] In-situ OAM (IOAM) with IPv6 vm-test-run-plpgsql_check> server # [ 1.204608] NET: Registered PF_PACKET protocol family vm-test-run-plpgsql_check> server # [ 1.206450] 9pnet: Installing 9P2000 support vm-test-run-plpgsql_check> server # [ 1.210683] Key type dns_resolver registered vm-test-run-plpgsql_check> server # [ 1.245146] registered taskstats version 1 vm-test-run-plpgsql_check> server # [ 1.247700] Loading compiled-in X.509 certificates vm-test-run-plpgsql_check> server # [ 1.301714] Demotion targets for Node 0: null vm-test-run-plpgsql_check> server # [ 1.304296] Key type .fscrypt registered vm-test-run-plpgsql_check> server # [ 1.304444] Key type fscrypt-provisioning registered vm-test-run-plpgsql_check> server # [ 1.313840] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-plpgsql_check> server # [ 1.358494] clk: Disabling unused clocks vm-test-run-plpgsql_check> server # [ 1.358828] PM: genpd: Disabling unused power domains vm-test-run-plpgsql_check> server # [ 1.359607] ALSA device list: vm-test-run-plpgsql_check> server # [ 1.359946] No soundcards found. vm-test-run-plpgsql_check> server # [ 1.445236] Freeing unused kernel memory: 4416K vm-test-run-plpgsql_check> server # [ 1.446930] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-plpgsql_check> server # [ 1.448519] Run /init as init process vm-test-run-plpgsql_check> server # [ 1.643545] 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/input1 vm-test-run-plpgsql_check> server # [ 1.777360] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 vm-test-run-plpgsql_check> server # [ 1.897879] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-plpgsql_check> server # [ 2.012932] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-plpgsql_check> server # [ 2.081768] 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/input2 vm-test-run-plpgsql_check> server # [ 2.092501] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 vm-test-run-plpgsql_check> server # [ 2.157188] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-plpgsql_check> server # [ 2.158403] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-plpgsql_check> server # [ 2.158431] [drm] features: -context_init vm-test-run-plpgsql_check> server # [ 2.160575] [drm] number of scanouts: 1 vm-test-run-plpgsql_check> server # [ 2.160697] [drm] number of cap sets: 0 vm-test-run-plpgsql_check> server # [ 2.170054] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-plpgsql_check> server # [ 2.201629] Console: switching to colour frame buffer device 160x50 vm-test-run-plpgsql_check> server # [ 2.214693] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-plpgsql_check> server # [ 4.944307] EXT4-fs (vda): mounted filesystem 27db171b-9288-49ef-9711-719366f2c4e4 r/w with ordered data mode. Quota mode: none. vm-test-run-plpgsql_check> server # [ 7.231421] EXT4-fs (vda): re-mounted 27db171b-9288-49ef-9711-719366f2c4e4. vm-test-run-plpgsql_check> server # [ 7.248490] booting system configuration /nix/store/idb351h5qlivypn8hrp1v6xw5sw1zn1i-nixos-system-server-test vm-test-run-plpgsql_check> server # [ 19.164119] 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) vm-test-run-plpgsql_check> server # [ 19.175318] systemd[1]: Detected virtualization qemu. vm-test-run-plpgsql_check> server # [ 19.180269] systemd[1]: Detected architecture arm64. vm-test-run-plpgsql_check> server # [ 19.185617] systemd[1]: Detected first boot. vm-test-run-plpgsql_check> server # [ 19.215166] systemd[1]: Initializing machine ID from random generator. vm-test-run-plpgsql_check> server # [ 19.245418] systemd[1]: Hostname set to . vm-test-run-plpgsql_check> server # [ 20.487791] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-plpgsql_check> server # [ 21.743882] systemd[1]: Applying preset policy. vm-test-run-plpgsql_check> server # [ 24.815748] systemd[1]: Populated /etc with preset unit settings. vm-test-run-plpgsql_check> server # [ 28.298977] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-plpgsql_check> server # [ 28.524017] systemd[1]: Created slice Slice /system/getty. vm-test-run-plpgsql_check> server # [ 28.539412] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-plpgsql_check> server # [ 28.551580] systemd[1]: Created slice User and Session Slice. vm-test-run-plpgsql_check> server # [ 28.559801] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-plpgsql_check> server # [ 28.565407] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-plpgsql_check> server # [ 28.571935] systemd[1]: Expecting device /dev/hvc0... vm-test-run-plpgsql_check> server # [ 28.576941] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-plpgsql_check> server # [ 28.581428] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-plpgsql_check> server # [ 28.587045] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-plpgsql_check> server # [ 28.591758] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-plpgsql_check> server # [ 28.596033] systemd[1]: Reached target Path Units. vm-test-run-plpgsql_check> server # [ 28.600931] systemd[1]: Reached target Remote File Systems. vm-test-run-plpgsql_check> server # [ 28.605978] systemd[1]: Reached target Slice Units. vm-test-run-plpgsql_check> server # [ 28.610596] systemd[1]: Reached target Swaps. vm-test-run-plpgsql_check> server # [ 28.648967] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-plpgsql_check> server # [ 28.672970] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-plpgsql_check> server # [ 28.684741] systemd[1]: Listening on Journal Audit Socket. vm-test-run-plpgsql_check> server # [ 28.691978] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-plpgsql_check> server # [ 28.697177] systemd[1]: Listening on Journal Sockets. vm-test-run-plpgsql_check> server # [ 28.705282] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-plpgsql_check> server # [ 28.713254] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plpgsql_check> server # [ 28.719916] systemd[1]: Listening on udev Control Socket. vm-test-run-plpgsql_check> server # [ 28.725880] systemd[1]: Listening on udev Kernel Socket. vm-test-run-plpgsql_check> server # [ 28.777806] systemd[1]: Mounting Huge Pages File System... vm-test-run-plpgsql_check> server # [ 28.821325] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-plpgsql_check> server # [ 28.872614] systemd[1]: Mounting Kernel Debug File System... vm-test-run-plpgsql_check> server # [ 28.944473] systemd[1]: Mounting Kernel Trace File System... vm-test-run-plpgsql_check> server # [ 29.078295] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-plpgsql_check> server: Guest root shell did not produce any data yet... vm-test-run-plpgsql_check> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-plpgsql_check> server # [ 29.204779] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-plpgsql_check> server # [ 29.222915] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-plpgsql_check> server # [ 29.341112] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-plpgsql_check> server # [ 29.359301] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-plpgsql_check> server # [ 29.384223] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-plpgsql_check> server # [ 29.515569] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-plpgsql_check> server # [ 29.526809] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-plpgsql_check> server # [ 29.534956] 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). vm-test-run-plpgsql_check> server # [ 29.671543] systemd[1]: Starting Journal Service... vm-test-run-plpgsql_check> server # [ 29.745516] systemd[1]: Starting Load Kernel Modules... vm-test-run-plpgsql_check> server # [ 29.827527] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-plpgsql_check> server # [ 29.878132] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-plpgsql_check> server # [ 29.891329] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plpgsql_check> server # [ 29.946798] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-plpgsql_check> server # [ 30.031294] systemd[1]: Mounted Huge Pages File System. vm-test-run-plpgsql_check> server # [ 30.041317] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-plpgsql_check> server # [ 30.054734] systemd[1]: Mounted Kernel Debug File System. vm-test-run-plpgsql_check> server # [ 30.064969] systemd[1]: Mounted Kernel Trace File System. vm-test-run-plpgsql_check> server # [ 30.093539] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-plpgsql_check> server # [ 30.112412] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-plpgsql_check> server # [ 30.179138] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-plpgsql_check> server # [ 30.490444] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-plpgsql_check> server # [ 30.498524] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-plpgsql_check> server # [ 30.910320] fuse: init (API version 7.41) vm-test-run-plpgsql_check> server # [ 30.965650] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-plpgsql_check> server # [ 30.985180] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-plpgsql_check> server # [ 31.044247] systemd[1]: Mounting FUSE Control File System... vm-test-run-plpgsql_check> server # [ 31.241977] systemd[1]: Finished Load Kernel Modules. vm-test-run-plpgsql_check> server # [ 31.251217] EXT4-fs (vda): re-mounted 27db171b-9288-49ef-9711-719366f2c4e4. vm-test-run-plpgsql_check> server # [ 31.396184] systemd[1]: Starting Firewall... vm-test-run-plpgsql_check> server # [ 31.445719] systemd[1]: Starting Apply Kernel Variables... vm-test-run-plpgsql_check> server # [ 31.485181] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-plpgsql_check> server # [ 31.497481] systemd[1]: Mounted FUSE Control File System. vm-test-run-plpgsql_check> server # [ 31.509367] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-plpgsql_check> server # [ 31.561437] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-plpgsql_check> server # [ 31.569244] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plpgsql_check> server # [ 31.941536] systemd-journald[396]: Collecting audit messages is enabled. vm-test-run-plpgsql_check> server # [ 32.511163] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-plpgsql_check> server # [ 32.526697] systemd[1]: Reached target First Boot Complete. vm-test-run-plpgsql_check> server # [ 32.664763] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-plpgsql_check> server # [ 32.780094] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-plpgsql_check> server # [ 32.868155] systemd[1]: Finished Apply Kernel Variables. vm-test-run-plpgsql_check> server # [ 33.366983] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-plpgsql_check> server # [ 34.003643] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-plpgsql_check> server # [ 34.031605] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-plpgsql_check> server # [ 34.076000] systemd[1]: Mounting /run/wrappers... vm-test-run-plpgsql_check> server # [ 34.143923] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-plpgsql_check> server # [ 34.584817] systemd[1]: Mounted /run/wrappers. vm-test-run-plpgsql_check> server # [ 34.600180] systemd[1]: Reached target Local File Systems. vm-test-run-plpgsql_check> server # [ 34.640081] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-plpgsql_check> server # [ 34.701387] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-plpgsql_check> server # [ 34.708861] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-plpgsql_check> server # [ 34.770849] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-plpgsql_check> server # [ 34.707755] systemd-modules-load[397]: Module 'atkbd' is built in[ 34.791442] systemd[1]: Started Journal Service. vm-test-run-plpgsql_check> server # vm-test-run-plpgsql_check> server # [ 34.757412] systemd-modules-load[397]: Module 'loop' is built in vm-test-run-plpgsql_check> server # [ 34.810334] systemd-oomd[398]: No swap; memory pressure usage will be degraded vm-test-run-plpgsql_check> server # [ 34.886548] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-plpgsql_check> server # [ 35.774324] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-plpgsql_check> server # [ 35.850534] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-plpgsql_check> server # [ 35.944314] systemd-journald[396]: Received client request to flush runtime journal. vm-test-run-plpgsql_check> server # [ 36.409824] systemd-udevd[424]: Using default interface naming scheme 'v258'. vm-test-run-plpgsql_check> server # [ 36.477794] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-plpgsql_check> server # [ 36.530631] systemd[1]: Starting Create System Files and Directories... vm-test-run-plpgsql_check> server # [ 38.357866] systemd[1]: Finished Create System Files and Directories. vm-test-run-plpgsql_check> server # [ 38.386690] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-plpgsql_check> server # [ 38.429764] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-plpgsql_check> server # [ 38.436070] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-plpgsql_check> server # [ 39.604681] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-plpgsql_check> server # [ 40.611725] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-plpgsql_check> server # [ 40.692654] systemd[1]: Starting Update is Completed... vm-test-run-plpgsql_check> server # [ 41.535502] systemd[1]: Finished Update is Completed. vm-test-run-plpgsql_check> server # [ 45.190404] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-plpgsql_check> server # [ 45.198807] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-plpgsql_check> server # [ 45.202650] systemd[1]: suid-sgid-wrappers.service: Consumed 2.860s CPU time, 5.6M memory peak. vm-test-run-plpgsql_check> server # [ 48.000879] systemd[1]: Finished Firewall. vm-test-run-plpgsql_check> server # [ 49.715042] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-plpgsql_check> server # [ 49.729518] systemd[1]: Reached target System Initialization. vm-test-run-plpgsql_check> server # [ 49.737846] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-plpgsql_check> server # [ 49.742591] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-plpgsql_check> server # [ 49.750546] systemd[1]: Reached target Timer Units. vm-test-run-plpgsql_check> server # [ 49.771505] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-plpgsql_check> server # [ 49.774467] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-plpgsql_check> server # [ 49.782874] systemd[1]: Listening on Hostname Service Socket. vm-test-run-plpgsql_check> server # [ 49.786145] systemd[1]: Reached target Socket Units. vm-test-run-plpgsql_check> server # [ 49.787832] systemd[1]: Reached target Basic System. vm-test-run-plpgsql_check> server # [ 49.803163] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-plpgsql_check> server # [ 49.867087] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plpgsql_check> server # [ 49.925867] systemd[1]: Started Reset console on configuration changes. vm-test-run-plpgsql_check> server # [ 49.973999] systemd[1]: Starting resolvconf update... vm-test-run-plpgsql_check> server # [ 50.056341] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-plpgsql_check> server # [ 51.297014] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-plpgsql_check> server # [ 51.432678] nsncd[629]: Oct 11 11:36:00.832 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plpgsql_check> server # [ 51.451960] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plpgsql_check> server # [ 51.466318] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plpgsql_check> server # [ 51.477558] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plpgsql_check> server # [ 51.546023] systemd[1]: Starting User Login Management... vm-test-run-plpgsql_check> server # [ 51.830836] dbus-daemon[632]: dbus[632]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-plpgsql_check> server # [ 52.246655] systemd[1]: Started D-Bus System Message Bus. vm-test-run-plpgsql_check> server # [ 53.395839] systemd-logind[649]: New seat seat0. vm-test-run-plpgsql_check> server # [ 53.433784] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-plpgsql_check> server # [ 53.460008] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-plpgsql_check> server # [ 53.482971] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-plpgsql_check> server # [ 53.487941] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-plpgsql_check> server # [ 53.495118] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-plpgsql_check> server # [ 53.502359] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-plpgsql_check> server # [ 53.510928] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-plpgsql_check> server # [ 53.590956] systemd[1]: Started User Login Management. vm-test-run-plpgsql_check> server # [ 53.739190] systemd[1]: Starting linger-users.service... vm-test-run-plpgsql_check> server # [ 53.826333] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plpgsql_check> server # [ 54.514524] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-plpgsql_check> server # [ 54.527421] systemd[1]: Finished linger-users.service. vm-test-run-plpgsql_check> server # [ 54.762954] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plpgsql_check> server # [ 54.781853] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plpgsql_check> server # [ 54.785155] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plpgsql_check> server # [ 54.801435] nsncd[697]: Oct 11 11:36:04.201 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plpgsql_check> server # [ 55.130690] systemd[1]: Finished resolvconf update. vm-test-run-plpgsql_check> server # [ 55.149690] systemd[1]: Reached target Preparation for Network. vm-test-run-plpgsql_check> server # [ 55.224859] systemd[1]: Starting DHCP Client... vm-test-run-plpgsql_check> server # [ 56.973569] dhcpcd[740]: dhcpcd-10.2.4 starting vm-test-run-plpgsql_check> server # [ 57.087287] dhcpcd[764]: dev: loaded udev vm-test-run-plpgsql_check> server # [ 57.452440] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-plpgsql_check> server # [ 57.922310] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-plpgsql_check> server # [ 58.172628] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-plpgsql_check> server # [ 58.180019] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-plpgsql_check> server # [ 58.210304] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-plpgsql_check> server # [ 58.217125] cfg80211: failed to load regulatory.db vm-test-run-plpgsql_check> server # [ 58.930467] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-plpgsql_check> server # [ 58.864980] dhcpcd[764]: eth0: waiting for carrier vm-test-run-plpgsql_check> server # [ 58.887444] dhcpcd[764]: libudev: received NULL device vm-test-run-plpgsql_check> server # [ 58.891494] dhcpcd[764]: libudev: received NULL device vm-test-run-plpgsql_check> server # [ 58.894207] dhcpcd[764]: eth0: carrier acquired vm-test-run-plpgsql_check> server # [ 59.045974] dhcpcd[764]: DUID 00:01:00:01:32:5e:31:28:52:54:00:12:34:56 vm-test-run-plpgsql_check> server # [ 59.054752] dhcpcd[764]: eth0: IAID 00:12:34:56 vm-test-run-plpgsql_check> server # [ 59.057978] dhcpcd[764]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-plpgsql_check> server: Guest root shell did not produce any data yet... vm-test-run-plpgsql_check> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-plpgsql_check> server # [ 59.656015] systemd[1]: Found device /dev/hvc0. vm-test-run-plpgsql_check> server # [ 59.662887] dhcpcd[764]: eth0: soliciting a DHCP lease vm-test-run-plpgsql_check> server # [ 59.715579] dhcpcd[764]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plpgsql_check> server # [ 59.739772] dhcpcd[764]: eth0: probing address 10.0.2.15/24 vm-test-run-plpgsql_check> server # [ 60.130725] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-plpgsql_check> server # [ 60.180573] systemd[1]: Started backdoor.service. vm-test-run-plpgsql_check> server # connecting to host... vm-test-run-plpgsql_check> server: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-plpgsql_check> server: connected to guest root shell vm-test-run-plpgsql_check> server: (connecting took 61.96 seconds) vm-test-run-plpgsql_check> server: (finished: waiting for the VM to finish booting, in 61.96 seconds) vm-test-run-plpgsql_check> server # [ 61.061481] dhcpcd[764]: eth0: soliciting an IPv6 router vm-test-run-plpgsql_check> server # [ 61.067919] dhcpcd[764]: eth0: Router Advertisement from fe80::2 vm-test-run-plpgsql_check> server # [ 61.074962] dhcpcd[764]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-plpgsql_check> server # [ 61.076641] dhcpcd[764]: eth0: adding route to fec0::/64 vm-test-run-plpgsql_check> server # [ 61.094393] dhcpcd[764]: eth0: adding default route via fe80::2 vm-test-run-plpgsql_check> server # [ 61.198897] (udev-worker)[779]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plpgsql_check> server # [ 61.215682] (udev-worker)[782]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-plpgsql_check> server # [ 61.223716] (udev-worker)[782]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plpgsql_check> server # [ 62.118516] systemd[1]: Found device Virtio network device. vm-test-run-plpgsql_check> server # [ 62.144194] systemd[1]: Starting Address configuration of eth1... vm-test-run-plpgsql_check> server # [ 62.175594] dhcpcd[764]: eth0: IAID 00:12:34:56 vm-test-run-plpgsql_check> server # [ 62.277802] dhcpcd[764]: eth0: soliciting an IPv6 router vm-test-run-plpgsql_check> server # [ 63.147551] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-plpgsql_check> server # [ 63.405642] network-addresses-eth1-start[814]: adding address 192.168.1.1/24... done vm-test-run-plpgsql_check> server # [ 63.564260] network-addresses-eth1-start[814]: adding address 2001:db8:1::1/64... done vm-test-run-plpgsql_check> server # [ 63.829861] dhcpcd[764]: eth0: soliciting a DHCP lease vm-test-run-plpgsql_check> server # [ 63.831902] dhcpcd[764]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plpgsql_check> server # [ 63.838651] dhcpcd[764]: eth0: probing address 10.0.2.15/24 vm-test-run-plpgsql_check> server # [ 63.852099] systemd[1]: Finished Address configuration of eth1. vm-test-run-plpgsql_check> server # [ 63.902724] systemd[1]: Starting Networking Setup... vm-test-run-plpgsql_check> server # [ 64.405832] dhcpcd[764]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-plpgsql_check> server # [ 64.411307] dhcpcd[764]: eth0: adding route to 10.0.2.0/24 vm-test-run-plpgsql_check> server # [ 64.417401] dhcpcd[764]: eth0: adding default route via 10.0.2.2 vm-test-run-plpgsql_check> server # [ 65.224187] dhcpcd[860]: /nix/store/hsj50yr7hr62ql9xaynbihkhfhbgprcn-openresolv-3.17.0/sbin/.resolvconf-wrapped: line 1221: kill: (856) - Operation not permitted vm-test-run-plpgsql_check> server # [ 65.239764] dhcpcd[860]: clearing stale lock pid 856 vm-test-run-plpgsql_check> server # [ 67.437775] systemd[1]: Finished Networking Setup. vm-test-run-plpgsql_check> server # [ 67.476111] systemd[1]: Reached target Network. vm-test-run-plpgsql_check> server # [ 67.523243] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-plpgsql_check> server # [ 67.593003] systemd[1]: Starting Permit User Sessions... vm-test-run-plpgsql_check> server # [ 68.569110] systemd[1]: Finished Permit User Sessions. vm-test-run-plpgsql_check> server # [ 68.643480] systemd[1]: Started Getty on tty1. vm-test-run-plpgsql_check> server # [ 68.667564] systemd[1]: Reached target Login Prompts. vm-test-run-plpgsql_check> server # [ 68.710276] systemd[1]: Started DHCP Client. vm-test-run-plpgsql_check> server # [ 69.630735] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[983]: Initializing database at /var/lib/postgresql/data vm-test-run-plpgsql_check> server # [ 71.347506] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: The files belonging to this database system will be owned by user "postgres". vm-test-run-plpgsql_check> server # [ 71.356221] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: This user must also own the server process. vm-test-run-plpgsql_check> server # [ 71.441870] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-plpgsql_check> server # [ 71.443819] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: The default database encoding has accordingly been set to "UTF8". vm-test-run-plpgsql_check> server # [ 71.449663] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: The default text search configuration will be set to "english". vm-test-run-plpgsql_check> server # [ 71.450606] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: Data page checksums are enabled. vm-test-run-plpgsql_check> server # [ 71.460356] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-plpgsql_check> server # [ 71.498304] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: creating subdirectories ... ok vm-test-run-plpgsql_check> server # [ 71.513027] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: selecting dynamic shared memory implementation ... posix vm-test-run-plpgsql_check> server # [ 72.875520] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: selecting default max_connections ... 100 vm-test-run-plpgsql_check> server # [ 73.465809] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: selecting default shared_buffers ... 128MB vm-test-run-plpgsql_check> server # [ 76.429262] systemd-logind[649]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-plpgsql_check> server # [ 84.738286] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: selecting default time zone ... UTC vm-test-run-plpgsql_check> server # [ 84.813142] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: creating configuration files ... ok vm-test-run-plpgsql_check> server # [ 86.274539] mousedev: PS/2 mouse device common for all mice vm-test-run-plpgsql_check> server # [ 89.847927] systemd-logind[649]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-plpgsql_check> server # [ 89.970992] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: running bootstrap script ... ok vm-test-run-plpgsql_check> server # [ 103.305470] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: performing post-bootstrap initialization ... ok vm-test-run-plpgsql_check> server # [ 106.651484] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: syncing data to disk ... ok vm-test-run-plpgsql_check> server # [ 106.658675] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-plpgsql_check> server # [ 106.659546] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: 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. vm-test-run-plpgsql_check> server # [ 106.665289] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: Success. You can now start the database server using: vm-test-run-plpgsql_check> server # [ 106.673332] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[986]: /nix/store/2bhdbvpk81xy3mkfgqrpc719ip588cba-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-plpgsql_check> server # [ 108.590254] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[983]: Validating PostgreSQL configuration... vm-test-run-plpgsql_check> server # [ 109.167225] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[1378]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault vm-test-run-plpgsql_check> server # [ 110.305904] postgres[1383]: 2026-10-11 11:36:59.729 UTC [1383] LOG: pgaudit extension initialized vm-test-run-plpgsql_check> server # [ 111.494789] postgres[1383]: 2026-10-11 11:37:00.897 UTC [1383] LOG: pgsodium primary server secret key loaded vm-test-run-plpgsql_check> server # [ 112.228035] postgres[1383]: 2026-10-11 11:37:01.664 UTC [1383] LOG: vault primary server secret key loaded vm-test-run-plpgsql_check> server # [ 112.693088] postgres[1383]: 2026-10-11 11:37:02.130 UTC [1383] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-plpgsql_check> server # [ 112.703094] postgres[1383]: 2026-10-11 11:37:02.145 UTC [1383] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-plpgsql_check> server # [ 112.708063] postgres[1383]: 2026-10-11 11:37:02.148 UTC [1383] LOG: listening on IPv6 address "::", port 5432 vm-test-run-plpgsql_check> server # [ 112.725963] postgres[1383]: 2026-10-11 11:37:02.165 UTC [1383] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-plpgsql_check> server # [ 112.815967] postgres[1419]: 2026-10-11 11:37:02.253 UTC [1419] LOG: database system was shut down at 2026-10-11 11:36:52 UTC vm-test-run-plpgsql_check> server # [ 113.010896] postgres[1383]: 2026-10-11 11:37:02.452 UTC [1383] LOG: database system is ready to accept connections vm-test-run-plpgsql_check> server # [ 113.085442] systemd[1]: Started PostgreSQL Database Server. vm-test-run-plpgsql_check> server # [ 113.109622] postgres[1423]: 2026-10-11 11:37:02.540 UTC [1423] FATAL: role "postgres" does not exist vm-test-run-plpgsql_check> server # [ 113.138837] postgres[1422]: 2026-10-11 11:37:02.546 UTC [1422] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-plpgsql_check> server # [ 113.140299] systemd[1]: Starting Supabase Database Initialization... vm-test-run-plpgsql_check> server # [ 113.355047] postgres[1383]: 2026-10-11 11:37:02.796 UTC [1383] LOG: background worker "pg_net 0.20.4 worker" (PID 1423) exited with exit code 1 vm-test-run-plpgsql_check> server # [ 113.434738] postgres[1424]: 2026-10-11 11:37:02.865 UTC [1424] LOG: pg_cron scheduler started vm-test-run-plpgsql_check> server # [ 113.517803] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Waiting for PostgreSQL to be ready... vm-test-run-plpgsql_check> server # [ 114.437376] postgres[1446]: 2026-10-11 11:37:03.857 UTC [1446] FATAL: role "postgres" does not exist vm-test-run-plpgsql_check> server # [ 114.473415] postgres[1444]: ::1 2026-10-11 11:37:03.898 UTC [1444] root@root FATAL: role "root" does not exist vm-test-run-plpgsql_check> server # [ 114.527831] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: PostgreSQL is ready vm-test-run-plpgsql_check> server # [ 114.542692] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Creating postgres role... vm-test-run-plpgsql_check> server # [ 114.623881] postgres[1383]: 2026-10-11 11:37:04.053 UTC [1383] LOG: background worker "pg_net 0.20.4 worker" (PID 1446) exited with exit code 1 vm-test-run-plpgsql_check> server # [ 115.205250] postgres[1453]: ::1 2026-10-11 11:37:04.638 UTC [1453] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-plpgsql_check> server # [ 115.285150] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1447]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 115.595931] postgres[1459]: ::1 2026-10-11 11:37:05.032 UTC [1459] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-plpgsql_check> server # [ 115.607817] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1458]: ALTER DATABASE vm-test-run-plpgsql_check> server # [ 115.676146] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-plpgsql_check> server # [ 116.076332] postgres[1465]: ::1 2026-10-11 11:37:05.512 UTC [1465] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-plpgsql_check> server # [ 116.116922] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: CREATE PUBLICATION vm-test-run-plpgsql_check> server # [ 116.118983] postgres[1465]: ::1 2026-10-11 11:37:05.545 UTC [1465] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-plpgsql_check> server # [ 116.120363] postgres[1465]: ::1 2026-10-11 11:37:05.560 UTC [1465] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-plpgsql_check> server # [ 116.129384] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 116.141160] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 116.143086] postgres[1465]: ::1 2026-10-11 11:37:05.582 UTC [1465] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-plpgsql_check> server # [ 116.152328] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 116.157551] postgres[1465]: ::1 2026-10-11 11:37:05.596 UTC [1465] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-plpgsql_check> server # [ 116.167502] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 116.175377] postgres[1465]: ::1 2026-10-11 11:37:05.612 UTC [1465] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-plpgsql_check> server # [ 116.184061] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: GRANT vm-test-run-plpgsql_check> server # [ 116.194479] postgres[1465]: ::1 2026-10-11 11:37:05.630 UTC [1465] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-plpgsql_check> server # [ 116.203975] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 116.205957] postgres[1465]: ::1 2026-10-11 11:37:05.645 UTC [1465] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-plpgsql_check> server # [ 116.221784] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 116.223649] postgres[1465]: ::1 2026-10-11 11:37:05.660 UTC [1465] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-plpgsql_check> server # [ 116.238638] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: CREATE SCHEMA vm-test-run-plpgsql_check> server # [ 116.243352] postgres[1465]: ::1 2026-10-11 11:37:05.685 UTC [1465] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-plpgsql_check> server # [ 119.218578] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: CREATE EXTENSION vm-test-run-plpgsql_check> server # [ 119.233395] postgres[1465]: ::1 2026-10-11 11:37:08.658 UTC [1465] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-plpgsql_check> server # [ 120.074714] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: CREATE EXTENSION vm-test-run-plpgsql_check> server # [ 120.078998] postgres[1465]: ::1 2026-10-11 11:37:09.514 UTC [1465] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-plpgsql_check> server # [ 120.086402] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 120.088008] postgres[1465]: ::1 2026-10-11 11:37:09.526 UTC [1465] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-plpgsql_check> server # [ 120.097589] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 120.101171] postgres[1465]: ::1 2026-10-11 11:37:09.541 UTC [1465] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-plpgsql_check> server # [ 120.121348] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 120.122355] postgres[1465]: ::1 2026-10-11 11:37:09.557 UTC [1465] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-plpgsql_check> server # [ 120.130445] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 120.138197] postgres[1465]: ::1 2026-10-11 11:37:09.577 UTC [1465] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-plpgsql_check> server # [ 120.160269] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 120.163203] postgres[1465]: ::1 2026-10-11 11:37:09.600 UTC [1465] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-plpgsql_check> server # [ 120.173887] postgres[1465]: ::1 2026-10-11 11:37:09.614 UTC [1465] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-plpgsql_check> server # [ 120.183289] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 120.193034] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 120.198791] postgres[1465]: ::1 2026-10-11 11:37:09.631 UTC [1465] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-plpgsql_check> server # [ 120.210329] postgres[1465]: ::1 2026-10-11 11:37:09.643 UTC [1465] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 120.224754] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 120.225553] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: GRANT vm-test-run-plpgsql_check> server # [ 120.226844] postgres[1465]: ::1 2026-10-11 11:37:09.660 UTC [1465] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 120.242783] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 120.264877] postgres[1465]: ::1 2026-10-11 11:37:09.680 UTC [1465] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 120.267136] postgres[1465]: ::1 2026-10-11 11:37:09.696 UTC [1465] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 120.270195] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 120.270879] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 120.271652] postgres[1465]: ::1 2026-10-11 11:37:09.712 UTC [1465] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 120.283015] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: GRANT vm-test-run-plpgsql_check> server # [ 120.294605] postgres[1465]: ::1 2026-10-11 11:37:09.724 UTC [1465] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-plpgsql_check> server # [ 120.302186] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 120.309584] postgres[1465]: ::1 2026-10-11 11:37:09.750 UTC [1465] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plpgsql_check> server # [ 120.311212] postgres[1465]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 120.326578] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 120.328196] postgres[1465]: ::1 2026-10-11 11:37:09.769 UTC [1465] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plpgsql_check> server # [ 120.339310] postgres[1465]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 120.345873] postgres[1465]: ::1 2026-10-11 11:37:09.784 UTC [1465] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plpgsql_check> server # [ 120.357919] postgres[1465]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 120.361263] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 120.362049] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 120.362724] postgres[1465]: ::1 2026-10-11 11:37:09.796 UTC [1465] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-plpgsql_check> server # [ 120.377167] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 120.383500] postgres[1465]: ::1 2026-10-11 11:37:09.814 UTC [1465] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-plpgsql_check> server # [ 120.390320] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1461]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 120.488550] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-plpgsql_check> server # [ 120.933109] postgres[1498]: ::1 2026-10-11 11:37:10.327 UTC [1498] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-plpgsql_check> server # [ 120.954342] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE SCHEMA vm-test-run-plpgsql_check> server # [ 120.955201] postgres[1498]: ::1 2026-10-11 11:37:10.395 UTC [1498] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-plpgsql_check> server # [ 120.964853] postgres[1498]: instance_id uuid NULL, vm-test-run-plpgsql_check> server # [ 120.965823] postgres[1498]: id uuid NOT NULL UNIQUE, vm-test-run-plpgsql_check> server # [ 120.966733] postgres[1498]: aud varchar(255) NULL, vm-test-run-plpgsql_check> server # [ 120.967235] postgres[1498]: "role" varchar(255) NULL, vm-test-run-plpgsql_check> server # [ 120.967651] postgres[1498]: email varchar(255) NULL UNIQUE, vm-test-run-plpgsql_check> server # [ 120.967968] postgres[1498]: encrypted_password varchar(255) NULL, vm-test-run-plpgsql_check> server # [ 120.981931] postgres[1498]: confirmed_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 120.983136] postgres[1498]: invited_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 120.983955] postgres[1498]: confirmation_token varchar(255) NULL, vm-test-run-plpgsql_check> server # [ 120.990624] postgres[1498]: confirmation_sent_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 120.992307] postgres[1498]: recovery_token varchar(255) NULL, vm-test-run-plpgsql_check> server # [ 120.997887] postgres[1498]: recovery_sent_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 120.998525] postgres[1498]: email_change_token varchar(255) NULL, vm-test-run-plpgsql_check> server # [ 120.998848] postgres[1498]: email_change varchar(255) NULL, vm-test-run-plpgsql_check> server # [ 120.999101] postgres[1498]: email_change_sent_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 120.999348] postgres[1498]: last_sign_in_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 120.999581] postgres[1498]: raw_app_meta_data jsonb NULL, vm-test-run-plpgsql_check> server # [ 121.005299] postgres[1498]: raw_user_meta_data jsonb NULL, vm-test-run-plpgsql_check> server # [ 121.012200] postgres[1498]: is_super_admin bool NULL, vm-test-run-plpgsql_check> server # [ 121.022476] postgres[1498]: created_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 121.023705] postgres[1498]: updated_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 121.024861] postgres[1498]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-plpgsql_check> server # [ 121.025569] postgres[1498]: ); vm-test-run-plpgsql_check> server # [ 121.174448] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE TABLE vm-test-run-plpgsql_check> server # [ 121.185595] postgres[1498]: ::1 2026-10-11 11:37:10.625 UTC [1498] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-plpgsql_check> server # [ 121.227194] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE INDEX vm-test-run-plpgsql_check> server # [ 121.241575] postgres[1498]: ::1 2026-10-11 11:37:10.680 UTC [1498] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-plpgsql_check> server # [ 121.288971] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE INDEX vm-test-run-plpgsql_check> server # [ 121.289944] postgres[1498]: ::1 2026-10-11 11:37:10.728 UTC [1498] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-plpgsql_check> server # [ 121.297877] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: COMMENT vm-test-run-plpgsql_check> server # [ 121.299139] postgres[1498]: ::1 2026-10-11 11:37:10.741 UTC [1498] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-plpgsql_check> server # [ 121.299807] postgres[1498]: instance_id uuid NULL, vm-test-run-plpgsql_check> server # [ 121.302245] postgres[1498]: id bigserial NOT NULL, vm-test-run-plpgsql_check> server # [ 121.302876] postgres[1498]: "token" varchar(255) NULL, vm-test-run-plpgsql_check> server # [ 121.303384] postgres[1498]: user_id varchar(255) NULL, vm-test-run-plpgsql_check> server # [ 121.304315] postgres[1498]: revoked bool NULL, vm-test-run-plpgsql_check> server # [ 121.309969] postgres[1498]: created_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 121.310449] postgres[1498]: updated_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 121.311371] postgres[1498]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-plpgsql_check> server # [ 121.312018] postgres[1498]: ); vm-test-run-plpgsql_check> server # [ 121.448384] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE TABLE vm-test-run-plpgsql_check> server # [ 121.452963] postgres[1498]: ::1 2026-10-11 11:37:10.892 UTC [1498] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-plpgsql_check> server # [ 121.491542] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE INDEX vm-test-run-plpgsql_check> server # [ 121.492326] postgres[1498]: ::1 2026-10-11 11:37:10.934 UTC [1498] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id); vm-test-run-plpgsql_check> server # [ 121.573883] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE INDEX vm-test-run-plpgsql_check> server # [ 121.584933] postgres[1498]: ::1 2026-10-11 11:37:11.020 UTC [1498] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-plpgsql_check> server # [ 121.623912] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE INDEX vm-test-run-plpgsql_check> server # [ 121.630799] postgres[1498]: ::1 2026-10-11 11:37:11.069 UTC [1498] postgres@postgres LOG: statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.'; vm-test-run-plpgsql_check> server # [ 121.646236] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: COMMENT vm-test-run-plpgsql_check> server # [ 121.654009] postgres[1498]: ::1 2026-10-11 11:37:11.093 UTC [1498] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-plpgsql_check> server # [ 121.655117] postgres[1498]: id uuid NOT NULL, vm-test-run-plpgsql_check> server # [ 121.655959] postgres[1498]: uuid uuid NULL, vm-test-run-plpgsql_check> server # [ 121.661538] postgres[1498]: raw_base_config text NULL, vm-test-run-plpgsql_check> server # [ 121.662005] postgres[1498]: created_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 121.662296] postgres[1498]: updated_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 121.662554] postgres[1498]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-plpgsql_check> server # [ 121.662823] postgres[1498]: ); vm-test-run-plpgsql_check> server # [ 121.778019] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE TABLE vm-test-run-plpgsql_check> server # [ 121.788830] postgres[1498]: ::1 2026-10-11 11:37:11.224 UTC [1498] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-plpgsql_check> server # [ 121.823967] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: COMMENT vm-test-run-plpgsql_check> server # [ 121.825806] postgres[1498]: ::1 2026-10-11 11:37:11.263 UTC [1498] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-plpgsql_check> server # [ 121.827126] postgres[1498]: instance_id uuid NULL, vm-test-run-plpgsql_check> server # [ 121.834603] postgres[1498]: id uuid NOT NULL, vm-test-run-plpgsql_check> server # [ 121.837989] postgres[1498]: payload json NULL, vm-test-run-plpgsql_check> server # [ 121.839343] postgres[1498]: created_at timestamptz NULL, vm-test-run-plpgsql_check> server # [ 121.839708] postgres[1498]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-plpgsql_check> server # [ 121.850390] postgres[1498]: ); vm-test-run-plpgsql_check> server # [ 121.897129] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE TABLE vm-test-run-plpgsql_check> server # [ 121.919207] postgres[1498]: ::1 2026-10-11 11:37:11.338 UTC [1498] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id); vm-test-run-plpgsql_check> server # [ 121.930389] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE INDEX vm-test-run-plpgsql_check> server # [ 121.937392] postgres[1498]: ::1 2026-10-11 11:37:11.375 UTC [1498] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-plpgsql_check> server # [ 121.948356] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: COMMENT vm-test-run-plpgsql_check> server # [ 121.954057] postgres[1498]: ::1 2026-10-11 11:37:11.385 UTC [1498] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-plpgsql_check> server # [ 121.955471] postgres[1498]: "version" varchar(255) NOT NULL, vm-test-run-plpgsql_check> server # [ 121.955922] postgres[1498]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-plpgsql_check> server # [ 121.960080] postgres[1498]: ); vm-test-run-plpgsql_check> server # [ 121.977122] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE TABLE vm-test-run-plpgsql_check> server # [ 121.980946] postgres[1498]: ::1 2026-10-11 11:37:11.422 UTC [1498] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-plpgsql_check> server # [ 121.991040] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: COMMENT vm-test-run-plpgsql_check> server # [ 122.025432] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: INSERT 0 7 vm-test-run-plpgsql_check> server # [ 122.027366] postgres[1498]: ::1 2026-10-11 11:37:11.462 UTC [1498] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-plpgsql_check> server # [ 122.029439] postgres[1498]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-plpgsql_check> server # [ 122.031140] postgres[1498]: $$ language sql stable; vm-test-run-plpgsql_check> server # [ 122.048599] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 122.057287] postgres[1498]: ::1 2026-10-11 11:37:11.493 UTC [1498] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-plpgsql_check> server # [ 122.058385] postgres[1498]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-plpgsql_check> server # [ 122.065899] postgres[1498]: $$ language sql stable; vm-test-run-plpgsql_check> server # [ 122.074238] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 122.077914] postgres[1498]: ::1 2026-10-11 11:37:11.518 UTC [1498] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-plpgsql_check> server # [ 122.079316] postgres[1498]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-plpgsql_check> server # [ 122.079984] postgres[1498]: $$ language sql stable; vm-test-run-plpgsql_check> server # [ 122.093938] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 122.095078] postgres[1498]: ::1 2026-10-11 11:37:11.537 UTC [1498] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 122.107048] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: GRANT vm-test-run-plpgsql_check> server # [ 122.108172] postgres[1498]: ::1 2026-10-11 11:37:11.549 UTC [1498] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plpgsql_check> server # [ 122.118673] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 122.126052] postgres[1498]: ::1 2026-10-11 11:37:11.560 UTC [1498] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 122.133550] postgres[1498]: ::1 2026-10-11 11:37:11.574 UTC [1498] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 122.134710] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: GRANT vm-test-run-plpgsql_check> server # [ 122.153534] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: GRANT vm-test-run-plpgsql_check> server # [ 122.154693] postgres[1498]: ::1 2026-10-11 11:37:11.595 UTC [1498] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 122.168094] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: GRANT vm-test-run-plpgsql_check> server # [ 122.171620] postgres[1498]: ::1 2026-10-11 11:37:11.612 UTC [1498] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-plpgsql_check> server # [ 122.183867] postgres[1498]: ::1 2026-10-11 11:37:11.626 UTC [1498] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 122.187805] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 122.195061] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: ALTER TABLE vm-test-run-plpgsql_check> server # [ 122.196002] postgres[1498]: ::1 2026-10-11 11:37:11.638 UTC [1498] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 122.211243] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: ALTER TABLE vm-test-run-plpgsql_check> server # [ 122.212115] postgres[1498]: ::1 2026-10-11 11:37:11.654 UTC [1498] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 122.238007] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: ALTER TABLE vm-test-run-plpgsql_check> server # [ 122.238855] postgres[1498]: ::1 2026-10-11 11:37:11.681 UTC [1498] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 122.253150] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: ALTER TABLE vm-test-run-plpgsql_check> server # [ 122.256327] postgres[1498]: ::1 2026-10-11 11:37:11.697 UTC [1498] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 122.269871] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1495]: ALTER TABLE vm-test-run-plpgsql_check> server # [ 122.327799] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-plpgsql_check> server # [ 122.711492] postgres[1522]: ::1 2026-10-11 11:37:12.147 UTC [1522] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-plpgsql_check> server # [ 122.732653] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1521]: CREATE SCHEMA vm-test-run-plpgsql_check> server # [ 122.734159] postgres[1522]: ::1 2026-10-11 11:37:12.173 UTC [1522] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plpgsql_check> server # [ 122.751521] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1521]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 122.753571] postgres[1522]: ::1 2026-10-11 11:37:12.193 UTC [1522] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-plpgsql_check> server # [ 122.777422] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1521]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 122.778404] postgres[1522]: ::1 2026-10-11 11:37:12.215 UTC [1522] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-plpgsql_check> server # [ 122.787622] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1521]: GRANT vm-test-run-plpgsql_check> server # [ 122.840995] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1521]: DO vm-test-run-plpgsql_check> server # [ 122.886329] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-plpgsql_check> server # [ 123.139468] postgres[1524]: ::1 2026-10-11 11:37:12.572 UTC [1524] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-plpgsql_check> server # [ 123.151970] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 123.153829] postgres[1524]: ::1 2026-10-11 11:37:12.592 UTC [1524] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-plpgsql_check> server # [ 123.159684] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 123.163446] postgres[1524]: ::1 2026-10-11 11:37:12.605 UTC [1524] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-plpgsql_check> server # [ 123.164475] postgres[1524]: RETURNS event_trigger vm-test-run-plpgsql_check> server # [ 123.164924] postgres[1524]: LANGUAGE plpgsql vm-test-run-plpgsql_check> server # [ 123.169961] postgres[1524]: AS $$ vm-test-run-plpgsql_check> server # [ 123.170480] postgres[1524]: DECLARE vm-test-run-plpgsql_check> server # [ 123.170852] postgres[1524]: schema_is_cron bool; vm-test-run-plpgsql_check> server # [ 123.171548] postgres[1524]: BEGIN vm-test-run-plpgsql_check> server # [ 123.172261] postgres[1524]: schema_is_cron = ( vm-test-run-plpgsql_check> server # [ 123.178160] postgres[1524]: SELECT n.nspname = 'cron' vm-test-run-plpgsql_check> server # [ 123.179206] postgres[1524]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plpgsql_check> server # [ 123.179591] postgres[1524]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-plpgsql_check> server # [ 123.180066] postgres[1524]: ON ev.objid = n.oid vm-test-run-plpgsql_check> server # [ 123.180361] postgres[1524]: ); vm-test-run-plpgsql_check> server # [ 123.185656] postgres[1524]: vm-test-run-plpgsql_check> server # [ 123.186439] postgres[1524]: IF schema_is_cron vm-test-run-plpgsql_check> server # [ 123.187698] postgres[1524]: THEN vm-test-run-plpgsql_check> server # [ 123.188051] postgres[1524]: grant usage on schema cron to postgres with grant option; vm-test-run-plpgsql_check> server # [ 123.193151] postgres[1524]: vm-test-run-plpgsql_check> server # [ 123.198787] postgres[1524]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plpgsql_check> server # [ 123.199533] postgres[1524]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plpgsql_check> server # [ 123.203901] postgres[1524]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plpgsql_check> server # [ 123.210086] postgres[1524]: vm-test-run-plpgsql_check> server # [ 123.211857] postgres[1524]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plpgsql_check> server # [ 123.214157] postgres[1524]: on sequences to postgres with grant option; vm-test-run-plpgsql_check> server # [ 123.214940] postgres[1524]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plpgsql_check> server # [ 123.216086] postgres[1524]: on tables to postgres with grant option; vm-test-run-plpgsql_check> server # [ 123.219554] postgres[1524]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plpgsql_check> server # [ 123.221992] postgres[1524]: on functions to postgres with grant option; vm-test-run-plpgsql_check> server # [ 123.222470] postgres[1524]: vm-test-run-plpgsql_check> server # [ 123.223143] postgres[1524]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plpgsql_check> server # [ 123.224922] postgres[1524]: vm-test-run-plpgsql_check> server # [ 123.225863] postgres[1524]: END IF; vm-test-run-plpgsql_check> server # [ 123.226229] postgres[1524]: vm-test-run-plpgsql_check> server # [ 123.226494] postgres[1524]: END; vm-test-run-plpgsql_check> server # [ 123.226895] postgres[1524]: $$; vm-test-run-plpgsql_check> server # [ 123.227714] postgres[1524]: ::1 2026-10-11 11:37:12.641 UTC [1524] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA') vm-test-run-plpgsql_check> server # [ 123.230185] postgres[1524]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-plpgsql_check> server # [ 123.230607] postgres[1524]: ::1 2026-10-11 11:37:12.667 UTC [1524] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-plpgsql_check> server # [ 123.231088] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 123.232829] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: CREATE EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 123.238394] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: COMMENT vm-test-run-plpgsql_check> server # [ 123.243566] postgres[1524]: ::1 2026-10-11 11:37:12.683 UTC [1524] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-plpgsql_check> server # [ 123.245607] postgres[1524]: RETURNS event_trigger vm-test-run-plpgsql_check> server # [ 123.246165] postgres[1524]: LANGUAGE plpgsql vm-test-run-plpgsql_check> server # [ 123.247343] postgres[1524]: AS $$ vm-test-run-plpgsql_check> server # [ 123.247635] postgres[1524]: BEGIN vm-test-run-plpgsql_check> server # [ 123.248316] postgres[1524]: IF EXISTS ( vm-test-run-plpgsql_check> server # [ 123.250291] postgres[1524]: SELECT 1 vm-test-run-plpgsql_check> server # [ 123.251201] postgres[1524]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plpgsql_check> server # [ 123.252425] postgres[1524]: JOIN pg_extension AS ext vm-test-run-plpgsql_check> server # [ 123.253929] postgres[1524]: ON ev.objid = ext.oid vm-test-run-plpgsql_check> server # [ 123.256031] postgres[1524]: WHERE ext.extname = 'pg_net' vm-test-run-plpgsql_check> server # [ 123.259415] postgres[1524]: ) vm-test-run-plpgsql_check> server # [ 123.261213] postgres[1524]: THEN vm-test-run-plpgsql_check> server # [ 123.261762] postgres[1524]: IF NOT EXISTS ( vm-test-run-plpgsql_check> server # [ 123.264307] postgres[1524]: SELECT 1 vm-test-run-plpgsql_check> server # [ 123.264764] postgres[1524]: FROM pg_roles vm-test-run-plpgsql_check> server # [ 123.266436] postgres[1524]: WHERE rolname = 'supabase_functions_admin' vm-test-run-plpgsql_check> server # [ 123.266965] postgres[1524]: ) vm-test-run-plpgsql_check> server # [ 123.267745] postgres[1524]: THEN vm-test-run-plpgsql_check> server # [ 123.273440] postgres[1524]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plpgsql_check> server # [ 123.275843] postgres[1524]: END IF; vm-test-run-plpgsql_check> server # [ 123.281080] postgres[1524]: vm-test-run-plpgsql_check> server # [ 123.281812] postgres[1524]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 123.282492] postgres[1524]: vm-test-run-plpgsql_check> server # [ 123.282813] postgres[1524]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plpgsql_check> server # [ 123.283623] postgres[1524]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plpgsql_check> server # [ 123.284443] postgres[1524]: vm-test-run-plpgsql_check> server # [ 123.284992] postgres[1524]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plpgsql_check> server # [ 123.293645] postgres[1524]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plpgsql_check> server # [ 123.294583] postgres[1524]: vm-test-run-plpgsql_check> server # [ 123.294979] postgres[1524]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plpgsql_check> server # [ 123.295660] postgres[1524]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plpgsql_check> server # [ 123.296036] postgres[1524]: vm-test-run-plpgsql_check> server # [ 123.302081] postgres[1524]: 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; vm-test-run-plpgsql_check> server # [ 123.309426] postgres[1524]: 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; vm-test-run-plpgsql_check> server # [ 123.310814] postgres[1524]: END IF; vm-test-run-plpgsql_check> server # [ 123.313817] postgres[1524]: END; vm-test-run-plpgsql_check> server # [ 123.314642] postgres[1524]: $$; vm-test-run-plpgsql_check> server # [ 123.315167] postgres[1524]: ::1 2026-10-11 11:37:12.712 UTC [1524] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-plpgsql_check> server # [ 123.315828] postgres[1524]: ::1 2026-10-11 11:37:12.748 UTC [1524] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-plpgsql_check> server # [ 123.316442] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 123.319019] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: COMMENT vm-test-run-plpgsql_check> server # [ 123.319681] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: DO vm-test-run-plpgsql_check> server # [ 123.325393] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 123.326274] postgres[1524]: ::1 2026-10-11 11:37:12.764 UTC [1524] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-plpgsql_check> server # [ 123.332742] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: GRANT vm-test-run-plpgsql_check> server # [ 123.333979] postgres[1524]: ::1 2026-10-11 11:37:12.774 UTC [1524] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-plpgsql_check> server # [ 123.343457] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: GRANT vm-test-run-plpgsql_check> server # [ 123.347832] postgres[1524]: ::1 2026-10-11 11:37:12.789 UTC [1524] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-plpgsql_check> server # [ 123.359753] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: GRANT vm-test-run-plpgsql_check> server # [ 123.363428] postgres[1524]: ::1 2026-10-11 11:37:12.802 UTC [1524] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-plpgsql_check> server # [ 123.371819] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: GRANT vm-test-run-plpgsql_check> server # [ 123.373921] postgres[1524]: ::1 2026-10-11 11:37:12.816 UTC [1524] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-plpgsql_check> server # [ 123.383143] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: GRANT vm-test-run-plpgsql_check> server # [ 123.392806] postgres[1524]: ::1 2026-10-11 11:37:12.825 UTC [1524] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-plpgsql_check> server # [ 123.393779] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: GRANT vm-test-run-plpgsql_check> server # [ 123.394431] postgres[1524]: ::1 2026-10-11 11:37:12.836 UTC [1524] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-plpgsql_check> server # [ 123.398219] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: GRANT vm-test-run-plpgsql_check> server # [ 123.399195] postgres[1524]: ::1 2026-10-11 11:37:12.841 UTC [1524] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-plpgsql_check> server # [ 123.424677] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: GRANT vm-test-run-plpgsql_check> server # [ 123.425938] postgres[1524]: ::1 2026-10-11 11:37:12.867 UTC [1524] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-plpgsql_check> server # [ 123.467578] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: GRANT vm-test-run-plpgsql_check> server # [ 123.487684] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1523]: DO vm-test-run-plpgsql_check> server # [ 123.556223] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running pgbouncer auth schema... vm-test-run-plpgsql_check> server # [ 123.937446] postgres[1527]: ::1 2026-10-11 11:37:13.362 UTC [1527] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-plpgsql_check> server # [ 123.959496] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1525]: CREATE ROLE vm-test-run-plpgsql_check> server # [ 123.964352] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1525]: REVOKE vm-test-run-plpgsql_check> server # [ 123.971937] postgres[1527]: ::1 2026-10-11 11:37:13.384 UTC [1527] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-plpgsql_check> server # [ 123.975387] postgres[1527]: ::1 2026-10-11 11:37:13.399 UTC [1527] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-plpgsql_check> server # [ 124.055384] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1525]: CREATE SCHEMA vm-test-run-plpgsql_check> server # [ 124.059374] postgres[1527]: ::1 2026-10-11 11:37:13.496 UTC [1527] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-plpgsql_check> server # [ 124.067858] postgres[1527]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-plpgsql_check> server # [ 124.073668] postgres[1527]: $$ vm-test-run-plpgsql_check> server # [ 124.075441] postgres[1527]: BEGIN vm-test-run-plpgsql_check> server # [ 124.087033] postgres[1527]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-plpgsql_check> server # [ 124.088075] postgres[1527]: vm-test-run-plpgsql_check> server # [ 124.089882] postgres[1527]: RETURN QUERY vm-test-run-plpgsql_check> server # [ 124.091132] postgres[1527]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-plpgsql_check> server # [ 124.106081] postgres[1527]: WHERE usename = p_usename; vm-test-run-plpgsql_check> server # [ 124.107666] postgres[1527]: END; vm-test-run-plpgsql_check> server # [ 124.111301] postgres[1527]: $$ LANGUAGE plpgsql vm-test-run-plpgsql_check> server # [ 124.125763] postgres[1527]: SET search_path = '' vm-test-run-plpgsql_check> server # [ 124.137327] postgres[1527]: SECURITY DEFINER; vm-test-run-plpgsql_check> server # [ 124.138910] postgres[1527]: ::1 2026-10-11 11:37:13.530 UTC [1527] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-plpgsql_check> server # [ 124.154110] postgres[1527]: ::1 2026-10-11 11:37:13.545 UTC [1527] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-plpgsql_check> server # [ 124.155311] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1525]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 124.155919] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1525]: REVOKE vm-test-run-plpgsql_check> server # [ 124.156420] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1525]: GRANT vm-test-run-plpgsql_check> server # [ 124.208844] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running stat extension... vm-test-run-plpgsql_check> server # [ 124.730325] postgres[1541]: ::1 2026-10-11 11:37:14.157 UTC [1541] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-plpgsql_check> server # [ 124.754275] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1538]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-plpgsql_check> server # [ 124.783393] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1538]: CREATE SCHEMA vm-test-run-plpgsql_check> server # [ 124.784221] postgres[1541]: ::1 2026-10-11 11:37:14.225 UTC [1541] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-plpgsql_check> server # [ 126.075696] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1538]: CREATE EXTENSION vm-test-run-plpgsql_check> server # [ 126.159107] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-plpgsql_check> server # [ 126.524146] postgres[1558]: ::1 2026-10-11 11:37:15.958 UTC [1558] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-plpgsql_check> server # [ 126.544776] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1556]: GRANT vm-test-run-plpgsql_check> server # [ 126.555619] postgres[1558]: ::1 2026-10-11 11:37:15.982 UTC [1558] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-plpgsql_check> server # [ 126.562844] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1556]: GRANT vm-test-run-plpgsql_check> server # [ 126.573891] postgres[1558]: ::1 2026-10-11 11:37:16.009 UTC [1558] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-plpgsql_check> server # [ 126.584682] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1556]: GRANT vm-test-run-plpgsql_check> server # [ 126.588068] postgres[1558]: ::1 2026-10-11 11:37:16.028 UTC [1558] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-plpgsql_check> server # [ 126.607571] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1556]: GRANT vm-test-run-plpgsql_check> server # [ 126.609596] postgres[1558]: ::1 2026-10-11 11:37:16.048 UTC [1558] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-plpgsql_check> server # [ 126.617345] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1556]: GRANT vm-test-run-plpgsql_check> server # [ 126.618480] postgres[1558]: ::1 2026-10-11 11:37:16.060 UTC [1558] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-plpgsql_check> server # [ 126.630971] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1556]: GRANT vm-test-run-plpgsql_check> server # [ 126.631850] postgres[1558]: ::1 2026-10-11 11:37:16.071 UTC [1558] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-plpgsql_check> server # [ 126.639541] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1556]: GRANT vm-test-run-plpgsql_check> server # [ 126.643293] postgres[1558]: ::1 2026-10-11 11:37:16.076 UTC [1558] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-plpgsql_check> server # [ 126.655769] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1556]: GRANT vm-test-run-plpgsql_check> server # [ 126.657574] postgres[1558]: ::1 2026-10-11 11:37:16.098 UTC [1558] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-plpgsql_check> server # [ 126.709627] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1556]: GRANT vm-test-run-plpgsql_check> server # [ 126.734539] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1556]: DO vm-test-run-plpgsql_check> server # [ 126.737145] postgres[1558]: ::1 2026-10-11 11:37:16.178 UTC [1558] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-plpgsql_check> server # [ 126.746146] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1556]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 126.820226] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-plpgsql_check> server # [ 127.162621] postgres[1560]: ::1 2026-10-11 11:37:16.591 UTC [1560] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 127.199326] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: GRANT vm-test-run-plpgsql_check> server # [ 127.211963] postgres[1560]: ::1 2026-10-11 11:37:16.625 UTC [1560] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 127.214473] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: GRANT vm-test-run-plpgsql_check> server # [ 127.223727] postgres[1560]: ::1 2026-10-11 11:37:16.659 UTC [1560] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 127.238162] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: GRANT vm-test-run-plpgsql_check> server # [ 127.246189] postgres[1560]: ::1 2026-10-11 11:37:16.686 UTC [1560] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 127.267045] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: ALTER TABLE vm-test-run-plpgsql_check> server # [ 127.282506] postgres[1560]: ::1 2026-10-11 11:37:16.712 UTC [1560] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 127.293941] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: ALTER TABLE vm-test-run-plpgsql_check> server # [ 127.299065] postgres[1560]: ::1 2026-10-11 11:37:16.740 UTC [1560] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 127.319339] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: ALTER TABLE vm-test-run-plpgsql_check> server # [ 127.320493] postgres[1560]: ::1 2026-10-11 11:37:16.762 UTC [1560] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 127.333443] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: ALTER TABLE vm-test-run-plpgsql_check> server # [ 127.341351] postgres[1560]: ::1 2026-10-11 11:37:16.780 UTC [1560] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plpgsql_check> server # [ 127.349030] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: ALTER TABLE vm-test-run-plpgsql_check> server # [ 127.351601] postgres[1560]: ::1 2026-10-11 11:37:16.791 UTC [1560] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-plpgsql_check> server # [ 127.362967] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: GRANT vm-test-run-plpgsql_check> server # [ 127.363825] postgres[1560]: ::1 2026-10-11 11:37:16.806 UTC [1560] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 127.383260] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: GRANT vm-test-run-plpgsql_check> server # [ 127.384636] postgres[1560]: ::1 2026-10-11 11:37:16.826 UTC [1560] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 127.393877] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: GRANT vm-test-run-plpgsql_check> server # [ 127.395156] postgres[1560]: ::1 2026-10-11 11:37:16.836 UTC [1560] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 127.417847] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: GRANT vm-test-run-plpgsql_check> server # [ 127.420708] postgres[1560]: ::1 2026-10-11 11:37:16.861 UTC [1560] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 127.438649] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 127.439539] postgres[1560]: ::1 2026-10-11 11:37:16.881 UTC [1560] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 127.450892] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 127.451767] postgres[1560]: ::1 2026-10-11 11:37:16.893 UTC [1560] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 127.463210] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1559]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 127.545367] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-plpgsql_check> server # [ 128.122415] postgres[1575]: ::1 2026-10-11 11:37:17.536 UTC [1575] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-plpgsql_check> server # [ 128.211183] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1569]: CREATE SCHEMA vm-test-run-plpgsql_check> server # [ 128.219778] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-plpgsql_check> server # [ 128.798064] postgres[1588]: ::1 2026-10-11 11:37:18.223 UTC [1588] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-plpgsql_check> server # [ 128.811126] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1582]: GRANT vm-test-run-plpgsql_check> server # [ 128.812302] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1582]: GRANT vm-test-run-plpgsql_check> server # [ 128.812708] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1582]: GRANT vm-test-run-plpgsql_check> server # [ 128.821098] postgres[1588]: ::1 2026-10-11 11:37:18.246 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 128.822293] postgres[1588]: ::1 2026-10-11 11:37:18.252 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 128.823971] postgres[1588]: ::1 2026-10-11 11:37:18.258 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 128.835788] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1582]: GRANT vm-test-run-plpgsql_check> server # [ 128.904706] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-plpgsql_check> server # [ 129.291659] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1589]: DO vm-test-run-plpgsql_check> server # [ 129.302329] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1589]: DO vm-test-run-plpgsql_check> server # [ 129.314183] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1589]: DO vm-test-run-plpgsql_check> server # [ 129.356674] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-plpgsql_check> server # [ 129.599277] postgres[1592]: ::1 2026-10-11 11:37:19.033 UTC [1592] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 129.617938] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1591]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 129.621479] postgres[1592]: ::1 2026-10-11 11:37:19.062 UTC [1592] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 129.631698] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1591]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 129.636430] postgres[1592]: ::1 2026-10-11 11:37:19.075 UTC [1592] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user; vm-test-run-plpgsql_check> server # [ 129.643608] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1591]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 129.680836] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-plpgsql_check> server # [ 129.956096] postgres[1594]: ::1 2026-10-11 11:37:19.385 UTC [1594] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-plpgsql_check> server # [ 129.974583] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1593]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 130.037657] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-plpgsql_check> server # [ 130.385985] postgres[1599]: ::1 2026-10-11 11:37:19.803 UTC [1599] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plpgsql_check> server # [ 130.419539] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-plpgsql_check> server # [ 130.427100] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: DROP EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 130.437083] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-plpgsql_check> server # [ 130.439796] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: DROP FUNCTION vm-test-run-plpgsql_check> server # [ 130.450733] postgres[1599]: ::1 2026-10-11 11:37:19.836 UTC [1599] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plpgsql_check> server # [ 130.451836] postgres[1599]: ::1 2026-10-11 11:37:19.854 UTC [1599] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plpgsql_check> server # [ 130.452270] postgres[1599]: DECLARE vm-test-run-plpgsql_check> server # [ 130.459356] postgres[1599]: cmd record; vm-test-run-plpgsql_check> server # [ 130.461698] postgres[1599]: BEGIN vm-test-run-plpgsql_check> server # [ 130.462559] postgres[1599]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plpgsql_check> server # [ 130.473751] postgres[1599]: LOOP vm-test-run-plpgsql_check> server # [ 130.474694] postgres[1599]: IF cmd.command_tag IN ( vm-test-run-plpgsql_check> server # [ 130.475021] postgres[1599]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plpgsql_check> server # [ 130.475819] postgres[1599]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plpgsql_check> server # [ 130.476439] postgres[1599]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plpgsql_check> server # [ 130.476723] postgres[1599]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plpgsql_check> server # [ 130.485843] postgres[1599]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plpgsql_check> server # [ 130.487968] postgres[1599]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plpgsql_check> server # [ 130.500074] postgres[1599]: , 'CREATE TRIGGER' vm-test-run-plpgsql_check> server # [ 130.501934] postgres[1599]: , 'CREATE TYPE' vm-test-run-plpgsql_check> server # [ 130.502269] postgres[1599]: , 'CREATE RULE' vm-test-run-plpgsql_check> server # [ 130.503469] postgres[1599]: , 'COMMENT' vm-test-run-plpgsql_check> server # [ 130.505450] postgres[1599]: ) vm-test-run-plpgsql_check> server # [ 130.506070] postgres[1599]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plpgsql_check> server # [ 130.507479] postgres[1599]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plpgsql_check> server # [ 130.508778] postgres[1599]: THEN vm-test-run-plpgsql_check> server # [ 130.509351] postgres[1599]: NOTIFY pgrst, 'reload schema'; vm-test-run-plpgsql_check> server # [ 130.509719] postgres[1599]: END IF; vm-test-run-plpgsql_check> server # [ 130.513366] postgres[1599]: END LOOP; vm-test-run-plpgsql_check> server # [ 130.514132] postgres[1599]: END; $$ LANGUAGE plpgsql; vm-test-run-plpgsql_check> server # [ 130.515064] postgres[1599]: ::1 2026-10-11 11:37:19.911 UTC [1599] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plpgsql_check> server # [ 130.515765] postgres[1599]: DECLARE vm-test-run-plpgsql_check> server # [ 130.517837] postgres[1599]: obj record; vm-test-run-plpgsql_check> server # [ 130.519110] postgres[1599]: BEGIN vm-test-run-plpgsql_check> server # [ 130.519392] postgres[1599]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plpgsql_check> server # [ 130.519760] postgres[1599]: LOOP vm-test-run-plpgsql_check> server # [ 130.520161] postgres[1599]: IF obj.object_type IN ( vm-test-run-plpgsql_check> server # [ 130.520484] postgres[1599]: 'schema' vm-test-run-plpgsql_check> server # [ 130.521583] postgres[1599]: , 'table' vm-test-run-plpgsql_check> server # [ 130.523259] postgres[1599]: , 'foreign table' vm-test-run-plpgsql_check> server # [ 130.524082] postgres[1599]: , 'view' vm-test-run-plpgsql_check> server # [ 130.525488] postgres[1599]: , 'materialized view' vm-test-run-plpgsql_check> server # [ 130.526847] postgres[1599]: , 'function' vm-test-run-plpgsql_check> server # [ 130.527590] postgres[1599]: , 'trigger' vm-test-run-plpgsql_check> server # [ 130.528558] postgres[1599]: , 'type' vm-test-run-plpgsql_check> server # [ 130.529359] postgres[1599]: , 'rule' vm-test-run-plpgsql_check> server # [ 130.530863] postgres[1599]: ) vm-test-run-plpgsql_check> server # [ 130.532755] postgres[1599]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plpgsql_check> server # [ 130.533400] postgres[1599]: THEN vm-test-run-plpgsql_check> server # [ 130.534941] postgres[1599]: NOTIFY pgrst, 'reload schema'; vm-test-run-plpgsql_check> server # [ 130.536911] postgres[1599]: END IF; vm-test-run-plpgsql_check> server # [ 130.537563] postgres[1599]: END LOOP; vm-test-run-plpgsql_check> server # [ 130.537827] postgres[1599]: END; $$ LANGUAGE plpgsql; vm-test-run-plpgsql_check> server # [ 130.538072] postgres[1599]: ::1 2026-10-11 11:37:19.926 UTC [1599] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plpgsql_check> server # [ 130.541283] postgres[1599]: ::1 2026-10-11 11:37:19.957 UTC [1599] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plpgsql_check> server # [ 130.541776] postgres[1599]: ON ddl_command_end vm-test-run-plpgsql_check> server # [ 130.542380] postgres[1599]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plpgsql_check> server # [ 130.542999] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 130.543384] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 130.543663] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-plpgsql_check> server # [ 130.544745] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: DROP EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 130.553239] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: CREATE EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 130.554620] postgres[1599]: ::1 2026-10-11 11:37:19.996 UTC [1599] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plpgsql_check> server # [ 130.557846] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-plpgsql_check> server # [ 130.558974] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: DROP EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 130.559403] postgres[1599]: ::1 2026-10-11 11:37:20.002 UTC [1599] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plpgsql_check> server # [ 130.559761] postgres[1599]: ON sql_drop vm-test-run-plpgsql_check> server # [ 130.559997] postgres[1599]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plpgsql_check> server # [ 130.570462] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: CREATE EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 130.612864] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-plpgsql_check> server # [ 132.089687] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1606]: DO vm-test-run-plpgsql_check> server # [ 132.134442] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-plpgsql_check> server # [ 132.403951] postgres[1626]: ::1 2026-10-11 11:37:21.836 UTC [1626] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-plpgsql_check> server # [ 132.490332] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: CREATE SCHEMA vm-test-run-plpgsql_check> server # [ 132.502762] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping vm-test-run-plpgsql_check> server # [ 132.503676] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: DROP FUNCTION vm-test-run-plpgsql_check> server # [ 132.511654] postgres[1626]: ::1 2026-10-11 11:37:21.913 UTC [1626] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-plpgsql_check> server # [ 132.515478] postgres[1626]: ::1 2026-10-11 11:37:21.927 UTC [1626] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plpgsql_check> server # [ 132.520777] postgres[1626]: "operationName" text default null, vm-test-run-plpgsql_check> server # [ 132.521650] postgres[1626]: query text default null, vm-test-run-plpgsql_check> server # [ 132.522826] postgres[1626]: variables jsonb default null, vm-test-run-plpgsql_check> server # [ 132.523523] postgres[1626]: extensions jsonb default null vm-test-run-plpgsql_check> server # [ 132.523836] postgres[1626]: ) vm-test-run-plpgsql_check> server # [ 132.524073] postgres[1626]: returns jsonb vm-test-run-plpgsql_check> server # [ 132.529389] postgres[1626]: language plpgsql vm-test-run-plpgsql_check> server # [ 132.533838] postgres[1626]: as $$ vm-test-run-plpgsql_check> server # [ 132.540180] postgres[1626]: DECLARE vm-test-run-plpgsql_check> server # [ 132.540568] postgres[1626]: server_version float; vm-test-run-plpgsql_check> server # [ 132.541704] postgres[1626]: BEGIN vm-test-run-plpgsql_check> server # [ 132.546163] postgres[1626]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plpgsql_check> server # [ 132.546635] postgres[1626]: vm-test-run-plpgsql_check> server # [ 132.546867] postgres[1626]: IF server_version >= 14 THEN vm-test-run-plpgsql_check> server # [ 132.547120] postgres[1626]: RETURN jsonb_build_object( vm-test-run-plpgsql_check> server # [ 132.547358] postgres[1626]: 'data', null::jsonb, vm-test-run-plpgsql_check> server # [ 132.547938] postgres[1626]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plpgsql_check> server # [ 132.559075] postgres[1626]: ); vm-test-run-plpgsql_check> server # [ 132.559755] postgres[1626]: ELSE vm-test-run-plpgsql_check> server # [ 132.561787] postgres[1626]: RETURN jsonb_build_object( vm-test-run-plpgsql_check> server # [ 132.562292] postgres[1626]: 'data', null::jsonb, vm-test-run-plpgsql_check> server # [ 132.562596] postgres[1626]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plpgsql_check> server # [ 132.563532] postgres[1626]: ); vm-test-run-plpgsql_check> server # [ 132.564047] postgres[1626]: END IF; vm-test-run-plpgsql_check> server # [ 132.574435] postgres[1626]: END; vm-test-run-plpgsql_check> server # [ 132.575082] postgres[1626]: $$; vm-test-run-plpgsql_check> server # [ 132.575357] postgres[1626]: ::1 2026-10-11 11:37:21.952 UTC [1626] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.576073] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 132.584864] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: GRANT vm-test-run-plpgsql_check> server # [ 132.585678] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 132.586434] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 132.586927] postgres[1626]: ::1 2026-10-11 11:37:21.980 UTC [1626] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.587754] postgres[1626]: ::1 2026-10-11 11:37:22.001 UTC [1626] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.589518] postgres[1626]: ::1 2026-10-11 11:37:22.018 UTC [1626] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.590362] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 132.591240] postgres[1626]: ::1 2026-10-11 11:37:22.029 UTC [1626] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plpgsql_check> server # [ 132.591738] postgres[1626]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.600829] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 132.605339] postgres[1626]: ::1 2026-10-11 11:37:22.044 UTC [1626] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plpgsql_check> server # [ 132.606615] postgres[1626]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.613556] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 132.623343] postgres[1626]: ::1 2026-10-11 11:37:22.058 UTC [1626] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plpgsql_check> server # [ 132.627980] postgres[1626]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.643387] postgres[1626]: ::1 2026-10-11 11:37:22.080 UTC [1626] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-plpgsql_check> server # [ 132.646300] postgres[1626]: RETURNS event_trigger vm-test-run-plpgsql_check> server # [ 132.646888] postgres[1626]: LANGUAGE plpgsql vm-test-run-plpgsql_check> server # [ 132.647731] postgres[1626]: AS $func$ vm-test-run-plpgsql_check> server # [ 132.649754] postgres[1626]: DECLARE vm-test-run-plpgsql_check> server # [ 132.653914] postgres[1626]: func_is_graphql_resolve bool; vm-test-run-plpgsql_check> server # [ 132.654322] postgres[1626]: BEGIN vm-test-run-plpgsql_check> server # [ 132.654666] postgres[1626]: func_is_graphql_resolve = ( vm-test-run-plpgsql_check> server # [ 132.655564] postgres[1626]: SELECT n.proname = 'resolve' vm-test-run-plpgsql_check> server # [ 132.655903] postgres[1626]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plpgsql_check> server # [ 132.657521] postgres[1626]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plpgsql_check> server # [ 132.657987] postgres[1626]: ON ev.objid = n.oid vm-test-run-plpgsql_check> server # [ 132.658572] postgres[1626]: ); vm-test-run-plpgsql_check> server # [ 132.659135] postgres[1626]: vm-test-run-plpgsql_check> server # [ 132.660419] postgres[1626]: IF func_is_graphql_resolve vm-test-run-plpgsql_check> server # [ 132.662077] postgres[1626]: THEN vm-test-run-plpgsql_check> server # [ 132.662402] postgres[1626]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.663340] postgres[1626]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.665690] postgres[1626]: vm-test-run-plpgsql_check> server # [ 132.666279] postgres[1626]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.667004] postgres[1626]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.667646] postgres[1626]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.668463] postgres[1626]: vm-test-run-plpgsql_check> server # [ 132.668788] postgres[1626]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plpgsql_check> server # [ 132.669943] postgres[1626]: create or replace function graphql_public.graphql( vm-test-run-plpgsql_check> server # [ 132.670983] postgres[1626]: "operationName" text default null, vm-test-run-plpgsql_check> server # [ 132.671303] postgres[1626]: query text default null, vm-test-run-plpgsql_check> server # [ 132.673845] postgres[1626]: variables jsonb default null, vm-test-run-plpgsql_check> server # [ 132.674321] postgres[1626]: extensions jsonb default null vm-test-run-plpgsql_check> server # [ 132.674607] postgres[1626]: ) vm-test-run-plpgsql_check> server # [ 132.675113] postgres[1626]: returns jsonb vm-test-run-plpgsql_check> server # [ 132.675396] postgres[1626]: language sql vm-test-run-plpgsql_check> server # [ 132.675651] postgres[1626]: as $$ vm-test-run-plpgsql_check> server # [ 132.675882] postgres[1626]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-plpgsql_check> server # [ 132.676287] postgres[1626]: $$; vm-test-run-plpgsql_check> server # [ 132.678164] postgres[1626]: vm-test-run-plpgsql_check> server # [ 132.678752] postgres[1626]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 132.679108] postgres[1626]: END IF; vm-test-run-plpgsql_check> server # [ 132.679454] postgres[1626]: vm-test-run-plpgsql_check> server # [ 132.679843] postgres[1626]: END; vm-test-run-plpgsql_check> server # [ 132.680106] postgres[1626]: $func$; vm-test-run-plpgsql_check> server # [ 132.681922] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 132.682953] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 132.685925] postgres[1626]: ::1 2026-10-11 11:37:22.122 UTC [1626] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-plpgsql_check> server # [ 132.695009] postgres[1626]: ::1 2026-10-11 11:37:22.133 UTC [1626] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION') vm-test-run-plpgsql_check> server # [ 132.696189] postgres[1626]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-plpgsql_check> server # [ 132.700567] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping vm-test-run-plpgsql_check> server # [ 132.705873] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: DROP EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 132.709382] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: CREATE EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 132.710155] postgres[1626]: ::1 2026-10-11 11:37:22.150 UTC [1626] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-plpgsql_check> server # [ 132.724705] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: COMMENT vm-test-run-plpgsql_check> server # [ 132.725586] postgres[1626]: ::1 2026-10-11 11:37:22.166 UTC [1626] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plpgsql_check> server # [ 132.730968] postgres[1626]: RETURNS event_trigger vm-test-run-plpgsql_check> server # [ 132.732041] postgres[1626]: LANGUAGE plpgsql vm-test-run-plpgsql_check> server # [ 132.739839] postgres[1626]: AS $func$ vm-test-run-plpgsql_check> server # [ 132.744043] postgres[1626]: DECLARE vm-test-run-plpgsql_check> server # [ 132.745832] postgres[1626]: graphql_is_dropped bool; vm-test-run-plpgsql_check> server # [ 132.748652] postgres[1626]: BEGIN vm-test-run-plpgsql_check> server # [ 132.750409] postgres[1626]: graphql_is_dropped = ( vm-test-run-plpgsql_check> server # [ 132.751420] postgres[1626]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plpgsql_check> server # [ 132.752328] postgres[1626]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plpgsql_check> server # [ 132.753441] postgres[1626]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plpgsql_check> server # [ 132.754622] postgres[1626]: ); vm-test-run-plpgsql_check> server # [ 132.755035] postgres[1626]: vm-test-run-plpgsql_check> server # [ 132.756846] postgres[1626]: IF graphql_is_dropped vm-test-run-plpgsql_check> server # [ 132.757389] postgres[1626]: THEN vm-test-run-plpgsql_check> server # [ 132.757743] postgres[1626]: create or replace function graphql_public.graphql( vm-test-run-plpgsql_check> server # [ 132.758280] postgres[1626]: "operationName" text default null, vm-test-run-plpgsql_check> server # [ 132.760062] postgres[1626]: query text default null, vm-test-run-plpgsql_check> server # [ 132.762629] postgres[1626]: variables jsonb default null, vm-test-run-plpgsql_check> server # [ 132.763500] postgres[1626]: extensions jsonb default null vm-test-run-plpgsql_check> server # [ 132.765907] postgres[1626]: ) vm-test-run-plpgsql_check> server # [ 132.766299] postgres[1626]: returns jsonb vm-test-run-plpgsql_check> server # [ 132.766815] postgres[1626]: language plpgsql vm-test-run-plpgsql_check> server # [ 132.767221] postgres[1626]: as $$ vm-test-run-plpgsql_check> server # [ 132.767482] postgres[1626]: DECLARE vm-test-run-plpgsql_check> server # [ 132.768098] postgres[1626]: server_version float; vm-test-run-plpgsql_check> server # [ 132.769497] postgres[1626]: BEGIN vm-test-run-plpgsql_check> server # [ 132.770731] postgres[1626]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plpgsql_check> server # [ 132.774932] postgres[1626]: vm-test-run-plpgsql_check> server # [ 132.776060] postgres[1626]: IF server_version >= 14 THEN vm-test-run-plpgsql_check> server # [ 132.777683] postgres[1626]: RETURN jsonb_build_object( vm-test-run-plpgsql_check> server # [ 132.778155] postgres[1626]: 'data', null::jsonb, vm-test-run-plpgsql_check> server # [ 132.779621] postgres[1626]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plpgsql_check> server # [ 132.781807] postgres[1626]: ); vm-test-run-plpgsql_check> server # [ 132.783449] postgres[1626]: ELSE vm-test-run-plpgsql_check> server # [ 132.787312] postgres[1626]: RETURN jsonb_build_object( vm-test-run-plpgsql_check> server # [ 132.787943] postgres[1626]: 'data', null::jsonb, vm-test-run-plpgsql_check> server # [ 132.789927] postgres[1626]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plpgsql_check> server # [ 132.790732] postgres[1626]: ); vm-test-run-plpgsql_check> server # [ 132.791029] postgres[1626]: END IF; vm-test-run-plpgsql_check> server # [ 132.791278] postgres[1626]: END; vm-test-run-plpgsql_check> server # [ 132.791655] postgres[1626]: $$; vm-test-run-plpgsql_check> server # [ 132.791919] postgres[1626]: END IF; vm-test-run-plpgsql_check> server # [ 132.792128] postgres[1626]: vm-test-run-plpgsql_check> server # [ 132.794029] postgres[1626]: END; vm-test-run-plpgsql_check> server # [ 132.794421] postgres[1626]: $func$; vm-test-run-plpgsql_check> server # [ 132.821317] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 132.828859] postgres[1626]: ::1 2026-10-11 11:37:22.268 UTC [1626] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-plpgsql_check> server # [ 132.830413] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping vm-test-run-plpgsql_check> server # [ 132.841967] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: DROP EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 132.842831] postgres[1626]: ::1 2026-10-11 11:37:22.279 UTC [1626] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-plpgsql_check> server # [ 132.844006] postgres[1626]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-plpgsql_check> server # [ 132.853046] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: CREATE EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 132.854645] postgres[1626]: ::1 2026-10-11 11:37:22.293 UTC [1626] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql'; vm-test-run-plpgsql_check> server # [ 132.873581] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1623]: COMMENT vm-test-run-plpgsql_check> server # [ 132.921111] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-plpgsql_check> server # [ 133.207301] postgres[1630]: ::1 2026-10-11 11:37:22.635 UTC [1630] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plpgsql_check> server # [ 133.214295] postgres[1630]: ::1 2026-10-11 11:37:22.641 UTC [1630] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plpgsql_check> server # [ 133.232075] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1629]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-plpgsql_check> server # [ 133.234157] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1629]: DROP EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 133.235499] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1629]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-plpgsql_check> server # [ 133.238271] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1629]: DROP FUNCTION vm-test-run-plpgsql_check> server # [ 133.239134] postgres[1630]: ::1 2026-10-11 11:37:22.662 UTC [1630] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plpgsql_check> server # [ 133.245548] postgres[1630]: DECLARE vm-test-run-plpgsql_check> server # [ 133.253115] postgres[1630]: cmd record; vm-test-run-plpgsql_check> server # [ 133.260829] postgres[1630]: BEGIN vm-test-run-plpgsql_check> server # [ 133.262211] postgres[1630]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plpgsql_check> server # [ 133.262696] postgres[1630]: LOOP vm-test-run-plpgsql_check> server # [ 133.262990] postgres[1630]: IF cmd.command_tag IN ( vm-test-run-plpgsql_check> server # [ 133.263503] postgres[1630]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plpgsql_check> server # [ 133.265529] postgres[1630]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plpgsql_check> server # [ 133.267579] postgres[1630]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plpgsql_check> server # [ 133.267983] postgres[1630]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plpgsql_check> server # [ 133.270011] postgres[1630]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plpgsql_check> server # [ 133.270687] postgres[1630]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plpgsql_check> server # [ 133.271558] postgres[1630]: , 'CREATE TRIGGER' vm-test-run-plpgsql_check> server # [ 133.271970] postgres[1630]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-plpgsql_check> server # [ 133.273818] postgres[1630]: , 'CREATE RULE' vm-test-run-plpgsql_check> server # [ 133.274427] postgres[1630]: , 'COMMENT' vm-test-run-plpgsql_check> server # [ 133.275220] postgres[1630]: ) vm-test-run-plpgsql_check> server # [ 133.275518] postgres[1630]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plpgsql_check> server # [ 133.276053] postgres[1630]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plpgsql_check> server # [ 133.279287] postgres[1630]: THEN vm-test-run-plpgsql_check> server # [ 133.279855] postgres[1630]: NOTIFY pgrst, 'reload schema'; vm-test-run-plpgsql_check> server # [ 133.280135] postgres[1630]: END IF; vm-test-run-plpgsql_check> server # [ 133.280364] postgres[1630]: END LOOP; vm-test-run-plpgsql_check> server # [ 133.280577] postgres[1630]: END; $$ LANGUAGE plpgsql; vm-test-run-plpgsql_check> server # [ 133.280968] postgres[1630]: ::1 2026-10-11 11:37:22.721 UTC [1630] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plpgsql_check> server # [ 133.281637] postgres[1630]: DECLARE vm-test-run-plpgsql_check> server # [ 133.282878] postgres[1630]: obj record; vm-test-run-plpgsql_check> server # [ 133.283340] postgres[1630]: BEGIN vm-test-run-plpgsql_check> server # [ 133.283810] postgres[1630]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plpgsql_check> server # [ 133.284547] postgres[1630]: LOOP vm-test-run-plpgsql_check> server # [ 133.285243] postgres[1630]: IF obj.object_type IN ( vm-test-run-plpgsql_check> server # [ 133.285577] postgres[1630]: 'schema' vm-test-run-plpgsql_check> server # [ 133.286619] postgres[1630]: , 'table' vm-test-run-plpgsql_check> server # [ 133.287320] postgres[1630]: , 'foreign table' vm-test-run-plpgsql_check> server # [ 133.287946] postgres[1630]: , 'view' vm-test-run-plpgsql_check> server # [ 133.288439] postgres[1630]: , 'materialized view' vm-test-run-plpgsql_check> server # [ 133.288766] postgres[1630]: , 'function' vm-test-run-plpgsql_check> server # [ 133.289433] postgres[1630]: , 'trigger' vm-test-run-plpgsql_check> server # [ 133.290023] postgres[1630]: , 'type' vm-test-run-plpgsql_check> server # [ 133.290506] postgres[1630]: , 'rule' vm-test-run-plpgsql_check> server # [ 133.290871] postgres[1630]: ) vm-test-run-plpgsql_check> server # [ 133.291701] postgres[1630]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plpgsql_check> server # [ 133.292168] postgres[1630]: THEN vm-test-run-plpgsql_check> server # [ 133.292859] postgres[1630]: NOTIFY pgrst, 'reload schema'; vm-test-run-plpgsql_check> server # [ 133.293676] postgres[1630]: END IF; vm-test-run-plpgsql_check> server # [ 133.293929] postgres[1630]: END LOOP; vm-test-run-plpgsql_check> server # [ 133.294165] postgres[1630]: END; $$ LANGUAGE plpgsql; vm-test-run-plpgsql_check> server # [ 133.294896] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1629]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 133.309658] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1629]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 133.310885] postgres[1630]: ::1 2026-10-11 11:37:22.753 UTC [1630] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plpgsql_check> server # [ 133.321643] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1629]: DROP EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 133.326953] postgres[1630]: ::1 2026-10-11 11:37:22.766 UTC [1630] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plpgsql_check> server # [ 133.328951] postgres[1630]: ON ddl_command_end vm-test-run-plpgsql_check> server # [ 133.330013] postgres[1630]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plpgsql_check> server # [ 133.332871] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1629]: CREATE EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 133.334249] postgres[1630]: ::1 2026-10-11 11:37:22.776 UTC [1630] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plpgsql_check> server # [ 133.343417] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1629]: DROP EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 133.345431] postgres[1630]: ::1 2026-10-11 11:37:22.787 UTC [1630] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plpgsql_check> server # [ 133.345944] postgres[1630]: ON sql_drop vm-test-run-plpgsql_check> server # [ 133.346619] postgres[1630]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plpgsql_check> server # [ 133.354692] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1629]: CREATE EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 133.408149] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-plpgsql_check> server # [ 133.721524] postgres[1633]: ::1 2026-10-11 11:37:23.154 UTC [1633] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-plpgsql_check> server # [ 133.755820] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1631]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 133.809080] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-plpgsql_check> server # [ 134.342164] postgres[1647]: ::1 2026-10-11 11:37:23.766 UTC [1647] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plpgsql_check> server # [ 134.361520] postgres[1647]: returns event_trigger vm-test-run-plpgsql_check> server # [ 134.362358] postgres[1647]: language plpgsql vm-test-run-plpgsql_check> server # [ 134.363143] postgres[1647]: AS $func$ vm-test-run-plpgsql_check> server # [ 134.369863] postgres[1647]: DECLARE vm-test-run-plpgsql_check> server # [ 134.371711] postgres[1647]: func_is_graphql_resolve bool; vm-test-run-plpgsql_check> server # [ 134.381545] postgres[1647]: BEGIN vm-test-run-plpgsql_check> server # [ 134.383085] postgres[1647]: func_is_graphql_resolve = ( vm-test-run-plpgsql_check> server # [ 134.383545] postgres[1647]: SELECT n.proname = 'resolve' vm-test-run-plpgsql_check> server # [ 134.390659] postgres[1647]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plpgsql_check> server # [ 134.402664] postgres[1647]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plpgsql_check> server # [ 134.403439] postgres[1647]: ON ev.objid = n.oid vm-test-run-plpgsql_check> server # [ 134.404113] postgres[1647]: ); vm-test-run-plpgsql_check> server # [ 134.410667] postgres[1647]: vm-test-run-plpgsql_check> server # [ 134.412926] postgres[1647]: IF func_is_graphql_resolve vm-test-run-plpgsql_check> server # [ 134.423344] postgres[1647]: THEN vm-test-run-plpgsql_check> server # [ 134.430326] postgres[1647]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 134.437504] postgres[1647]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 134.438163] postgres[1647]: vm-test-run-plpgsql_check> server # [ 134.439810] postgres[1647]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 134.446939] postgres[1647]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 134.447859] postgres[1647]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 134.459179] postgres[1647]: vm-test-run-plpgsql_check> server # [ 134.459793] postgres[1647]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plpgsql_check> server # [ 134.465847] postgres[1647]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plpgsql_check> server # [ 134.466747] postgres[1647]: create or replace function graphql_public.graphql( vm-test-run-plpgsql_check> server # [ 134.467833] postgres[1647]: "operationName" text default null, vm-test-run-plpgsql_check> server # [ 134.468340] postgres[1647]: query text default null, vm-test-run-plpgsql_check> server # [ 134.479983] postgres[1647]: variables jsonb default null, vm-test-run-plpgsql_check> server # [ 134.486494] postgres[1647]: extensions jsonb default null vm-test-run-plpgsql_check> server # [ 134.497648] postgres[1647]: ) vm-test-run-plpgsql_check> server # [ 134.498266] postgres[1647]: returns jsonb vm-test-run-plpgsql_check> server # [ 134.498663] postgres[1647]: language sql vm-test-run-plpgsql_check> server # [ 134.499254] postgres[1647]: as $$ vm-test-run-plpgsql_check> server # [ 134.499563] postgres[1647]: -- This changed vm-test-run-plpgsql_check> server # [ 134.509534] postgres[1647]: select graphql.resolve( vm-test-run-plpgsql_check> server # [ 134.511499] postgres[1647]: query := query, vm-test-run-plpgsql_check> server # [ 134.521898] postgres[1647]: variables := coalesce(variables, '{}'), vm-test-run-plpgsql_check> server # [ 134.529477] postgres[1647]: "operationName" := "operationName", vm-test-run-plpgsql_check> server # [ 134.530530] postgres[1647]: extensions := extensions vm-test-run-plpgsql_check> server # [ 134.539897] postgres[1647]: ); vm-test-run-plpgsql_check> server # [ 134.550397] postgres[1647]: $$; vm-test-run-plpgsql_check> server # [ 134.551115] postgres[1647]: vm-test-run-plpgsql_check> server # [ 134.551524] postgres[1647]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 134.560856] postgres[1647]: END IF; vm-test-run-plpgsql_check> server # [ 134.562340] postgres[1647]: vm-test-run-plpgsql_check> server # [ 134.562686] postgres[1647]: END; vm-test-run-plpgsql_check> server # [ 134.563169] postgres[1647]: $func$; vm-test-run-plpgsql_check> server # [ 134.578981] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1640]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 134.590073] postgres[1647]: ::1 2026-10-11 11:37:24.020 UTC [1647] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plpgsql_check> server # [ 134.590967] postgres[1647]: RETURNS event_trigger vm-test-run-plpgsql_check> server # [ 134.591777] postgres[1647]: LANGUAGE plpgsql vm-test-run-plpgsql_check> server # [ 134.598872] postgres[1647]: AS $func$ vm-test-run-plpgsql_check> server # [ 134.608478] postgres[1647]: DECLARE vm-test-run-plpgsql_check> server # [ 134.613052] postgres[1647]: graphql_is_dropped bool; vm-test-run-plpgsql_check> server # [ 134.613818] postgres[1647]: BEGIN vm-test-run-plpgsql_check> server # [ 134.626526] postgres[1647]: graphql_is_dropped = ( vm-test-run-plpgsql_check> server # [ 134.629158] postgres[1647]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plpgsql_check> server # [ 134.630367] postgres[1647]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plpgsql_check> server # [ 134.630693] postgres[1647]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plpgsql_check> server # [ 134.630945] postgres[1647]: ); vm-test-run-plpgsql_check> server # [ 134.631361] postgres[1647]: vm-test-run-plpgsql_check> server # [ 134.634376] postgres[1647]: IF graphql_is_dropped vm-test-run-plpgsql_check> server # [ 134.635342] postgres[1647]: THEN vm-test-run-plpgsql_check> server # [ 134.637113] postgres[1647]: create or replace function graphql_public.graphql( vm-test-run-plpgsql_check> server # [ 134.639168] postgres[1647]: "operationName" text default null, vm-test-run-plpgsql_check> server # [ 134.641157] postgres[1647]: query text default null, vm-test-run-plpgsql_check> server # [ 134.643629] postgres[1647]: variables jsonb default null, vm-test-run-plpgsql_check> server # [ 134.644556] postgres[1647]: extensions jsonb default null vm-test-run-plpgsql_check> server # [ 134.645387] postgres[1647]: ) vm-test-run-plpgsql_check> server # [ 134.646929] postgres[1647]: returns jsonb vm-test-run-plpgsql_check> server # [ 134.647415] postgres[1647]: language plpgsql vm-test-run-plpgsql_check> server # [ 134.648866] postgres[1647]: as $$ vm-test-run-plpgsql_check> server # [ 134.649336] postgres[1647]: DECLARE vm-test-run-plpgsql_check> server # [ 134.649605] postgres[1647]: server_version float; vm-test-run-plpgsql_check> server # [ 134.649952] postgres[1647]: BEGIN vm-test-run-plpgsql_check> server # [ 134.651154] postgres[1647]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plpgsql_check> server # [ 134.651686] postgres[1647]: vm-test-run-plpgsql_check> server # [ 134.651954] postgres[1647]: IF server_version >= 14 THEN vm-test-run-plpgsql_check> server # [ 134.652635] postgres[1647]: RETURN jsonb_build_object( vm-test-run-plpgsql_check> server # [ 134.652997] postgres[1647]: 'errors', jsonb_build_array( vm-test-run-plpgsql_check> server # [ 134.654045] postgres[1647]: jsonb_build_object( vm-test-run-plpgsql_check> server # [ 134.655046] postgres[1647]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plpgsql_check> server # [ 134.656380] postgres[1647]: ) vm-test-run-plpgsql_check> server # [ 134.658362] postgres[1647]: ) vm-test-run-plpgsql_check> server # [ 134.659810] postgres[1647]: ); vm-test-run-plpgsql_check> server # [ 134.660305] postgres[1647]: ELSE vm-test-run-plpgsql_check> server # [ 134.662244] postgres[1647]: RETURN jsonb_build_object( vm-test-run-plpgsql_check> server # [ 134.662570] postgres[1647]: 'errors', jsonb_build_array( vm-test-run-plpgsql_check> server # [ 134.662817] postgres[1647]: jsonb_build_object( vm-test-run-plpgsql_check> server # [ 134.663213] postgres[1647]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plpgsql_check> server # [ 134.664613] postgres[1647]: ) vm-test-run-plpgsql_check> server # [ 134.665965] postgres[1647]: ) vm-test-run-plpgsql_check> server # [ 134.666440] postgres[1647]: ); vm-test-run-plpgsql_check> server # [ 134.666744] postgres[1647]: END IF; vm-test-run-plpgsql_check> server # [ 134.668117] postgres[1647]: END; vm-test-run-plpgsql_check> server # [ 134.668962] postgres[1647]: $$; vm-test-run-plpgsql_check> server # [ 134.670471] postgres[1647]: END IF; vm-test-run-plpgsql_check> server # [ 134.671008] postgres[1647]: vm-test-run-plpgsql_check> server # [ 134.671260] postgres[1647]: END; vm-test-run-plpgsql_check> server # [ 134.671500] postgres[1647]: $func$; vm-test-run-plpgsql_check> server # [ 134.672269] postgres[1647]: ::1 2026-10-11 11:37:24.052 UTC [1647] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plpgsql_check> server # [ 134.674990] postgres[1647]: "operationName" text default null, vm-test-run-plpgsql_check> server # [ 134.675714] postgres[1647]: query text default null, vm-test-run-plpgsql_check> server # [ 134.676246] postgres[1647]: variables jsonb default null, vm-test-run-plpgsql_check> server # [ 134.677993] postgres[1647]: extensions jsonb default null vm-test-run-plpgsql_check> server # [ 134.678461] postgres[1647]: ) vm-test-run-plpgsql_check> server # [ 134.681118] postgres[1647]: returns jsonb vm-test-run-plpgsql_check> server # [ 134.686495] postgres[1647]: language plpgsql vm-test-run-plpgsql_check> server # [ 134.687274] postgres[1647]: as $$ vm-test-run-plpgsql_check> server # [ 134.688106] postgres[1647]: DECLARE vm-test-run-plpgsql_check> server # [ 134.693297] postgres[1647]: server_version float; vm-test-run-plpgsql_check> server # [ 134.694597] postgres[1647]: BEGIN vm-test-run-plpgsql_check> server # [ 134.695670] postgres[1647]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plpgsql_check> server # [ 134.696439] postgres[1647]: vm-test-run-plpgsql_check> server # [ 134.712020] postgres[1647]: IF server_version >= 14 THEN vm-test-run-plpgsql_check> server # [ 134.714386] postgres[1647]: RETURN jsonb_build_object( vm-test-run-plpgsql_check> server # [ 134.726143] postgres[1647]: 'errors', jsonb_build_array( vm-test-run-plpgsql_check> server # [ 134.740730] postgres[1647]: jsonb_build_object( vm-test-run-plpgsql_check> server # [ 134.742947] postgres[1647]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plpgsql_check> server # [ 134.748167] postgres[1647]: ) vm-test-run-plpgsql_check> server # [ 134.753397] postgres[1647]: ) vm-test-run-plpgsql_check> server # [ 134.766186] postgres[1647]: ); vm-test-run-plpgsql_check> server # [ 134.772963] postgres[1647]: ELSE vm-test-run-plpgsql_check> server # [ 134.779204] postgres[1647]: RETURN jsonb_build_object( vm-test-run-plpgsql_check> server # [ 134.785511] postgres[1647]: 'errors', jsonb_build_array( vm-test-run-plpgsql_check> server # [ 134.785995] postgres[1647]: jsonb_build_object( vm-test-run-plpgsql_check> server # [ 134.787181] postgres[1647]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plpgsql_check> server # [ 134.805807] postgres[1647]: ) vm-test-run-plpgsql_check> server # [ 134.811206] postgres[1647]: ) vm-test-run-plpgsql_check> server # [ 134.821551] postgres[1647]: ); vm-test-run-plpgsql_check> server # [ 134.826481] postgres[1647]: END IF; vm-test-run-plpgsql_check> server # [ 134.836508] postgres[1647]: END; vm-test-run-plpgsql_check> server # [ 134.837447] postgres[1647]: $$; vm-test-run-plpgsql_check> server # [ 134.848473] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1640]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 134.849540] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1640]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 134.850912] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1640]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping vm-test-run-plpgsql_check> server # [ 134.858995] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1640]: DROP EXTENSION vm-test-run-plpgsql_check> server # [ 134.871226] postgres[1647]: ::1 2026-10-11 11:37:24.132 UTC [1647] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plpgsql_check> server # [ 136.343926] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1640]: DO vm-test-run-plpgsql_check> server # [ 136.404027] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql vm-test-run-plpgsql_check> server # [ 136.809397] postgres[1664]: ::1 2026-10-11 11:37:26.231 UTC [1664] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-plpgsql_check> server # [ 136.877114] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1662]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 136.913038] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-plpgsql_check> server # [ 137.395740] postgres[1674]: ::1 2026-10-11 11:37:26.832 UTC [1674] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plpgsql_check> server # [ 137.402780] postgres[1674]: returns event_trigger vm-test-run-plpgsql_check> server # [ 137.403609] postgres[1674]: language plpgsql vm-test-run-plpgsql_check> server # [ 137.405698] postgres[1674]: AS $func$ vm-test-run-plpgsql_check> server # [ 137.406578] postgres[1674]: DECLARE vm-test-run-plpgsql_check> server # [ 137.406972] postgres[1674]: func_is_graphql_resolve bool; vm-test-run-plpgsql_check> server # [ 137.407287] postgres[1674]: BEGIN vm-test-run-plpgsql_check> server # [ 137.407531] postgres[1674]: func_is_graphql_resolve = ( vm-test-run-plpgsql_check> server # [ 137.407943] postgres[1674]: SELECT n.proname = 'resolve' vm-test-run-plpgsql_check> server # [ 137.409242] postgres[1674]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plpgsql_check> server # [ 137.418071] postgres[1674]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plpgsql_check> server # [ 137.418613] postgres[1674]: ON ev.objid = n.oid vm-test-run-plpgsql_check> server # [ 137.418900] postgres[1674]: ); vm-test-run-plpgsql_check> server # [ 137.420009] postgres[1674]: vm-test-run-plpgsql_check> server # [ 137.421715] postgres[1674]: IF func_is_graphql_resolve vm-test-run-plpgsql_check> server # [ 137.425310] postgres[1674]: THEN vm-test-run-plpgsql_check> server # [ 137.425945] postgres[1674]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plpgsql_check> server # [ 137.426779] postgres[1674]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plpgsql_check> server # [ 137.427434] postgres[1674]: create or replace function graphql_public.graphql( vm-test-run-plpgsql_check> server # [ 137.432948] postgres[1674]: "operationName" text default null, vm-test-run-plpgsql_check> server # [ 137.434346] postgres[1674]: query text default null, vm-test-run-plpgsql_check> server # [ 137.434799] postgres[1674]: variables jsonb default null, vm-test-run-plpgsql_check> server # [ 137.435188] postgres[1674]: extensions jsonb default null vm-test-run-plpgsql_check> server # [ 137.435459] postgres[1674]: ) vm-test-run-plpgsql_check> server # [ 137.435689] postgres[1674]: returns jsonb vm-test-run-plpgsql_check> server # [ 137.436265] postgres[1674]: language sql vm-test-run-plpgsql_check> server # [ 137.448840] postgres[1674]: as $$ vm-test-run-plpgsql_check> server # [ 137.449946] postgres[1674]: select graphql.resolve( vm-test-run-plpgsql_check> server # [ 137.450558] postgres[1674]: query := query, vm-test-run-plpgsql_check> server # [ 137.451546] postgres[1674]: variables := coalesce(variables, '{}'), vm-test-run-plpgsql_check> server # [ 137.452441] postgres[1674]: "operationName" := "operationName", vm-test-run-plpgsql_check> server # [ 137.469413] postgres[1674]: extensions := extensions vm-test-run-plpgsql_check> server # [ 137.470393] postgres[1674]: ); vm-test-run-plpgsql_check> server # [ 137.470855] postgres[1674]: $$; vm-test-run-plpgsql_check> server # [ 137.471365] postgres[1674]: vm-test-run-plpgsql_check> server # [ 137.471619] postgres[1674]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plpgsql_check> server # [ 137.472168] postgres[1674]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plpgsql_check> server # [ 137.490191] postgres[1674]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plpgsql_check> server # [ 137.491808] postgres[1674]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 137.496673] postgres[1674]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 137.505073] postgres[1674]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 137.514026] postgres[1674]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 137.515188] postgres[1674]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 137.523126] postgres[1674]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 137.534464] postgres[1674]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 137.535225] postgres[1674]: END IF; vm-test-run-plpgsql_check> server # [ 137.536017] postgres[1674]: vm-test-run-plpgsql_check> server # [ 137.542500] postgres[1674]: END; vm-test-run-plpgsql_check> server # [ 137.549078] postgres[1674]: $func$; vm-test-run-plpgsql_check> server # [ 137.620176] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1670]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 137.626338] postgres[1674]: ::1 2026-10-11 11:37:27.053 UTC [1674] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plpgsql_check> server # [ 137.719970] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1670]: DROP EXTENSION vm-test-run-plpgsql_check> server # [ 139.448010] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1670]: DO vm-test-run-plpgsql_check> server # [ 139.500021] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-plpgsql_check> server # [ 140.658017] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1691]: DO vm-test-run-plpgsql_check> server # [ 141.490085] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1691]: DO vm-test-run-plpgsql_check> server # [ 141.557769] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-plpgsql_check> server # [ 141.890819] postgres[1718]: ::1 2026-10-11 11:37:31.329 UTC [1718] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-plpgsql_check> server # [ 141.954024] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1714]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 141.966267] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-plpgsql_check> server # [ 142.226930] postgres[1720]: ::1 2026-10-11 11:37:31.662 UTC [1720] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-plpgsql_check> server # [ 142.278387] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1719]: REVOKE ROLE vm-test-run-plpgsql_check> server # [ 142.297885] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-plpgsql_check> server # [ 144.939463] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1721]: DO vm-test-run-plpgsql_check> server # [ 144.987166] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-plpgsql_check> server # [ 145.395413] postgres[1752]: ::1 2026-10-11 11:37:34.828 UTC [1752] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-plpgsql_check> server # [ 145.430788] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1751]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 145.469331] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-plpgsql_check> server # [ 145.723880] postgres[1754]: ::1 2026-10-11 11:37:35.158 UTC [1754] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-plpgsql_check> server # [ 145.758565] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1753]: GRANT vm-test-run-plpgsql_check> server # [ 145.765122] postgres[1754]: ::1 2026-10-11 11:37:35.193 UTC [1754] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-plpgsql_check> server # [ 145.779878] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1753]: GRANT vm-test-run-plpgsql_check> server # [ 145.784892] postgres[1754]: ::1 2026-10-11 11:37:35.225 UTC [1754] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-plpgsql_check> server # [ 145.793964] postgres[1754]: ::1 2026-10-11 11:37:35.234 UTC [1754] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option; vm-test-run-plpgsql_check> server # [ 145.797522] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1753]: GRANT vm-test-run-plpgsql_check> server # [ 145.807260] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1753]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 145.809708] postgres[1754]: ::1 2026-10-11 11:37:35.248 UTC [1754] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option; vm-test-run-plpgsql_check> server # [ 145.820377] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1753]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 145.827441] postgres[1754]: ::1 2026-10-11 11:37:35.264 UTC [1754] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option; vm-test-run-plpgsql_check> server # [ 145.833328] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1753]: ALTER DEFAULT PRIVILEGES vm-test-run-plpgsql_check> server # [ 145.875544] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-plpgsql_check> server # [ 146.103909] postgres[1756]: ::1 2026-10-11 11:37:35.542 UTC [1756] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-plpgsql_check> server # [ 146.122555] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1755]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 146.170910] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-plpgsql_check> server # [ 146.503793] postgres[1758]: ::1 2026-10-11 11:37:35.933 UTC [1758] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-plpgsql_check> server # [ 146.548017] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1757]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 146.581873] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-plpgsql_check> server # [ 147.060168] postgres[1767]: ::1 2026-10-11 11:37:36.482 UTC [1767] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-plpgsql_check> server # [ 147.068096] postgres[1767]: ::1 2026-10-11 11:37:36.502 UTC [1767] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-plpgsql_check> server # [ 147.095327] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1762]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 147.096146] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1762]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 147.109603] postgres[1767]: ::1 2026-10-11 11:37:36.513 UTC [1767] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-plpgsql_check> server # [ 147.110743] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1762]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 147.111750] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1762]: DO vm-test-run-plpgsql_check> server # [ 147.198807] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-plpgsql_check> server # [ 147.607815] postgres[1775]: ::1 2026-10-11 11:37:37.041 UTC [1775] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-plpgsql_check> server # [ 147.669866] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1770]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 147.670998] postgres[1775]: ::1 2026-10-11 11:37:37.068 UTC [1775] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-plpgsql_check> server # [ 147.672067] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1770]: REVOKE ROLE vm-test-run-plpgsql_check> server # [ 147.744836] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-plpgsql_check> server # [ 148.241394] postgres[1787]: ::1 2026-10-11 11:37:37.660 UTC [1787] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plpgsql_check> server # [ 148.244087] postgres[1787]: returns event_trigger vm-test-run-plpgsql_check> server # [ 148.251467] postgres[1787]: language plpgsql vm-test-run-plpgsql_check> server # [ 148.252353] postgres[1787]: AS $func$ vm-test-run-plpgsql_check> server # [ 148.253933] postgres[1787]: DECLARE vm-test-run-plpgsql_check> server # [ 148.254621] postgres[1787]: func_is_graphql_resolve bool; vm-test-run-plpgsql_check> server # [ 148.255040] postgres[1787]: BEGIN vm-test-run-plpgsql_check> server # [ 148.255319] postgres[1787]: func_is_graphql_resolve = ( vm-test-run-plpgsql_check> server # [ 148.255598] postgres[1787]: SELECT n.proname = 'resolve' vm-test-run-plpgsql_check> server # [ 148.255862] postgres[1787]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plpgsql_check> server # [ 148.256635] postgres[1787]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plpgsql_check> server # [ 148.256954] postgres[1787]: ON ev.objid = n.oid vm-test-run-plpgsql_check> server # [ 148.257407] postgres[1787]: ); vm-test-run-plpgsql_check> server # [ 148.257672] postgres[1787]: vm-test-run-plpgsql_check> server # [ 148.257908] postgres[1787]: IF func_is_graphql_resolve vm-test-run-plpgsql_check> server # [ 148.258266] postgres[1787]: THEN vm-test-run-plpgsql_check> server # [ 148.258607] postgres[1787]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plpgsql_check> server # [ 148.259049] postgres[1787]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plpgsql_check> server # [ 148.259327] postgres[1787]: create or replace function graphql_public.graphql( vm-test-run-plpgsql_check> server # [ 148.259802] postgres[1787]: "operationName" text default null, vm-test-run-plpgsql_check> server # [ 148.261489] postgres[1787]: query text default null, vm-test-run-plpgsql_check> server # [ 148.262668] postgres[1787]: variables jsonb default null, vm-test-run-plpgsql_check> server # [ 148.262974] postgres[1787]: extensions jsonb default null vm-test-run-plpgsql_check> server # [ 148.263252] postgres[1787]: ) vm-test-run-plpgsql_check> server # [ 148.263847] postgres[1787]: returns jsonb vm-test-run-plpgsql_check> server # [ 148.264169] postgres[1787]: language sql vm-test-run-plpgsql_check> server # [ 148.264952] postgres[1787]: as $$ vm-test-run-plpgsql_check> server # [ 148.265675] postgres[1787]: select graphql.resolve( vm-test-run-plpgsql_check> server # [ 148.265971] postgres[1787]: query := query, vm-test-run-plpgsql_check> server # [ 148.266527] postgres[1787]: variables := coalesce(variables, '{}'), vm-test-run-plpgsql_check> server # [ 148.267841] postgres[1787]: "operationName" := "operationName", vm-test-run-plpgsql_check> server # [ 148.269093] postgres[1787]: extensions := extensions vm-test-run-plpgsql_check> server # [ 148.269566] postgres[1787]: ); vm-test-run-plpgsql_check> server # [ 148.269845] postgres[1787]: $$; vm-test-run-plpgsql_check> server # [ 148.270101] postgres[1787]: vm-test-run-plpgsql_check> server # [ 148.270343] postgres[1787]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plpgsql_check> server # [ 148.271051] postgres[1787]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plpgsql_check> server # [ 148.271411] postgres[1787]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plpgsql_check> server # [ 148.271724] postgres[1787]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 148.273091] postgres[1787]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 148.273836] postgres[1787]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 148.274256] postgres[1787]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 148.275058] postgres[1787]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 148.275760] postgres[1787]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 148.276454] postgres[1787]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plpgsql_check> server # [ 148.278886] postgres[1787]: vm-test-run-plpgsql_check> server # [ 148.279291] postgres[1787]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-plpgsql_check> server # [ 148.279761] postgres[1787]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-plpgsql_check> server # [ 148.280323] postgres[1787]: grant usage on schema graphql to postgres with grant option; vm-test-run-plpgsql_check> server # [ 148.282277] postgres[1787]: END IF; vm-test-run-plpgsql_check> server # [ 148.282870] postgres[1787]: vm-test-run-plpgsql_check> server # [ 148.283157] postgres[1787]: END; vm-test-run-plpgsql_check> server # [ 148.283401] postgres[1787]: $func$; vm-test-run-plpgsql_check> server # [ 148.316061] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1780]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 148.319941] postgres[1787]: ::1 2026-10-11 11:37:37.760 UTC [1787] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plpgsql_check> server # [ 148.374850] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1780]: DROP EXTENSION vm-test-run-plpgsql_check> server # [ 150.063961] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1780]: DO vm-test-run-plpgsql_check> server # [ 150.137453] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-plpgsql_check> server # [ 150.752074] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1800]: DO vm-test-run-plpgsql_check> server # [ 150.772115] postgres[1807]: ::1 2026-10-11 11:37:40.166 UTC [1807] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-plpgsql_check> server # [ 150.780858] postgres[1807]: LANGUAGE plpgsql vm-test-run-plpgsql_check> server # [ 150.782355] postgres[1807]: AS $$ vm-test-run-plpgsql_check> server # [ 150.790223] postgres[1807]: BEGIN vm-test-run-plpgsql_check> server # [ 150.790991] postgres[1807]: IF EXISTS ( vm-test-run-plpgsql_check> server # [ 150.791382] postgres[1807]: SELECT vm-test-run-plpgsql_check> server # [ 150.792064] postgres[1807]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plpgsql_check> server # [ 150.799145] postgres[1807]: JOIN pg_extension AS ext vm-test-run-plpgsql_check> server # [ 150.801229] postgres[1807]: ON ev.objid = ext.oid vm-test-run-plpgsql_check> server # [ 150.802194] postgres[1807]: WHERE ext.extname = 'pg_cron' vm-test-run-plpgsql_check> server # [ 150.802533] postgres[1807]: ) vm-test-run-plpgsql_check> server # [ 150.802764] postgres[1807]: THEN vm-test-run-plpgsql_check> server # [ 150.802994] postgres[1807]: grant usage on schema cron to postgres with grant option; vm-test-run-plpgsql_check> server # [ 150.803261] postgres[1807]: vm-test-run-plpgsql_check> server # [ 150.803686] postgres[1807]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plpgsql_check> server # [ 150.804009] postgres[1807]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plpgsql_check> server # [ 150.815350] postgres[1807]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plpgsql_check> server # [ 150.819366] postgres[1807]: vm-test-run-plpgsql_check> server # [ 150.819932] postgres[1807]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plpgsql_check> server # [ 150.824790] postgres[1807]: on sequences to postgres with grant option; vm-test-run-plpgsql_check> server # [ 150.826011] postgres[1807]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plpgsql_check> server # [ 150.827250] postgres[1807]: on tables to postgres with grant option; vm-test-run-plpgsql_check> server # [ 150.827626] postgres[1807]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plpgsql_check> server # [ 150.834306] postgres[1807]: on functions to postgres with grant option; vm-test-run-plpgsql_check> server # [ 150.835133] postgres[1807]: vm-test-run-plpgsql_check> server # [ 150.835575] postgres[1807]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plpgsql_check> server # [ 150.835912] postgres[1807]: revoke all on table cron.job from postgres; vm-test-run-plpgsql_check> server # [ 150.843451] postgres[1807]: grant select on table cron.job to postgres with grant option; vm-test-run-plpgsql_check> server # [ 150.856004] postgres[1807]: END IF; vm-test-run-plpgsql_check> server # [ 150.865817] postgres[1807]: END; vm-test-run-plpgsql_check> server # [ 150.866836] postgres[1807]: $$; vm-test-run-plpgsql_check> server # [ 150.868755] postgres[1807]: ::1 2026-10-11 11:37:40.296 UTC [1807] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-plpgsql_check> server # [ 150.879307] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1800]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 150.880874] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1800]: DROP EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 150.890322] postgres[1807]: ::1 2026-10-11 11:37:40.322 UTC [1807] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-plpgsql_check> server # [ 150.909130] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1800]: ALTER FUNCTION vm-test-run-plpgsql_check> server # [ 150.910081] postgres[1807]: ::1 2026-10-11 11:37:40.350 UTC [1807] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-plpgsql_check> server # [ 150.910533] postgres[1807]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-plpgsql_check> server # [ 150.911600] postgres[1807]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-plpgsql_check> server # [ 150.937502] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1800]: CREATE EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 151.015729] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-plpgsql_check> server # [ 151.384336] postgres[1817]: ::1 2026-10-11 11:37:40.821 UTC [1817] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-plpgsql_check> server # [ 151.419543] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1813]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 151.481229] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-plpgsql_check> server # [ 151.762431] postgres[1822]: ::1 2026-10-11 11:37:41.201 UTC [1822] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-plpgsql_check> server # [ 151.803021] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1821]: ALTER FUNCTION vm-test-run-plpgsql_check> server # [ 151.808887] postgres[1822]: ::1 2026-10-11 11:37:41.239 UTC [1822] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-plpgsql_check> server # [ 151.811301] postgres[1822]: ::1 2026-10-11 11:37:41.249 UTC [1822] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-plpgsql_check> server # [ 151.812119] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1821]: ALTER FUNCTION vm-test-run-plpgsql_check> server # [ 151.822678] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1821]: ALTER FUNCTION vm-test-run-plpgsql_check> server # [ 151.851815] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-plpgsql_check> server # [ 152.090898] postgres[1824]: ::1 2026-10-11 11:37:41.528 UTC [1824] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-plpgsql_check> server # [ 152.110844] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1823]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 152.154731] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-plpgsql_check> server # [ 153.358558] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1825]: DO vm-test-run-plpgsql_check> server # [ 153.407239] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-plpgsql_check> server # [ 153.939799] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1838]: DO vm-test-run-plpgsql_check> server # [ 153.950795] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1838]: DO vm-test-run-plpgsql_check> server # [ 154.001892] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-plpgsql_check> server # [ 154.425900] postgres[1857]: ::1 2026-10-11 11:37:43.846 UTC [1857] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-plpgsql_check> server # [ 154.433239] postgres[1857]: ::1 2026-10-11 11:37:43.862 UTC [1857] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-plpgsql_check> server # [ 154.455170] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1852]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 154.469343] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1852]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 154.474449] postgres[1857]: ::1 2026-10-11 11:37:43.875 UTC [1857] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-plpgsql_check> server # [ 154.484950] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1852]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 154.521933] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-plpgsql_check> server # [ 154.942518] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1859]: DO vm-test-run-plpgsql_check> server # [ 154.978783] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-plpgsql_check> server # [ 155.243494] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1861]: DO vm-test-run-plpgsql_check> server # [ 155.277586] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-plpgsql_check> server # [ 155.591633] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1863]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 155.595764] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1863]: DO vm-test-run-plpgsql_check> server # [ 155.652270] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-plpgsql_check> server # [ 155.959371] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1865]: ALTER FUNCTION vm-test-run-plpgsql_check> server # [ 155.972991] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1865]: GRANT vm-test-run-plpgsql_check> server # [ 156.020080] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-plpgsql_check> server # [ 156.778503] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1868]: DROP EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 156.885951] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1868]: ALTER FUNCTION vm-test-run-plpgsql_check> server # [ 156.902850] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1868]: CREATE EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 156.981903] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-plpgsql_check> server # [ 157.563138] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1885]: DO vm-test-run-plpgsql_check> server # [ 157.589107] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-plpgsql_check> server # [ 157.943194] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1895]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 157.955429] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1895]: GRANT vm-test-run-plpgsql_check> server # [ 158.021424] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-plpgsql_check> server # [ 158.395494] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1897]: REVOKE ROLE vm-test-run-plpgsql_check> server # [ 158.462494] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1897]: DO vm-test-run-plpgsql_check> server # [ 158.489707] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1897]: DO vm-test-run-plpgsql_check> server # [ 158.509958] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1897]: REVOKE ROLE vm-test-run-plpgsql_check> server # [ 158.531254] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1897]: REVOKE vm-test-run-plpgsql_check> server # [ 158.571324] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1897]: DO vm-test-run-plpgsql_check> server # [ 158.607720] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-plpgsql_check> server # [ 158.926923] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1903]: DO vm-test-run-plpgsql_check> server # [ 158.966651] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-plpgsql_check> server # [ 159.354971] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1905]: DO vm-test-run-plpgsql_check> server # [ 159.398559] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-plpgsql_check> server # [ 159.985218] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1912]: DO vm-test-run-plpgsql_check> server # [ 160.013024] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-plpgsql_check> server # [ 160.657448] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1925]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 160.722452] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-plpgsql_check> server # [ 161.078169] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1935]: GRANT ROLE vm-test-run-plpgsql_check> server # [ 161.087760] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1935]: DO vm-test-run-plpgsql_check> server # [ 161.138385] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-plpgsql_check> server # [ 161.427123] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1937]: GRANT vm-test-run-plpgsql_check> server # [ 161.459139] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-plpgsql_check> server # [ 161.758445] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1939]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 161.766919] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1939]: REVOKE vm-test-run-plpgsql_check> server # [ 161.778929] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1939]: REVOKE vm-test-run-plpgsql_check> server # [ 161.789924] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1939]: GRANT vm-test-run-plpgsql_check> server # [ 161.855815] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-plpgsql_check> server # [ 162.302943] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1941]: DO vm-test-run-plpgsql_check> server # [ 162.369822] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-plpgsql_check> server # [ 162.903263] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1947]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 162.939829] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-plpgsql_check> server # [ 163.637737] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1957]: DROP EXTENSION vm-test-run-plpgsql_check> server # [ 163.669398] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-plpgsql_check> server # [ 164.051507] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1970]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 164.076805] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1970]: DROP EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 164.090015] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1970]: CREATE EVENT TRIGGER vm-test-run-plpgsql_check> server # [ 164.156294] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-plpgsql_check> server # [ 164.539302] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1976]: DO vm-test-run-plpgsql_check> server # [ 164.574352] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1976]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 164.632983] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-plpgsql_check> server # [ 164.999273] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1979]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 165.020834] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1979]: CREATE FUNCTION vm-test-run-plpgsql_check> server # [ 165.052995] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Running postgresql schema... vm-test-run-plpgsql_check> server # [ 165.367226] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER DATABASE vm-test-run-plpgsql_check> server # [ 165.373126] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER DATABASE vm-test-run-plpgsql_check> server # [ 165.506925] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 165.633463] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 165.752477] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 165.873348] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 166.027886] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 166.110667] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 166.233714] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 166.439959] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 166.647855] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 166.677101] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1981]: ALTER ROLE vm-test-run-plpgsql_check> server # [ 166.749405] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1426]: Database initialization complete vm-test-run-plpgsql_check> server # [ 166.775327] systemd[1]: Finished Supabase Database Initialization. vm-test-run-plpgsql_check> server # [ 166.880536] systemd[1]: Reached target Multi-User System. vm-test-run-plpgsql_check> server # [ 166.882640] systemd[1]: Startup finished in 18.396s (kernel) + 2min 28.481s (userspace) = 2min 46.877s. vm-test-run-plpgsql_check> server: (finished: waiting for unit supabase-db-init.service, in 167.96 seconds) vm-test-run-plpgsql_check> subtest: Check upgrade path with postgresql 15 vm-test-run-plpgsql_check> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plpgsql_check;" vm-test-run-plpgsql_check> server # NOTICE: extension "plpgsql_check" does not exist, skipping vm-test-run-plpgsql_check> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plpgsql_check;" , in 0.56 seconds) vm-test-run-plpgsql_check> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plpgsql_check WITH VERSION '2.2' CASCADE;" vm-test-run-plpgsql_check> server # ERROR: attempt to redefine parameter "plpgsql_check.regress_test_mode" vm-test-run-plpgsql_check> server # [ 169.024903] postgres[2015]: [local] 2026-10-11 11:37:58.455 UTC [2015] supabase_admin@postgres ERROR: attempt to redefine parameter "plpgsql_check.regress_test_mode" vm-test-run-plpgsql_check> server # [ 169.034812] postgres[2015]: [local] 2026-10-11 11:37:58.455 UTC [2015] supabase_admin@postgres STATEMENT: CREATE EXTENSION plpgsql_check WITH VERSION '2.2' CASCADE; vm-test-run-plpgsql_check> server: output: vm-test-run-plpgsql_check> !!! Test "Check upgrade path with postgresql 15" failed with error: "command `psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plpgsql_check WITH VERSION '2.2' CASCADE;" ` failed (exit code 1)" vm-test-run-plpgsql_check> !!! Traceback (most recent call last): vm-test-run-plpgsql_check> !!! File "", line 284, in vm-test-run-plpgsql_check> !!! test.check_upgrade_path("15") vm-test-run-plpgsql_check> !!! File "", line 138, in check_upgrade_path vm-test-run-plpgsql_check> !!! self.install_extension(first_version) vm-test-run-plpgsql_check> !!! File "", line 77, in install_extension vm-test-run-plpgsql_check> !!! self.run_sql( vm-test-run-plpgsql_check> !!! File "", line 60, in run_sql vm-test-run-plpgsql_check> !!! return self.vm.succeed( vm-test-run-plpgsql_check> !!! vm-test-run-plpgsql_check> !!! RequestedAssertionFailed: command `psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plpgsql_check WITH VERSION '2.2' CASCADE;" ` failed (exit code 1) vm-test-run-plpgsql_check> cleanup vm-test-run-plpgsql_check> kill machine (pid 9) vm-test-run-plpgsql_check> qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13) vm-test-run-plpgsql_check> vde_switch: EOF data port: Interrupted system call vm-test-run-plpgsql_check> kill vlan (pid 7) vm-test-run-plpgsql_check> vde_switch: vde_switch: Caught signal 15, cleaning up and exiting vm-test-run-plpgsql_check> (finished: cleanup, in 0.00 seconds) error: build of '/nix/store/24kmrrhirj64c244h26zw4glglsmdir4-vm-test-run-plpgsql_check.drv' on 'ssh-ng://builder@mac-linux-builder' failed: Cannot build '/nix/store/24kmrrhirj64c244h26zw4glglsmdir4-vm-test-run-plpgsql_check.drv'. Reason: builder failed with exit code 1. Output paths: /nix/store/mq5cihw0b7mslzd0xl4y27ji2fb2kwym-vm-test-run-plpgsql_check Last 25 log lines: > server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plpgsql_check;" , in 0.56 seconds) > server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plpgsql_check WITH VERSION '2.2' CASCADE;" > server # ERROR: attempt to redefine parameter "plpgsql_check.regress_test_mode" > server # [ 169.024903] postgres[2015]: [local] 2026-10-11 11:37:58.455 UTC [2015] supabase_admin@postgres ERROR: attempt to redefine parameter "plpgsql_check.regress_test_mode" > server # [ 169.034812] postgres[2015]: [local] 2026-10-11 11:37:58.455 UTC [2015] supabase_admin@postgres STATEMENT: CREATE EXTENSION plpgsql_check WITH VERSION '2.2' CASCADE; > server: output: > !!! Test "Check upgrade path with postgresql 15" failed with error: "command `psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plpgsql_check WITH VERSION '2.2' CASCADE;" ` failed (exit code 1)" > !!! Traceback (most recent call last): > !!! File "", line 284, in > !!! test.check_upgrade_path("15") > !!! File "", line 138, in check_upgrade_path > !!! self.install_extension(first_version) > !!! File "", line 77, in install_extension > !!! self.run_sql( > !!! File "", line 60, in run_sql > !!! return self.vm.succeed( > !!! > !!! RequestedAssertionFailed: command `psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plpgsql_check WITH VERSION '2.2' CASCADE;" ` failed (exit code 1) > cleanup > kill machine (pid 9) > qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13) > vde_switch: EOF data port: Interrupted system call > kill vlan (pid 7) > vde_switch: vde_switch: Caught signal 15, cleaning up and exiting > (finished: cleanup, in 0.00 seconds) For full logs, run: nix-store -l /nix/store/24kmrrhirj64c244h26zw4glglsmdir4-vm-test-run-plpgsql_check.drv error: Cannot build '/nix/store/24kmrrhirj64c244h26zw4glglsmdir4-vm-test-run-plpgsql_check.drv'. Reason: builder failed with exit code 1. Output paths: /nix/store/mq5cihw0b7mslzd0xl4y27ji2fb2kwym-vm-test-run-plpgsql_check