these 12 derivations will be built: /nix/store/vlmrpqfgpvz3jnhl7r08hdab5x8xqggn-processed-postgresql-config-15.drv /nix/store/l517d6r0m4z5i76v6clbiap8p97p9lbd-postgresql-init.drv /nix/store/kj0hv1a1i8bc6xs60sv235grjs8mzgd4-unit-postgresql.service.drv /nix/store/5r0frhfsihidsnriyffp17d751p7lpw1-system-units.drv /nix/store/axgjaih754gjjn2qjvw69h378jd1gnnk-etc.drv /nix/store/xqklj46s6nagiwy8vb4n7vgp4bn60vfv-activate.drv /nix/store/1mybcksx54mrlw6clx9554yndp7c59js-nixos-system-server-test.drv /nix/store/x5cbgswbz8ssciaa8ag7ay31b4j09f03-closure-info.drv /nix/store/1vs31hj3qklydviy2p1390z48nkryamk-run-nixos-vm.drv /nix/store/zwnvclq86gc7v0yg249x9xfnx789khqi-nixos-vm.drv /nix/store/7yxg7az82d3968mv4mhig4mm8kvg4agk-nixos-test-driver-plv8.drv /nix/store/llgbwln0ciflfjinlhls67drkcv3vgp0-vm-test-run-plv8.drv building '/nix/store/vlmrpqfgpvz3jnhl7r08hdab5x8xqggn-processed-postgresql-config-15.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/vlmrpqfgpvz3jnhl7r08hdab5x8xqggn-processed-postgresql-config-15.drv' building '/nix/store/l517d6r0m4z5i76v6clbiap8p97p9lbd-postgresql-init.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/l517d6r0m4z5i76v6clbiap8p97p9lbd-postgresql-init.drv' building '/nix/store/kj0hv1a1i8bc6xs60sv235grjs8mzgd4-unit-postgresql.service.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/kj0hv1a1i8bc6xs60sv235grjs8mzgd4-unit-postgresql.service.drv' building '/nix/store/5r0frhfsihidsnriyffp17d751p7lpw1-system-units.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/5r0frhfsihidsnriyffp17d751p7lpw1-system-units.drv' building '/nix/store/axgjaih754gjjn2qjvw69h378jd1gnnk-etc.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/axgjaih754gjjn2qjvw69h378jd1gnnk-etc.drv' building '/nix/store/xqklj46s6nagiwy8vb4n7vgp4bn60vfv-activate.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/xqklj46s6nagiwy8vb4n7vgp4bn60vfv-activate.drv' building '/nix/store/1mybcksx54mrlw6clx9554yndp7c59js-nixos-system-server-test.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/1mybcksx54mrlw6clx9554yndp7c59js-nixos-system-server-test.drv' building '/nix/store/x5cbgswbz8ssciaa8ag7ay31b4j09f03-closure-info.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/x5cbgswbz8ssciaa8ag7ay31b4j09f03-closure-info.drv' closure-info> structuredAttrs is enabled building '/nix/store/1vs31hj3qklydviy2p1390z48nkryamk-run-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/1vs31hj3qklydviy2p1390z48nkryamk-run-nixos-vm.drv' building '/nix/store/zwnvclq86gc7v0yg249x9xfnx789khqi-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/zwnvclq86gc7v0yg249x9xfnx789khqi-nixos-vm.drv' building '/nix/store/7yxg7az82d3968mv4mhig4mm8kvg4agk-nixos-test-driver-plv8.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/7yxg7az82d3968mv4mhig4mm8kvg4agk-nixos-test-driver-plv8.drv' nixos-test-driver-plv8> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-plv8> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-plv8> Success: no issues found in 1 source file nixos-test-driver-plv8> additionally exposed symbols: nixos-test-driver-plv8> , nixos-test-driver-plv8> , nixos-test-driver-plv8> 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-plv8> Linting test script (enable/disable: config.skipLint) nixos-test-driver-plv8> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint building '/nix/store/llgbwln0ciflfjinlhls67drkcv3vgp0-vm-test-run-plv8.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/llgbwln0ciflfjinlhls67drkcv3vgp0-vm-test-run-plv8.drv' vm-test-run-plv8> Machine state will be reset. To keep it, pass --keep-vm-state vm-test-run-plv8> start all VLans vm-test-run-plv8> start vlan vm-test-run-plv8> running vlan (pid 7; ctl /build/vde1.ctl) vm-test-run-plv8> (finished: start all VLans, in 0.00 seconds) vm-test-run-plv8> Test will time out and terminate in 3600 seconds vm-test-run-plv8> run the VM test script vm-test-run-plv8> additionally exposed symbols: vm-test-run-plv8> server, vm-test-run-plv8> vlan1, vm-test-run-plv8> 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-plv8> start all VMs vm-test-run-plv8> server: starting vm vm-test-run-plv8> mke2fs 1.47.3 (8-Jul-2025) vm-test-run-plv8> qemu-system-aarch64: Could not access KVM kernel module: No such file or directory vm-test-run-plv8> qemu-system-aarch64: failed to initialize kvm: No such file or directory vm-test-run-plv8> qemu-system-aarch64: falling back to tcg vm-test-run-plv8> server: QEMU running (pid 9) vm-test-run-plv8> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-plv8> server # Formatting '/build/vm-state-server/tmp.338uBlxlyU', fmt=raw size=1073741824 vm-test-run-plv8> server # Discarding device blocks: 0/262144 done vm-test-run-plv8> server # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-plv8> server # Filesystem UUID: 1428e7de-6bd6-474b-af52-37f5bc13167a vm-test-run-plv8> server # Superblock backups stored on blocks: vm-test-run-plv8> server # 32768, 98304, 163840, 229376 vm-test-run-plv8> server # vm-test-run-plv8> server # Allocating group tables: 0/8 done vm-test-run-plv8> server # Writing inode tables: 0/8 done vm-test-run-plv8> server # Creating journal (8192 blocks): done vm-test-run-plv8> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-plv8> server # vm-test-run-plv8> server # Virtualisation disk image created. vm-test-run-plv8> (finished: start all VMs, in 0.12 seconds) vm-test-run-plv8> server: waiting for unit supabase-db-init.service vm-test-run-plv8> server: waiting for the VM to finish booting vm-test-run-plv8> server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510] vm-test-run-plv8> 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-plv8> server # [ 0.000000] KASLR enabled vm-test-run-plv8> server # [ 0.000000] random: crng init done vm-test-run-plv8> server # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-plv8> server # [ 0.000000] efi: UEFI not found. vm-test-run-plv8> server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-plv8> server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f602200-0x13f60593f] vm-test-run-plv8> server # [ 0.000000] Zone ranges: vm-test-run-plv8> server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] vm-test-run-plv8> server # [ 0.000000] DMA32 empty vm-test-run-plv8> server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] Device empty vm-test-run-plv8> server # [ 0.000000] Movable zone start for each node vm-test-run-plv8> server # [ 0.000000] Early memory node ranges vm-test-run-plv8> server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -1 vm-test-run-plv8> server # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-plv8> server # [ 0.000000] psci: PSCIv1.1 detected in firmware. vm-test-run-plv8> server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-plv8> server # [ 0.000000] psci: Trusted OS migration not required vm-test-run-plv8> server # [ 0.000000] psci: SMC Calling Convention v1.0 vm-test-run-plv8> server # [ 0.000000] percpu: Embedded 88 pages/cpu s180056 r65536 d114856 u360448 vm-test-run-plv8> server # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-plv8> server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm) vm-test-run-plv8> server # [ 0.000000] CPU features: detected: GIC system register CPU interface vm-test-run-plv8> server # [ 0.000000] CPU features: detected: HCRX_EL2 register vm-test-run-plv8> server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2) vm-test-run-plv8> server # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-plv8> server # [ 0.000000] alternatives: applying boot alternatives vm-test-run-plv8> 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/xccjb0p6frzqczkin80yq741hjvpsb6s-nixos-system-server-test/init regInfo=/nix/store/vwg6j0flb8pbxkb8gckzsrj42lp578kw-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-plv8> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/vwg6j0flb8pbxkb8gckzsrj42lp578kw-closure-info/registration", will be passed to user space. vm-test-run-plv8> server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-plv8> server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-plv8> server # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-plv8> server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 vm-test-run-plv8> server # [ 0.000000] Policy zone: Normal vm-test-run-plv8> server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-plv8> server # [ 0.000000] software IO TLB: area num 2. vm-test-run-plv8> server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) vm-test-run-plv8> server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm-test-run-plv8> server # [ 0.000000] allocated 8388608 bytes of page_ext vm-test-run-plv8> server # [ 0.000000] ftrace: allocating 72257 entries in 283 pages vm-test-run-plv8> server # [ 0.000000] ftrace: allocated 283 pages with 5 groups vm-test-run-plv8> server # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-plv8> server # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-plv8> server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. vm-test-run-plv8> server # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-plv8> server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm-test-run-plv8> 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-plv8> 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-plv8> server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-plv8> server # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-plv8> server # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-plv8> server # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-plv8> server # [ 0.000000] GICv3: GICv3 features: 16 PPIs vm-test-run-plv8> server # [ 0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 vm-test-run-plv8> server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-plv8> server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-plv8> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100ad0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-plv8> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100ae0000 (flat, esz 8, psz 64K, shr 1) vm-test-run-plv8> server # [ 0.000000] GICv3: using LPI property table @0x0000000100af0000 vm-test-run-plv8> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b00000 vm-test-run-plv8> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-plv8> server # [ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (virt). vm-test-run-plv8> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-plv8> server # [ 0.000026] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-plv8> server # [ 0.002360] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-plv8> server # [ 0.007967] Console: colour dummy device 80x25 vm-test-run-plv8> server # [ 0.008978] printk: legacy console [tty0] enabled vm-test-run-plv8> server # [ 0.012982] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-plv8> server # [ 0.013261] pid_max: default: 32768 minimum: 301 vm-test-run-plv8> server # [ 0.014672] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-plv8> server # [ 0.015742] landlock: Up and running. vm-test-run-plv8> server # [ 0.015783] Yama: becoming mindful. vm-test-run-plv8> server # [ 0.019679] LSM support for eBPF active vm-test-run-plv8> server # [ 0.021673] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.021973] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.042811] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-plv8> server # [ 0.050343] rcu: Hierarchical SRCU implementation. vm-test-run-plv8> server # [ 0.050384] rcu: Max phase no-delay instances is 1000. vm-test-run-plv8> server # [ 0.051341] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-plv8> server # [ 0.056547] fsl-mc MSI: its@8080000 domain created vm-test-run-plv8> server # [ 0.057964] EFI services will not be available. vm-test-run-plv8> server # [ 0.058992] smp: Bringing up secondary CPUs ... vm-test-run-plv8> server # [ 0.061934] Detected PIPT I-cache on CPU1 vm-test-run-plv8> server # [ 0.062756] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-plv8> server # [ 0.063230] GICv3: CPU1: using allocated LPI pending table @0x0000000100b10000 vm-test-run-plv8> server # [ 0.064330] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-plv8> server # [ 0.066769] smp: Brought up 1 node, 2 CPUs vm-test-run-plv8> server # [ 0.066863] SMP: Total of 2 processors activated. vm-test-run-plv8> server # [ 0.066891] CPU: All CPU(s) started at EL1 vm-test-run-plv8> server # [ 0.066994] CPU features: detected: Branch Target Identification vm-test-run-plv8> server # [ 0.067030] CPU features: detected: 32-bit EL0 Support vm-test-run-plv8> server # [ 0.067050] CPU features: detected: 32-bit EL1 Support vm-test-run-plv8> server # [ 0.067066] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-plv8> server # [ 0.067089] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-plv8> server # [ 0.067116] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-plv8> server # [ 0.067159] CPU features: detected: Common not Private translations vm-test-run-plv8> server # [ 0.067177] CPU features: detected: CRC32 instructions vm-test-run-plv8> server # [ 0.067192] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-plv8> server # [ 0.067212] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-plv8> server # [ 0.067230] CPU features: detected: Data independent timing control (DIT) vm-test-run-plv8> server # [ 0.067248] CPU features: detected: E0PD vm-test-run-plv8> server # [ 0.067261] CPU features: detected: Enhanced Counter Virtualization vm-test-run-plv8> server # [ 0.067298] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-plv8> server # [ 0.067322] CPU features: detected: Enhanced Privileged Access Never vm-test-run-plv8> server # [ 0.067339] CPU features: detected: Enhanced Virtualization Traps vm-test-run-plv8> server # [ 0.067356] CPU features: detected: Fine Grained Traps vm-test-run-plv8> server # [ 0.067395] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-plv8> server # [ 0.067470] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-plv8> server # [ 0.067502] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-plv8> server # [ 0.067521] CPU features: detected: LSE atomic instructions vm-test-run-plv8> server # [ 0.067537] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-plv8> server # [ 0.067555] CPU features: detected: Privileged Access Never vm-test-run-plv8> server # [ 0.067571] CPU features: detected: RAS Extension Support vm-test-run-plv8> server # [ 0.067587] CPU features: detected: Random Number Generator vm-test-run-plv8> server # [ 0.067602] CPU features: detected: Speculation barrier (SB) vm-test-run-plv8> server # [ 0.067618] CPU features: detected: Stage-2 Force Write-Back vm-test-run-plv8> server # [ 0.067634] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-plv8> server # [ 0.067654] CPU features: detected: TLB range maintenance instructions vm-test-run-plv8> server # [ 0.067671] CPU features: detected: WFx with timeout vm-test-run-plv8> server # [ 0.067700] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-plv8> server # [ 0.067718] CPU features: detected: Scalable Vector Extension vm-test-run-plv8> server # [ 0.071104] alternatives: applying system-wide alternatives vm-test-run-plv8> server # [ 0.081898] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-plv8> server # [ 0.082363] SVE: maximum available vector length 256 bytes per vector vm-test-run-plv8> server # [ 0.082423] SVE: default vector length 64 bytes per vector vm-test-run-plv8> server # [ 0.090656] Memory: 3922908K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-plv8> server # [ 0.107464] devtmpfs: initialized vm-test-run-plv8> server # [ 0.127020] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-plv8> server # [ 0.127397] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.129083] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-plv8> server # [ 0.129126] 0 pages in range for non-PLT usage vm-test-run-plv8> server # [ 0.129158] 509248 pages in range for PLT usage vm-test-run-plv8> server # [ 0.130900] pinctrl core: initialized pinctrl subsystem vm-test-run-plv8> server # [ 0.138110] DMI not present or invalid. vm-test-run-plv8> server # [ 0.150930] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-plv8> server # [ 0.158247] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-plv8> server # [ 0.158845] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-plv8> server # [ 0.159540] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-plv8> server # [ 0.159710] audit: initializing netlink subsys (disabled) vm-test-run-plv8> server # [ 0.160870] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 vm-test-run-plv8> server # [ 0.165719] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-plv8> server # [ 0.165749] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-plv8> server # [ 0.165783] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-plv8> server # [ 0.165805] thermal_sys: Registered thermal governor 'user_space' vm-test-run-plv8> server # [ 0.165825] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-plv8> server # [ 0.166223] cpuidle: using governor ladder vm-test-run-plv8> server # [ 0.166412] cpuidle: using governor menu vm-test-run-plv8> server # [ 0.167782] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-plv8> server # [ 0.168271] ASID allocator initialised with 65536 entries vm-test-run-plv8> server # [ 0.173188] Serial: AMBA PL011 UART driver vm-test-run-plv8> server # [ 0.206085] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-plv8> server # [ 0.207362] printk: legacy console [ttyAMA0] enabled vm-test-run-plv8> server # [ 0.245840] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.245989] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-plv8> server # [ 0.246087] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.246758] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-plv8> server # [ 0.246853] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.246990] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-plv8> server # [ 0.247472] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.247786] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-plv8> server # [ 0.277574] fbcon: Taking over console vm-test-run-plv8> server # [ 0.278224] ACPI: Interpreter disabled. vm-test-run-plv8> server # [ 0.283311] iommu: Default domain type: Translated vm-test-run-plv8> server # [ 0.283427] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-plv8> server # [ 0.308985] SCSI subsystem initialized vm-test-run-plv8> server # [ 0.310960] usbcore: registered new interface driver usbfs vm-test-run-plv8> server # [ 0.311286] usbcore: registered new interface driver hub vm-test-run-plv8> server # [ 0.311612] usbcore: registered new device driver usb vm-test-run-plv8> server # [ 0.313493] pps_core: LinuxPPS API ver. 1 registered vm-test-run-plv8> server # [ 0.313597] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-plv8> server # [ 0.313829] PTP clock support registered vm-test-run-plv8> server # [ 0.314710] EDAC MC: Ver: 3.0.0 vm-test-run-plv8> server # [ 0.315953] scmi_core: SCMI protocol bus registered vm-test-run-plv8> server # [ 0.318091] FPGA manager framework vm-test-run-plv8> server # [ 0.319200] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-plv8> server # [ 0.325425] vgaarb: loaded vm-test-run-plv8> server # [ 0.327679] clocksource: Switched to clocksource arch_sys_counter vm-test-run-plv8> server # [ 0.334906] VFS: Disk quotas dquot_6.6.0 vm-test-run-plv8> server # [ 0.335112] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-plv8> server # [ 0.337299] netfs: FS-Cache loaded vm-test-run-plv8> server # [ 0.338351] pnp: PnP ACPI: disabled vm-test-run-plv8> server # [ 0.361740] NET: Registered PF_INET protocol family vm-test-run-plv8> server # [ 0.362868] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-plv8> server # [ 0.440901] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.441264] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.442370] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.443442] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-plv8> server # [ 0.444236] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-plv8> server # [ 0.445360] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-plv8> server # [ 0.445925] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.446416] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.447642] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-plv8> server # [ 0.448303] NET: Registered PF_XDP protocol family vm-test-run-plv8> server # [ 0.448600] PCI: CLS 0 bytes, default 64 vm-test-run-plv8> server # [ 0.450016] kvm [1]: HYP mode not available vm-test-run-plv8> server # [ 0.451252] Trying to unpack rootfs image as initramfs... vm-test-run-plv8> server # [ 0.523691] Initialise system trusted keyrings vm-test-run-plv8> server # [ 0.524958] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-plv8> server # [ 0.528137] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-plv8> server # [ 0.529537] 9p: Installing v9fs 9p2000 file system support vm-test-run-plv8> server # [ 0.571109] Key type asymmetric registered vm-test-run-plv8> server # [ 0.571300] Asymmetric key parser 'x509' registered vm-test-run-plv8> server # [ 0.572161] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-plv8> server # [ 0.572933] io scheduler mq-deadline registered vm-test-run-plv8> server # [ 0.573078] io scheduler kyber registered vm-test-run-plv8> server # [ 0.590139] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-plv8> server # [ 0.593449] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-plv8> server # [ 0.595944] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-plv8> server # [ 0.596698] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-plv8> server # [ 0.597443] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-plv8> server # [ 0.597638] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-plv8> server # [ 0.598402] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-plv8> server # [ 0.599054] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-plv8> server # [ 0.600445] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-plv8> server # [ 0.600970] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-plv8> server # [ 0.601169] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.601497] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.601614] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.603004] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.605524] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.606038] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.606201] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.606547] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.606793] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.607575] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.607758] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.607895] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.608123] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.608969] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.609154] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.609253] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.609748] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.610442] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.610600] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.610929] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.611257] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.612182] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.612336] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.612453] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.612902] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.613590] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.613779] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-plv8> server # [ 0.613993] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.614148] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.615100] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.615298] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.615399] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.615518] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.616448] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.617222] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.617399] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.617524] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.618353] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.618542] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.618773] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.619552] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-plv8> server # [ 0.619724] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.620548] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.620767] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.621049] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.621178] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.621773] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.621946] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.622047] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.622264] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.624207] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-plv8> server # [ 0.624455] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-plv8> server # [ 0.625113] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.625366] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.625703] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.625935] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.626191] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.626327] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.626680] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.626896] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.627057] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.627638] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.628100] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.628454] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-plv8> server # [ 0.628735] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-plv8> server # [ 0.629079] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-plv8> server # [ 0.629235] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-plv8> server # [ 0.629716] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-plv8> server # [ 0.630047] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-plv8> server # [ 0.630347] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-plv8> server # [ 0.630558] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-plv8> server # [ 0.630654] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-plv8> server # [ 0.630976] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-plv8> server # [ 0.631329] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-plv8> server # [ 0.631468] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-plv8> server # [ 0.631702] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-plv8> server # [ 0.632285] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-plv8> server # [ 0.632655] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-plv8> server # [ 0.632754] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-plv8> server # [ 0.633014] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-plv8> server # [ 0.633329] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-plv8> server # [ 0.633661] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-plv8> server # [ 0.633782] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-plv8> server # [ 0.634279] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-plv8> server # [ 0.634828] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.634995] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.635287] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.636474] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.673831] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.676564] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.678212] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.679602] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.681175] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.682822] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.684191] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.686074] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.687096] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.688661] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.689916] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.700937] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-plv8> server # [ 0.707463] msm_serial: driver initialized vm-test-run-plv8> server # [ 0.708357] SuperH (H)SCI(F) driver initialized vm-test-run-plv8> server # [ 0.708802] STM32 USART driver initialized vm-test-run-plv8> server # [ 0.734749] Freeing initrd memory: 10684K vm-test-run-plv8> server # [ 0.739760] loop: module loaded vm-test-run-plv8> server # [ 0.740608] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-plv8> server # [ 0.742978] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-plv8> server # [ 0.751156] megasas: 07.727.03.00-rc1 vm-test-run-plv8> server # [ 0.754880] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-plv8> server # [ 0.756617] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 0.757464] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 0.758470] Using buffer write method vm-test-run-plv8> server # [ 0.759046] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-plv8> server # [ 0.760129] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 0.760388] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 0.761615] Using buffer write method vm-test-run-plv8> server # [ 0.761854] Concatenating MTD devices: vm-test-run-plv8> server # [ 0.762098] (0): "0.flash" vm-test-run-plv8> server # [ 0.762157] (1): "0.flash" vm-test-run-plv8> server # [ 0.762468] into device "0.flash" vm-test-run-plv8> server # [ 0.777503] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-plv8> server # [ 0.785124] thunder_xcv, ver 1.0 vm-test-run-plv8> server # [ 0.785321] thunder_bgx, ver 1.0 vm-test-run-plv8> server # [ 0.785568] nicpf, ver 1.0 vm-test-run-plv8> server # [ 0.787862] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-plv8> server # [ 0.788013] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-plv8> server # [ 0.788835] hclge is initializing vm-test-run-plv8> server # [ 0.789191] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 0.789278] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-plv8> server # [ 0.789779] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 0.789914] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-plv8> server # [ 0.790258] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-plv8> server # [ 0.790448] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-plv8> server # [ 0.790811] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-plv8> server # [ 0.791076] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-plv8> server # [ 0.792257] sky2: driver version 1.30 vm-test-run-plv8> server # [ 0.797550] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-plv8> server # [ 0.798303] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-plv8> server # [ 0.799194] usbcore: registered new interface driver usb-storage vm-test-run-plv8> server # [ 0.799975] usbcore: registered new interface driver usbserial_generic vm-test-run-plv8> server # [ 0.800388] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-plv8> server # [ 0.800448] usbserial: USB Serial support registered for generic vm-test-run-plv8> server # [ 0.806881] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-plv8> server # [ 0.807645] rtc-pl031 9010000.pl031: setting system clock to 2026-10-23T10:39:37 UTC (1792751977) vm-test-run-plv8> server # [ 0.809170] i2c_dev: i2c /dev entries driver vm-test-run-plv8> server # [ 0.818293] sdhci: Secure Digital Host Controller Interface driver vm-test-run-plv8> server # [ 0.818422] sdhci: Copyright(c) Pierre Ossman vm-test-run-plv8> server # [ 0.819962] Synopsys Designware Multimedia Card Interface Driver vm-test-run-plv8> server # [ 0.820647] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-plv8> server # [ 0.822014] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-plv8> server # [ 0.825391] hub 1-0:1.0: USB hub found vm-test-run-plv8> server # [ 0.825983] hub 1-0:1.0: 6 ports detected vm-test-run-plv8> server # [ 0.827321] hid: raw HID events driver (C) Jiri Kosina vm-test-run-plv8> server # [ 0.829200] usbcore: registered new interface driver usbhid vm-test-run-plv8> server # [ 0.829320] usbhid: USB HID core driver vm-test-run-plv8> server # [ 0.834666] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-plv8> server # [ 0.842788] drop_monitor: Initializing network drop monitor service vm-test-run-plv8> server # [ 0.844061] NET: Registered PF_INET6 protocol family vm-test-run-plv8> server # [ 0.852405] Segment Routing with IPv6 vm-test-run-plv8> server # [ 0.852792] In-situ OAM (IOAM) with IPv6 vm-test-run-plv8> server # [ 0.853611] NET: Registered PF_PACKET protocol family vm-test-run-plv8> server # [ 0.854549] 9pnet: Installing 9P2000 support vm-test-run-plv8> server # [ 0.857283] Key type dns_resolver registered vm-test-run-plv8> server # [ 0.880561] registered taskstats version 1 vm-test-run-plv8> server # [ 0.882312] Loading compiled-in X.509 certificates vm-test-run-plv8> server # [ 0.918704] Demotion targets for Node 0: null vm-test-run-plv8> server # [ 0.920134] Key type .fscrypt registered vm-test-run-plv8> server # [ 0.920235] Key type fscrypt-provisioning registered vm-test-run-plv8> server # [ 0.926096] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-plv8> server # [ 0.955453] clk: Disabling unused clocks vm-test-run-plv8> server # [ 0.955923] PM: genpd: Disabling unused power domains vm-test-run-plv8> server # [ 0.956170] ALSA device list: vm-test-run-plv8> server # [ 0.956444] No soundcards found. vm-test-run-plv8> server # [ 1.009443] Freeing unused kernel memory: 4416K vm-test-run-plv8> server # [ 1.010494] Run /init as init process vm-test-run-plv8> server # [ 1.104776] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-plv8> server # [ 1.293878] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-plv8> server # [ 1.351812] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-plv8> server # [ 1.353355] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-plv8> server # [ 1.353378] [drm] features: -context_init vm-test-run-plv8> server # [ 1.355547] [drm] number of scanouts: 1 vm-test-run-plv8> server # [ 1.355649] [drm] number of cap sets: 0 vm-test-run-plv8> server # [ 1.362322] 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-plv8> server # [ 1.362332] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-plv8> server # [ 1.385099] Console: switching to colour frame buffer device 160x50 vm-test-run-plv8> server # [ 1.391539] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-plv8> server # [ 1.669693] 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-plv8> server # [ 1.804121] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-plv8> server # [ 2.070573] 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-plv8> server # [ 2.072861] 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-plv8> server # [ 3.242730] EXT4-fs (vda): mounted filesystem 1428e7de-6bd6-474b-af52-37f5bc13167a r/w with ordered data mode. Quota mode: none. vm-test-run-plv8> server # [ 4.989276] EXT4-fs (vda): re-mounted 1428e7de-6bd6-474b-af52-37f5bc13167a. vm-test-run-plv8> server # [ 5.005797] booting system configuration /nix/store/xccjb0p6frzqczkin80yq741hjvpsb6s-nixos-system-server-test vm-test-run-plv8> server # [ 15.238792] 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-plv8> server # [ 15.248239] systemd[1]: Detected virtualization qemu. vm-test-run-plv8> server # [ 15.253250] systemd[1]: Detected architecture arm64. vm-test-run-plv8> server # [ 15.258181] systemd[1]: Detected first boot. vm-test-run-plv8> server # [ 15.282215] systemd[1]: Initializing machine ID from random generator. vm-test-run-plv8> server # [ 15.312234] systemd[1]: Hostname set to . vm-test-run-plv8> server # [ 16.461113] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-plv8> server # [ 17.651721] systemd[1]: Applying preset policy. vm-test-run-plv8> server # [ 20.648665] systemd[1]: Populated /etc with preset unit settings. vm-test-run-plv8> server # [ 23.566618] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-plv8> server # [ 23.776307] systemd[1]: Created slice Slice /system/getty. vm-test-run-plv8> server # [ 23.792231] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-plv8> server # [ 23.805546] systemd[1]: Created slice User and Session Slice. vm-test-run-plv8> server # [ 23.814410] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-plv8> server # [ 23.821054] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-plv8> server # [ 23.826677] systemd[1]: Expecting device /dev/hvc0... vm-test-run-plv8> server # [ 23.832057] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-plv8> server # [ 23.837582] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-plv8> server # [ 23.842565] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-plv8> server # [ 23.847613] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-plv8> server # [ 23.853043] systemd[1]: Reached target Path Units. vm-test-run-plv8> server # [ 23.857617] systemd[1]: Reached target Remote File Systems. vm-test-run-plv8> server # [ 23.862383] systemd[1]: Reached target Slice Units. vm-test-run-plv8> server # [ 23.868655] systemd[1]: Reached target Swaps. vm-test-run-plv8> server # [ 23.901483] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-plv8> server # [ 23.925776] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-plv8> server # [ 23.936413] systemd[1]: Listening on Journal Audit Socket. vm-test-run-plv8> server # [ 23.942623] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-plv8> server # [ 23.949009] systemd[1]: Listening on Journal Sockets. vm-test-run-plv8> server # [ 23.957363] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-plv8> server # [ 23.962130] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 23.968817] systemd[1]: Listening on udev Control Socket. vm-test-run-plv8> server # [ 23.974092] systemd[1]: Listening on udev Kernel Socket. vm-test-run-plv8> server # [ 24.020966] systemd[1]: Mounting Huge Pages File System... vm-test-run-plv8> server # [ 24.057804] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-plv8> server # [ 24.107534] systemd[1]: Mounting Kernel Debug File System... vm-test-run-plv8> server # [ 24.185601] systemd[1]: Mounting Kernel Trace File System... vm-test-run-plv8> server # [ 24.296877] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-plv8> server # [ 24.402002] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-plv8> server # [ 24.420868] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-plv8> server # [ 24.510446] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-plv8> server # [ 24.520914] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-plv8> server # [ 24.528688] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-plv8> server # [ 24.588224] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-plv8> server # [ 24.606811] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-plv8> server # [ 24.618340] 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-plv8> server # [ 24.723362] systemd[1]: Starting Journal Service... vm-test-run-plv8> server # [ 24.800085] systemd[1]: Starting Load Kernel Modules... vm-test-run-plv8> server # [ 24.858256] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-plv8> server # [ 24.928838] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-plv8> server # [ 24.934567] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 24.994144] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-plv8> server # [ 25.066944] systemd[1]: Mounted Huge Pages File System. vm-test-run-plv8> server # [ 25.075300] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-plv8> server # [ 25.085903] systemd[1]: Mounted Kernel Debug File System. vm-test-run-plv8> server # [ 25.100539] systemd[1]: Mounted Kernel Trace File System. vm-test-run-plv8> server # [ 25.119577] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-plv8> server # [ 25.132873] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-plv8> server # [ 25.203534] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-plv8> server # [ 25.593605] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-plv8> server # [ 25.611549] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-plv8> server # [ 25.806282] EXT4-fs (vda): re-mounted 1428e7de-6bd6-474b-af52-37f5bc13167a. vm-test-run-plv8> server # [ 25.924657] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-plv8> server # [ 25.931172] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-plv8> server # [ 25.976241] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-plv8> server # [ 25.984813] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 26.017009] systemd[1]: Finished Load Kernel Modules. vm-test-run-plv8> server # [ 26.051499] fuse: init (API version 7.41) vm-test-run-plv8> server # [ 26.070965] systemd[1]: Starting Firewall... vm-test-run-plv8> server # [ 26.117382] systemd[1]: Starting Apply Kernel Variables... vm-test-run-plv8> server # [ 26.166588] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-plv8> server # [ 26.190044] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-plv8> server # [ 26.231254] systemd[1]: Mounting FUSE Control File System... vm-test-run-plv8> server # [ 26.458665] systemd[1]: Mounted FUSE Control File System. vm-test-run-plv8> server # [ 26.547782] systemd-journald[398]: Collecting audit messages is enabled. vm-test-run-plv8> server # [ 26.995431] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-plv8> server # [ 27.010043] systemd[1]: Reached target First Boot Complete. vm-test-run-plv8> server # [ 27.254697] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-plv8> server # [ 27.346773] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-plv8> server # [ 27.383525] systemd[1]: Finished Apply Kernel Variables. vm-test-run-plv8> server # [ 27.528322] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-plv8> server # [ 28.437597] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-plv8> server # [ 28.461217] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-plv8> server # [ 28.500543] systemd[1]: Mounting /run/wrappers... vm-test-run-plv8> server # [ 28.540882] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-plv8> server # [ 28.962629] systemd[1]: Started Journal Service. vm-test-run-plv8> server # [ 28.746810] systemd-modules-load[399]: Module 'atkbd' is built in vm-test-run-plv8> server # [ 28.789424] systemd-modules-load[399]: Module 'loop' is built in vm-test-run-plv8> server # [ 28.806784] systemd-oomd[400]: No swap; memory pressure usage will be degraded vm-test-run-plv8> server # [ 28.820099] systemd[1]: Mounted /run/wrappers. vm-test-run-plv8> server # [ 28.839410] systemd[1]: Reached target Local File Systems. vm-test-run-plv8> server # [ 28.874265] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-plv8> server # [ 28.931650] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-plv8> server # [ 28.967234] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-plv8> server # [ 28.980018] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-plv8> server: Guest root shell did not produce any data yet... vm-test-run-plv8> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-plv8> server # [ 29.005556] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-plv8> server # [ 29.801947] systemd-journald[398]: Received client request to flush runtime journal. vm-test-run-plv8> server # [ 30.189316] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-plv8> server # [ 30.214773] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-plv8> server # [ 30.238086] systemd-udevd[427]: Using default interface naming scheme 'v258'. vm-test-run-plv8> server # [ 30.248208] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-plv8> server # [ 30.298299] systemd[1]: Starting Create System Files and Directories... vm-test-run-plv8> server # [ 32.223760] systemd[1]: Finished Create System Files and Directories. vm-test-run-plv8> server # [ 32.332339] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-plv8> server # [ 32.417554] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-plv8> server # [ 32.431570] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-plv8> server # [ 33.610063] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-plv8> server # [ 34.649816] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-plv8> server # [ 34.689693] systemd[1]: Starting Update is Completed... vm-test-run-plv8> server # [ 35.448467] systemd[1]: Finished Update is Completed. vm-test-run-plv8> server # [ 39.668106] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-plv8> server # [ 39.683686] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-plv8> server # [ 39.700203] systemd[1]: suid-sgid-wrappers.service: Consumed 2.971s CPU time, 5.6M memory peak. vm-test-run-plv8> server # [ 42.052222] systemd[1]: Finished Firewall. vm-test-run-plv8> server # [ 43.548778] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-plv8> server # [ 43.562443] systemd[1]: Reached target System Initialization. vm-test-run-plv8> server # [ 43.574471] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-plv8> server # [ 43.576040] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-plv8> server # [ 43.587603] systemd[1]: Reached target Timer Units. vm-test-run-plv8> server # [ 43.597615] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-plv8> server # [ 43.606018] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-plv8> server # [ 43.608104] systemd[1]: Listening on Hostname Service Socket. vm-test-run-plv8> server # [ 43.619137] systemd[1]: Reached target Socket Units. vm-test-run-plv8> server # [ 43.626279] systemd[1]: Reached target Basic System. vm-test-run-plv8> server # [ 43.653009] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-plv8> server # [ 43.685898] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 43.737523] systemd[1]: Started Reset console on configuration changes. vm-test-run-plv8> server # [ 43.771606] systemd[1]: Starting resolvconf update... vm-test-run-plv8> server # [ 43.838003] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-plv8> server # [ 45.001865] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-plv8> server # [ 45.201605] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 45.243645] nsncd[631]: Oct 23 10:40:22.094 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 45.267966] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 45.281741] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 45.329487] systemd[1]: Starting User Login Management... vm-test-run-plv8> server # [ 45.583487] dbus-daemon[634]: dbus[634]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-plv8> server # [ 46.038826] systemd[1]: Started D-Bus System Message Bus. vm-test-run-plv8> server # [ 46.940467] systemd-logind[652]: New seat seat0. vm-test-run-plv8> server # [ 46.970377] systemd[1]: Started User Login Management. vm-test-run-plv8> server # [ 47.057940] systemd[1]: Starting linger-users.service... vm-test-run-plv8> server # [ 47.242129] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-plv8> server # [ 47.259116] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-plv8> server # [ 47.270689] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-plv8> server # [ 47.284123] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-plv8> server # [ 47.295932] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 47.337529] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-plv8> server # [ 47.352081] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 47.569518] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 47.686342] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-plv8> server # [ 47.705775] systemd[1]: Finished linger-users.service. vm-test-run-plv8> server # [ 48.412364] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 48.433427] nsncd[694]: Oct 23 10:40:25.337 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 48.437836] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 48.441513] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 48.958442] systemd[1]: Finished resolvconf update. vm-test-run-plv8> server # [ 48.976928] systemd[1]: Reached target Preparation for Network. vm-test-run-plv8> server # [ 49.029417] systemd[1]: Starting DHCP Client... vm-test-run-plv8> server # [ 50.695447] dhcpcd[742]: dhcpcd-10.2.4 starting vm-test-run-plv8> server # [ 50.868808] dhcpcd[764]: dev: loaded udev vm-test-run-plv8> server # [ 51.413970] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-plv8> server # [ 51.901786] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-plv8> server # [ 52.155493] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-plv8> server # [ 52.163685] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-plv8> server # [ 52.191400] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-plv8> server # [ 52.202412] cfg80211: failed to load regulatory.db vm-test-run-plv8> server # [ 53.033318] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-plv8> server # [ 52.810637] dhcpcd[764]: eth0: waiting for carrier vm-test-run-plv8> server # [ 52.820956] dhcpcd[764]: eth0: carrier acquired vm-test-run-plv8> server # [ 52.933037] dhcpcd[764]: DUID 00:01:00:01:32:6d:f6:1d:52:54:00:12:34:56 vm-test-run-plv8> server # [ 52.934587] dhcpcd[764]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 52.938644] dhcpcd[764]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-plv8> server # [ 53.759394] systemd[1]: Found device /dev/hvc0. vm-test-run-plv8> server # [ 53.862807] dhcpcd[764]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 53.920683] dhcpcd[764]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 53.947237] dhcpcd[764]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 54.377891] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-plv8> server # [ 54.416401] systemd[1]: Started backdoor.service. vm-test-run-plv8> server # [ 54.936896] (udev-worker)[787]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-plv8> server # [ 54.963310] (udev-worker)[782]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 54.978814] (udev-worker)[787]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 55.022063] dhcpcd[764]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 55.049638] dhcpcd[764]: eth0: Router Advertisement from fe80::2 vm-test-run-plv8> server # [ 55.053582] dhcpcd[764]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-plv8> server # [ 55.057424] dhcpcd[764]: eth0: adding route to fec0::/64 vm-test-run-plv8> server # [ 55.065142] dhcpcd[764]: eth0: adding default route via fe80::2 vm-test-run-plv8> server # connecting to host... vm-test-run-plv8> server: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-plv8> server: connected to guest root shell vm-test-run-plv8> server: (connecting took 56.33 seconds) vm-test-run-plv8> server: (finished: waiting for the VM to finish booting, in 56.33 seconds) vm-test-run-plv8> server # [ 56.173944] dhcpcd[764]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 56.280697] dhcpcd[764]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 56.285384] dhcpcd[764]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 56.291158] dhcpcd[764]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 56.299736] systemd[1]: Found device Virtio network device. vm-test-run-plv8> server # [ 56.378118] systemd[1]: Starting Address configuration of eth1... vm-test-run-plv8> server # [ 57.535698] dhcpcd[764]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 57.778787] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-plv8> server # [ 57.946852] network-addresses-eth1-start[814]: adding address 192.168.1.1/24... done vm-test-run-plv8> server # [ 58.190283] network-addresses-eth1-start[814]: adding address 2001:db8:1::1/64... done vm-test-run-plv8> server # [ 58.534471] systemd[1]: Finished Address configuration of eth1. vm-test-run-plv8> server # [ 58.597371] systemd[1]: Starting Networking Setup... vm-test-run-plv8> server # [ 61.371041] systemd[1]: Finished Networking Setup. vm-test-run-plv8> server # [ 61.379181] systemd[1]: Reached target Network. vm-test-run-plv8> server # [ 61.404901] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-plv8> server # [ 61.438032] systemd[1]: Starting Permit User Sessions... vm-test-run-plv8> server # [ 62.011706] dhcpcd[764]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-plv8> server # [ 62.026597] dhcpcd[764]: eth0: adding route to 10.0.2.0/24 vm-test-run-plv8> server # [ 62.050041] dhcpcd[764]: eth0: adding default route via 10.0.2.2 vm-test-run-plv8> server # [ 62.237186] systemd[1]: Finished Permit User Sessions. vm-test-run-plv8> server # [ 62.328111] systemd[1]: Started Getty on tty1. vm-test-run-plv8> server # [ 62.343615] systemd[1]: Reached target Login Prompts. vm-test-run-plv8> server # [ 63.487133] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[943]: Initializing database at /var/lib/postgresql/data vm-test-run-plv8> server # [ 66.050362] systemd[1]: Started DHCP Client. vm-test-run-plv8> server # [ 66.149284] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: The files belonging to this database system will be owned by user "postgres". vm-test-run-plv8> server # [ 66.152068] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: This user must also own the server process. vm-test-run-plv8> server # [ 66.255090] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-plv8> server # [ 66.261323] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: The default database encoding has accordingly been set to "UTF8". vm-test-run-plv8> server # [ 66.262536] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: The default text search configuration will be set to "english". vm-test-run-plv8> server # [ 66.263091] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: Data page checksums are enabled. vm-test-run-plv8> server # [ 66.264597] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-plv8> server # [ 66.282160] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: creating subdirectories ... ok vm-test-run-plv8> server # [ 66.295236] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: selecting dynamic shared memory implementation ... posix vm-test-run-plv8> server # [ 67.681825] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: selecting default max_connections ... 100 vm-test-run-plv8> server # [ 69.069986] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: selecting default shared_buffers ... 128MB vm-test-run-plv8> server # [ 72.591587] systemd-logind[652]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-plv8> server # [ 80.823857] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: selecting default time zone ... UTC vm-test-run-plv8> server # [ 80.870317] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: creating configuration files ... ok vm-test-run-plv8> server # [ 82.476862] mousedev: PS/2 mouse device common for all mice vm-test-run-plv8> server # [ 86.255929] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: running bootstrap script ... ok vm-test-run-plv8> server # [ 86.471089] systemd-logind[652]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-plv8> server # [ 99.223201] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: performing post-bootstrap initialization ... ok vm-test-run-plv8> server # [ 102.658279] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: syncing data to disk ... ok vm-test-run-plv8> server # [ 102.660030] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-plv8> server # [ 102.662444] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: 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-plv8> server # [ 102.664356] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: Success. You can now start the database server using: vm-test-run-plv8> server # [ 102.667064] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[956]: /nix/store/i45yhjwwac2d5ygyv0s5gbg2cgdjclf9-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-plv8> server # [ 104.318909] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[943]: Validating PostgreSQL configuration... vm-test-run-plv8> server # [ 105.139605] l6yd4rrp0smxa1b2if617bpa9fjcfvi1-postgresql-init[1367]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault vm-test-run-plv8> server # [ 106.451153] postgres[1382]: 2026-10-23 10:41:23.382 UTC [1382] LOG: pgaudit extension initialized vm-test-run-plv8> server # [ 107.115488] postgres[1382]: 2026-10-23 10:41:24.051 UTC [1382] LOG: pgsodium primary server secret key loaded vm-test-run-plv8> server # [ 107.823067] postgres[1382]: 2026-10-23 10:41:24.738 UTC [1382] LOG: vault primary server secret key loaded vm-test-run-plv8> server # [ 108.658942] postgres[1382]: 2026-10-23 10:41:25.594 UTC [1382] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-plv8> server # [ 108.676778] postgres[1382]: 2026-10-23 10:41:25.612 UTC [1382] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-plv8> server # [ 108.678606] postgres[1382]: 2026-10-23 10:41:25.614 UTC [1382] LOG: listening on IPv6 address "::", port 5432 vm-test-run-plv8> server # [ 108.701066] postgres[1382]: 2026-10-23 10:41:25.635 UTC [1382] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-plv8> server # [ 108.883049] postgres[1416]: 2026-10-23 10:41:25.807 UTC [1416] LOG: database system was shut down at 2026-10-23 10:41:15 UTC vm-test-run-plv8> server # [ 109.311789] postgres[1382]: 2026-10-23 10:41:26.239 UTC [1382] LOG: database system is ready to accept connections vm-test-run-plv8> server # [ 109.359473] postgres[1423]: 2026-10-23 10:41:26.265 UTC [1423] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 109.392777] systemd[1]: Started PostgreSQL Database Server. vm-test-run-plv8> server # [ 109.445269] systemd[1]: Starting Supabase Database Initialization... vm-test-run-plv8> server # [ 109.503763] postgres[1422]: 2026-10-23 10:41:26.422 UTC [1422] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-plv8> server # [ 109.589568] postgres[1382]: 2026-10-23 10:41:26.523 UTC [1382] LOG: background worker "pg_net 0.20.4 worker" (PID 1423) exited with exit code 1 vm-test-run-plv8> server # [ 109.819300] postgres[1425]: 2026-10-23 10:41:26.738 UTC [1425] LOG: pg_cron scheduler started vm-test-run-plv8> server # [ 109.935759] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Waiting for PostgreSQL to be ready... vm-test-run-plv8> server # [ 110.566056] postgres[1438]: ::1 2026-10-23 10:41:27.489 UTC [1438] root@root FATAL: role "root" does not exist vm-test-run-plv8> server # [ 110.639740] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: PostgreSQL is ready vm-test-run-plv8> server # [ 110.649280] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Creating postgres role... vm-test-run-plv8> server # [ 110.690320] postgres[1440]: 2026-10-23 10:41:27.623 UTC [1440] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 110.803446] postgres[1382]: 2026-10-23 10:41:27.717 UTC [1382] LOG: background worker "pg_net 0.20.4 worker" (PID 1440) exited with exit code 1 vm-test-run-plv8> server # [ 111.169553] postgres[1442]: ::1 2026-10-23 10:41:28.095 UTC [1442] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-plv8> server # [ 111.230467] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1441]: CREATE ROLE vm-test-run-plv8> server # [ 111.538507] postgres[1444]: ::1 2026-10-23 10:41:28.470 UTC [1444] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-plv8> server # [ 111.567070] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1443]: ALTER DATABASE vm-test-run-plv8> server # [ 111.643743] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-plv8> server # [ 112.139231] postgres[1453]: ::1 2026-10-23 10:41:29.062 UTC [1453] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-plv8> server # [ 112.181239] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: CREATE PUBLICATION vm-test-run-plv8> server # [ 112.202087] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: ALTER ROLE vm-test-run-plv8> server # [ 112.211418] postgres[1453]: ::1 2026-10-23 10:41:29.114 UTC [1453] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-plv8> server # [ 112.221958] postgres[1453]: ::1 2026-10-23 10:41:29.133 UTC [1453] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-plv8> server # [ 112.222999] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: CREATE ROLE vm-test-run-plv8> server # [ 112.234123] postgres[1453]: ::1 2026-10-23 10:41:29.162 UTC [1453] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-plv8> server # [ 112.245325] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: CREATE ROLE vm-test-run-plv8> server # [ 112.247266] postgres[1453]: ::1 2026-10-23 10:41:29.178 UTC [1453] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-plv8> server # [ 112.274911] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: GRANT ROLE vm-test-run-plv8> server # [ 112.282279] postgres[1453]: ::1 2026-10-23 10:41:29.210 UTC [1453] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-plv8> server # [ 112.301724] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: GRANT vm-test-run-plv8> server # [ 112.302805] postgres[1453]: ::1 2026-10-23 10:41:29.238 UTC [1453] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-plv8> server # [ 112.317477] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: CREATE ROLE vm-test-run-plv8> server # [ 112.318860] postgres[1453]: ::1 2026-10-23 10:41:29.251 UTC [1453] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-plv8> server # [ 112.331617] postgres[1453]: ::1 2026-10-23 10:41:29.264 UTC [1453] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-plv8> server # [ 112.337544] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: GRANT ROLE vm-test-run-plv8> server # [ 112.346741] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: CREATE SCHEMA vm-test-run-plv8> server # [ 112.356032] postgres[1453]: ::1 2026-10-23 10:41:29.286 UTC [1453] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-plv8> server # [ 115.553745] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: CREATE EXTENSION vm-test-run-plv8> server # [ 115.565640] postgres[1453]: ::1 2026-10-23 10:41:32.478 UTC [1453] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-plv8> server # [ 116.780544] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: CREATE EXTENSION vm-test-run-plv8> server # [ 116.790628] postgres[1453]: ::1 2026-10-23 10:41:33.694 UTC [1453] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-plv8> server # [ 116.794117] postgres[1453]: ::1 2026-10-23 10:41:33.706 UTC [1453] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-plv8> server # [ 116.807223] postgres[1453]: ::1 2026-10-23 10:41:33.716 UTC [1453] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-plv8> server # [ 116.814011] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: CREATE ROLE vm-test-run-plv8> server # [ 116.814646] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: CREATE ROLE vm-test-run-plv8> server # [ 116.816124] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: CREATE ROLE vm-test-run-plv8> server # [ 116.818475] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: CREATE ROLE vm-test-run-plv8> server # [ 116.822447] postgres[1453]: ::1 2026-10-23 10:41:33.725 UTC [1453] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-plv8> server # [ 116.830046] postgres[1453]: ::1 2026-10-23 10:41:33.737 UTC [1453] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-plv8> server # [ 116.831368] postgres[1453]: ::1 2026-10-23 10:41:33.751 UTC [1453] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-plv8> server # [ 116.838500] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: GRANT ROLE vm-test-run-plv8> server # [ 116.839249] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: GRANT ROLE vm-test-run-plv8> server # [ 116.840146] postgres[1453]: ::1 2026-10-23 10:41:33.762 UTC [1453] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-plv8> server # [ 116.845797] postgres[1453]: ::1 2026-10-23 10:41:33.779 UTC [1453] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-plv8> server # [ 116.846797] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: GRANT ROLE vm-test-run-plv8> server # [ 116.857588] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: GRANT ROLE vm-test-run-plv8> server # [ 116.865942] postgres[1453]: ::1 2026-10-23 10:41:33.797 UTC [1453] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.874166] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: GRANT vm-test-run-plv8> server # [ 116.885861] postgres[1453]: ::1 2026-10-23 10:41:33.812 UTC [1453] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.909395] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 116.910294] postgres[1453]: ::1 2026-10-23 10:41:33.845 UTC [1453] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.922727] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 116.923592] postgres[1453]: ::1 2026-10-23 10:41:33.859 UTC [1453] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.941656] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 116.944783] postgres[1453]: ::1 2026-10-23 10:41:33.879 UTC [1453] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.958777] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: GRANT vm-test-run-plv8> server # [ 116.965024] postgres[1453]: ::1 2026-10-23 10:41:33.895 UTC [1453] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-plv8> server # [ 116.974551] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: ALTER ROLE vm-test-run-plv8> server # [ 116.982183] postgres[1453]: ::1 2026-10-23 10:41:33.914 UTC [1453] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 116.983667] postgres[1453]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.987982] postgres[1453]: ::1 2026-10-23 10:41:33.923 UTC [1453] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 117.005491] postgres[1453]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 117.006491] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 117.006872] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 117.007364] postgres[1453]: ::1 2026-10-23 10:41:33.937 UTC [1453] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 117.007758] postgres[1453]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 117.018644] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 117.028174] postgres[1453]: ::1 2026-10-23 10:41:33.958 UTC [1453] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-plv8> server # [ 117.036110] postgres[1453]: ::1 2026-10-23 10:41:33.970 UTC [1453] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-plv8> server # [ 117.038352] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: ALTER ROLE vm-test-run-plv8> server # [ 117.047936] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1445]: ALTER ROLE vm-test-run-plv8> server # [ 117.158857] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-plv8> server # [ 117.443038] postgres[1501]: ::1 2026-10-23 10:41:34.369 UTC [1501] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 117.453173] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE SCHEMA vm-test-run-plv8> server # [ 117.457345] postgres[1501]: ::1 2026-10-23 10:41:34.391 UTC [1501] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-plv8> server # [ 117.458520] postgres[1501]: instance_id uuid NULL, vm-test-run-plv8> server # [ 117.459200] postgres[1501]: id uuid NOT NULL UNIQUE, vm-test-run-plv8> server # [ 117.459532] postgres[1501]: aud varchar(255) NULL, vm-test-run-plv8> server # [ 117.473109] postgres[1501]: "role" varchar(255) NULL, vm-test-run-plv8> server # [ 117.475196] postgres[1501]: email varchar(255) NULL UNIQUE, vm-test-run-plv8> server # [ 117.476466] postgres[1501]: encrypted_password varchar(255) NULL, vm-test-run-plv8> server # [ 117.477243] postgres[1501]: confirmed_at timestamptz NULL, vm-test-run-plv8> server # [ 117.478609] postgres[1501]: invited_at timestamptz NULL, vm-test-run-plv8> server # [ 117.480291] postgres[1501]: confirmation_token varchar(255) NULL, vm-test-run-plv8> server # [ 117.485086] postgres[1501]: confirmation_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 117.486384] postgres[1501]: recovery_token varchar(255) NULL, vm-test-run-plv8> server # [ 117.487335] postgres[1501]: recovery_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 117.490825] postgres[1501]: email_change_token varchar(255) NULL, vm-test-run-plv8> server # [ 117.493747] postgres[1501]: email_change varchar(255) NULL, vm-test-run-plv8> server # [ 117.494584] postgres[1501]: email_change_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 117.496296] postgres[1501]: last_sign_in_at timestamptz NULL, vm-test-run-plv8> server # [ 117.497676] postgres[1501]: raw_app_meta_data jsonb NULL, vm-test-run-plv8> server # [ 117.498852] postgres[1501]: raw_user_meta_data jsonb NULL, vm-test-run-plv8> server # [ 117.499561] postgres[1501]: is_super_admin bool NULL, vm-test-run-plv8> server # [ 117.502073] postgres[1501]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 117.502577] postgres[1501]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 117.503360] postgres[1501]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 117.504000] postgres[1501]: ); vm-test-run-plv8> server # [ 117.585154] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE TABLE vm-test-run-plv8> server # [ 117.595262] postgres[1501]: ::1 2026-10-23 10:41:34.524 UTC [1501] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-plv8> server # [ 117.621175] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE INDEX vm-test-run-plv8> server # [ 117.625265] postgres[1501]: ::1 2026-10-23 10:41:34.561 UTC [1501] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-plv8> server # [ 117.657273] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE INDEX vm-test-run-plv8> server # [ 117.658383] postgres[1501]: ::1 2026-10-23 10:41:34.591 UTC [1501] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-plv8> server # [ 117.664951] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: COMMENT vm-test-run-plv8> server # [ 117.667115] postgres[1501]: ::1 2026-10-23 10:41:34.603 UTC [1501] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-plv8> server # [ 117.670742] postgres[1501]: instance_id uuid NULL, vm-test-run-plv8> server # [ 117.677014] postgres[1501]: id bigserial NOT NULL, vm-test-run-plv8> server # [ 117.677548] postgres[1501]: "token" varchar(255) NULL, vm-test-run-plv8> server # [ 117.677853] postgres[1501]: user_id varchar(255) NULL, vm-test-run-plv8> server # [ 117.678579] postgres[1501]: revoked bool NULL, vm-test-run-plv8> server # [ 117.678857] postgres[1501]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 117.680008] postgres[1501]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 117.690857] postgres[1501]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 117.691585] postgres[1501]: ); vm-test-run-plv8> server # [ 117.749608] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE TABLE vm-test-run-plv8> server # [ 117.754126] postgres[1501]: ::1 2026-10-23 10:41:34.690 UTC [1501] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-plv8> server # [ 117.782630] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE INDEX vm-test-run-plv8> server # [ 117.783548] postgres[1501]: ::1 2026-10-23 10:41:34.718 UTC [1501] 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-plv8> server # [ 117.817441] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE INDEX vm-test-run-plv8> server # [ 117.819468] postgres[1501]: ::1 2026-10-23 10:41:34.755 UTC [1501] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-plv8> server # [ 117.853618] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE INDEX vm-test-run-plv8> server # [ 117.859896] postgres[1501]: ::1 2026-10-23 10:41:34.792 UTC [1501] 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-plv8> server # [ 117.869416] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: COMMENT vm-test-run-plv8> server # [ 117.870977] postgres[1501]: ::1 2026-10-23 10:41:34.805 UTC [1501] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-plv8> server # [ 117.871568] postgres[1501]: id uuid NOT NULL, vm-test-run-plv8> server # [ 117.878575] postgres[1501]: uuid uuid NULL, vm-test-run-plv8> server # [ 117.884233] postgres[1501]: raw_base_config text NULL, vm-test-run-plv8> server # [ 117.889149] postgres[1501]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 117.891738] postgres[1501]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 117.897832] postgres[1501]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 117.899240] postgres[1501]: ); vm-test-run-plv8> server # [ 117.935541] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE TABLE vm-test-run-plv8> server # [ 117.939532] postgres[1501]: ::1 2026-10-23 10:41:34.871 UTC [1501] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-plv8> server # [ 117.945957] postgres[1501]: ::1 2026-10-23 10:41:34.881 UTC [1501] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-plv8> server # [ 117.946752] postgres[1501]: instance_id uuid NULL, vm-test-run-plv8> server # [ 117.947670] postgres[1501]: id uuid NOT NULL, vm-test-run-plv8> server # [ 117.949968] postgres[1501]: payload json NULL, vm-test-run-plv8> server # [ 117.951127] postgres[1501]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 117.951510] postgres[1501]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 117.954587] postgres[1501]: ); vm-test-run-plv8> server # [ 117.958123] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: COMMENT vm-test-run-plv8> server # [ 118.003046] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE TABLE vm-test-run-plv8> server # [ 118.010507] postgres[1501]: ::1 2026-10-23 10:41:34.946 UTC [1501] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id); vm-test-run-plv8> server # [ 118.043628] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE INDEX vm-test-run-plv8> server # [ 118.045527] postgres[1501]: ::1 2026-10-23 10:41:34.981 UTC [1501] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-plv8> server # [ 118.055595] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: COMMENT vm-test-run-plv8> server # [ 118.058119] postgres[1501]: ::1 2026-10-23 10:41:34.993 UTC [1501] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-plv8> server # [ 118.059335] postgres[1501]: "version" varchar(255) NOT NULL, vm-test-run-plv8> server # [ 118.060209] postgres[1501]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-plv8> server # [ 118.066483] postgres[1501]: ); vm-test-run-plv8> server # [ 118.105344] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE TABLE vm-test-run-plv8> server # [ 118.107147] postgres[1501]: ::1 2026-10-23 10:41:35.039 UTC [1501] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-plv8> server # [ 118.117127] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: COMMENT vm-test-run-plv8> server # [ 118.166870] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: INSERT 0 7 vm-test-run-plv8> server # [ 118.177008] postgres[1501]: ::1 2026-10-23 10:41:35.098 UTC [1501] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-plv8> server # [ 118.197103] postgres[1501]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-plv8> server # [ 118.206359] postgres[1501]: $$ language sql stable; vm-test-run-plv8> server # [ 118.207641] postgres[1501]: ::1 2026-10-23 10:41:35.129 UTC [1501] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-plv8> server # [ 118.225593] postgres[1501]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-plv8> server # [ 118.226957] postgres[1501]: $$ language sql stable; vm-test-run-plv8> server # [ 118.233184] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE FUNCTION vm-test-run-plv8> server # [ 118.236003] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE FUNCTION vm-test-run-plv8> server # [ 118.237539] postgres[1501]: ::1 2026-10-23 10:41:35.152 UTC [1501] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-plv8> server # [ 118.238353] postgres[1501]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-plv8> server # [ 118.239682] postgres[1501]: $$ language sql stable; vm-test-run-plv8> server # [ 118.242986] postgres[1501]: ::1 2026-10-23 10:41:35.178 UTC [1501] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.245406] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE FUNCTION vm-test-run-plv8> server # [ 118.255332] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: GRANT vm-test-run-plv8> server # [ 118.257945] postgres[1501]: ::1 2026-10-23 10:41:35.191 UTC [1501] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 118.274118] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: CREATE ROLE vm-test-run-plv8> server # [ 118.275160] postgres[1501]: ::1 2026-10-23 10:41:35.210 UTC [1501] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.292581] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: GRANT vm-test-run-plv8> server # [ 118.293796] postgres[1501]: ::1 2026-10-23 10:41:35.228 UTC [1501] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.321529] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: GRANT vm-test-run-plv8> server # [ 118.322812] postgres[1501]: ::1 2026-10-23 10:41:35.252 UTC [1501] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.339514] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: GRANT vm-test-run-plv8> server # [ 118.351280] postgres[1501]: ::1 2026-10-23 10:41:35.271 UTC [1501] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-plv8> server # [ 118.354339] postgres[1501]: ::1 2026-10-23 10:41:35.290 UTC [1501] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.355108] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: ALTER ROLE vm-test-run-plv8> server # [ 118.385256] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: ALTER TABLE vm-test-run-plv8> server # [ 118.400127] postgres[1501]: ::1 2026-10-23 10:41:35.330 UTC [1501] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.430597] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: ALTER TABLE vm-test-run-plv8> server # [ 118.474886] postgres[1501]: ::1 2026-10-23 10:41:35.361 UTC [1501] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.511097] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: ALTER TABLE vm-test-run-plv8> server # [ 118.519449] postgres[1501]: ::1 2026-10-23 10:41:35.437 UTC [1501] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.526332] postgres[1501]: ::1 2026-10-23 10:41:35.457 UTC [1501] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.527725] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: ALTER TABLE vm-test-run-plv8> server # [ 118.545230] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1500]: ALTER TABLE vm-test-run-plv8> server # [ 118.591000] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-plv8> server # [ 119.163227] postgres[1520]: ::1 2026-10-23 10:41:36.077 UTC [1520] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 119.241776] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1513]: CREATE SCHEMA vm-test-run-plv8> server # [ 119.243112] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1513]: CREATE ROLE vm-test-run-plv8> server # [ 119.243501] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1513]: ALTER ROLE vm-test-run-plv8> server # [ 119.243905] postgres[1520]: ::1 2026-10-23 10:41:36.135 UTC [1520] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 119.257628] postgres[1520]: ::1 2026-10-23 10:41:36.146 UTC [1520] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-plv8> server # [ 119.259681] postgres[1520]: ::1 2026-10-23 10:41:36.183 UTC [1520] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-plv8> server # [ 119.274518] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1513]: GRANT vm-test-run-plv8> server # [ 119.331823] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1513]: DO vm-test-run-plv8> server # [ 119.378577] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-plv8> server # [ 119.810140] postgres[1529]: ::1 2026-10-23 10:41:36.737 UTC [1529] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-plv8> server # [ 119.823041] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: ALTER ROLE vm-test-run-plv8> server # [ 119.829677] postgres[1529]: ::1 2026-10-23 10:41:36.761 UTC [1529] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-plv8> server # [ 119.834416] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: ALTER ROLE vm-test-run-plv8> server # [ 119.839455] postgres[1529]: ::1 2026-10-23 10:41:36.774 UTC [1529] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-plv8> server # [ 119.845930] postgres[1529]: RETURNS event_trigger vm-test-run-plv8> server # [ 119.846935] postgres[1529]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 119.847999] postgres[1529]: AS $$ vm-test-run-plv8> server # [ 119.849489] postgres[1529]: DECLARE vm-test-run-plv8> server # [ 119.850332] postgres[1529]: schema_is_cron bool; vm-test-run-plv8> server # [ 119.852730] postgres[1529]: BEGIN vm-test-run-plv8> server # [ 119.853602] postgres[1529]: schema_is_cron = ( vm-test-run-plv8> server # [ 119.854650] postgres[1529]: SELECT n.nspname = 'cron' vm-test-run-plv8> server # [ 119.855633] postgres[1529]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 119.856806] postgres[1529]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-plv8> server # [ 119.857971] postgres[1529]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 119.858788] postgres[1529]: ); vm-test-run-plv8> server # [ 119.859174] postgres[1529]: vm-test-run-plv8> server # [ 119.861621] postgres[1529]: IF schema_is_cron vm-test-run-plv8> server # [ 119.862297] postgres[1529]: THEN vm-test-run-plv8> server # [ 119.863004] postgres[1529]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 119.863332] postgres[1529]: vm-test-run-plv8> server # [ 119.864003] postgres[1529]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 119.864658] postgres[1529]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 119.866213] postgres[1529]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 119.868291] postgres[1529]: vm-test-run-plv8> server # [ 119.869875] postgres[1529]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 119.870319] postgres[1529]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 119.870632] postgres[1529]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 119.872120] postgres[1529]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 119.872623] postgres[1529]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 119.874647] postgres[1529]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 119.875382] postgres[1529]: vm-test-run-plv8> server # [ 119.875911] postgres[1529]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 119.877717] postgres[1529]: vm-test-run-plv8> server # [ 119.878127] postgres[1529]: END IF; vm-test-run-plv8> server # [ 119.878384] postgres[1529]: vm-test-run-plv8> server # [ 119.878584] postgres[1529]: END; vm-test-run-plv8> server # [ 119.879329] postgres[1529]: $$; vm-test-run-plv8> server # [ 119.886938] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: CREATE FUNCTION vm-test-run-plv8> server # [ 119.888278] postgres[1529]: ::1 2026-10-23 10:41:36.824 UTC [1529] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA') vm-test-run-plv8> server # [ 119.889392] postgres[1529]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 119.901224] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 119.902599] postgres[1529]: ::1 2026-10-23 10:41:36.835 UTC [1529] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-plv8> server # [ 119.913173] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: COMMENT vm-test-run-plv8> server # [ 119.914084] postgres[1529]: ::1 2026-10-23 10:41:36.849 UTC [1529] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-plv8> server # [ 119.914537] postgres[1529]: RETURNS event_trigger vm-test-run-plv8> server # [ 119.915055] postgres[1529]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 119.915759] postgres[1529]: AS $$ vm-test-run-plv8> server # [ 119.916102] postgres[1529]: BEGIN vm-test-run-plv8> server # [ 119.916531] postgres[1529]: IF EXISTS ( vm-test-run-plv8> server # [ 119.917858] postgres[1529]: SELECT 1 vm-test-run-plv8> server # [ 119.918200] postgres[1529]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 119.918478] postgres[1529]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 119.919066] postgres[1529]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 119.920533] postgres[1529]: WHERE ext.extname = 'pg_net' vm-test-run-plv8> server # [ 119.921625] postgres[1529]: ) vm-test-run-plv8> server # [ 119.922661] postgres[1529]: THEN vm-test-run-plv8> server # [ 119.923242] postgres[1529]: IF NOT EXISTS ( vm-test-run-plv8> server # [ 119.923540] postgres[1529]: SELECT 1 vm-test-run-plv8> server # [ 119.924650] postgres[1529]: FROM pg_roles vm-test-run-plv8> server # [ 119.925018] postgres[1529]: WHERE rolname = 'supabase_functions_admin' vm-test-run-plv8> server # [ 119.925293] postgres[1529]: ) vm-test-run-plv8> server # [ 119.925524] postgres[1529]: THEN vm-test-run-plv8> server # [ 119.925749] postgres[1529]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 119.926771] postgres[1529]: END IF; vm-test-run-plv8> server # [ 119.927476] postgres[1529]: vm-test-run-plv8> server # [ 119.928982] postgres[1529]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.930535] postgres[1529]: vm-test-run-plv8> server # [ 119.930808] postgres[1529]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 119.931129] postgres[1529]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 119.931592] postgres[1529]: vm-test-run-plv8> server # [ 119.931984] postgres[1529]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plv8> server # [ 119.932397] postgres[1529]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plv8> server # [ 119.934588] postgres[1529]: vm-test-run-plv8> server # [ 119.935161] postgres[1529]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plv8> server # [ 119.936898] postgres[1529]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plv8> server # [ 119.937894] postgres[1529]: vm-test-run-plv8> server # [ 119.938207] postgres[1529]: 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-plv8> server # [ 119.938691] postgres[1529]: 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-plv8> server # [ 119.939101] postgres[1529]: END IF; vm-test-run-plv8> server # [ 119.939315] postgres[1529]: END; vm-test-run-plv8> server # [ 119.940002] postgres[1529]: $$; vm-test-run-plv8> server # [ 119.940434] postgres[1529]: ::1 2026-10-23 10:41:36.874 UTC [1529] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-plv8> server # [ 119.943647] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: CREATE FUNCTION vm-test-run-plv8> server # [ 119.947299] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: COMMENT vm-test-run-plv8> server # [ 119.968928] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: DO vm-test-run-plv8> server # [ 119.981250] postgres[1529]: ::1 2026-10-23 10:41:36.905 UTC [1529] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-plv8> server # [ 119.993713] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: CREATE ROLE vm-test-run-plv8> server # [ 119.994516] postgres[1529]: ::1 2026-10-23 10:41:36.926 UTC [1529] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-plv8> server # [ 120.003026] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: GRANT vm-test-run-plv8> server # [ 120.009553] postgres[1529]: ::1 2026-10-23 10:41:36.942 UTC [1529] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 120.021070] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: GRANT vm-test-run-plv8> server # [ 120.022451] postgres[1529]: ::1 2026-10-23 10:41:36.954 UTC [1529] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 120.036935] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: GRANT vm-test-run-plv8> server # [ 120.038447] postgres[1529]: ::1 2026-10-23 10:41:36.970 UTC [1529] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 120.051633] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: GRANT vm-test-run-plv8> server # [ 120.058608] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: GRANT vm-test-run-plv8> server # [ 120.064759] postgres[1529]: ::1 2026-10-23 10:41:36.990 UTC [1529] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 120.068229] postgres[1529]: ::1 2026-10-23 10:41:36.998 UTC [1529] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 120.069990] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: GRANT vm-test-run-plv8> server # [ 120.074038] postgres[1529]: ::1 2026-10-23 10:41:37.007 UTC [1529] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 120.076688] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: GRANT vm-test-run-plv8> server # [ 120.081417] postgres[1529]: ::1 2026-10-23 10:41:37.015 UTC [1529] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 120.106277] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: GRANT vm-test-run-plv8> server # [ 120.107436] postgres[1529]: ::1 2026-10-23 10:41:37.038 UTC [1529] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 120.141658] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: GRANT vm-test-run-plv8> server # [ 120.165510] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: DO vm-test-run-plv8> server # [ 120.222719] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running pgbouncer auth schema... vm-test-run-plv8> server # [ 120.483365] postgres[1531]: ::1 2026-10-23 10:41:37.413 UTC [1531] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-plv8> server # [ 120.495471] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1530]: CREATE ROLE vm-test-run-plv8> server # [ 120.502639] postgres[1531]: ::1 2026-10-23 10:41:37.433 UTC [1531] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-plv8> server # [ 120.509027] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1530]: REVOKE vm-test-run-plv8> server # [ 120.512960] postgres[1531]: ::1 2026-10-23 10:41:37.446 UTC [1531] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-plv8> server # [ 120.554720] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1530]: CREATE SCHEMA vm-test-run-plv8> server # [ 120.566133] postgres[1531]: ::1 2026-10-23 10:41:37.488 UTC [1531] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-plv8> server # [ 120.571327] postgres[1531]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-plv8> server # [ 120.572120] postgres[1531]: $$ vm-test-run-plv8> server # [ 120.583080] postgres[1531]: BEGIN vm-test-run-plv8> server # [ 120.591960] postgres[1531]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-plv8> server # [ 120.614576] postgres[1531]: vm-test-run-plv8> server # [ 120.615232] postgres[1531]: RETURN QUERY vm-test-run-plv8> server # [ 120.615885] postgres[1531]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-plv8> server # [ 120.622572] postgres[1531]: WHERE usename = p_usename; vm-test-run-plv8> server # [ 120.623120] postgres[1531]: END; vm-test-run-plv8> server # [ 120.623444] postgres[1531]: $$ LANGUAGE plpgsql vm-test-run-plv8> server # [ 120.637454] postgres[1531]: SET search_path = '' vm-test-run-plv8> server # [ 120.638756] postgres[1531]: SECURITY DEFINER; vm-test-run-plv8> server # [ 120.646982] postgres[1531]: ::1 2026-10-23 10:41:37.548 UTC [1531] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-plv8> server # [ 120.651681] postgres[1531]: ::1 2026-10-23 10:41:37.570 UTC [1531] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-plv8> server # [ 120.659009] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1530]: CREATE FUNCTION vm-test-run-plv8> server # [ 120.659724] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1530]: REVOKE vm-test-run-plv8> server # [ 120.667011] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1530]: GRANT vm-test-run-plv8> server # [ 120.727470] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running stat extension... vm-test-run-plv8> server # [ 121.090235] postgres[1537]: ::1 2026-10-23 10:41:38.012 UTC [1537] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-plv8> server # [ 121.114848] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1535]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-plv8> server # [ 121.146386] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1535]: CREATE SCHEMA vm-test-run-plv8> server # [ 121.154520] postgres[1537]: ::1 2026-10-23 10:41:38.081 UTC [1537] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-plv8> server # [ 122.711591] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1535]: CREATE EXTENSION vm-test-run-plv8> server # [ 122.810089] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-plv8> server # [ 123.165846] postgres[1563]: ::1 2026-10-23 10:41:40.095 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-plv8> server # [ 123.193775] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 123.194689] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 123.195568] postgres[1563]: ::1 2026-10-23 10:41:40.110 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 123.202002] postgres[1563]: ::1 2026-10-23 10:41:40.121 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 123.212079] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 123.222405] postgres[1563]: ::1 2026-10-23 10:41:40.147 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 123.235177] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 123.245250] postgres[1563]: ::1 2026-10-23 10:41:40.171 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 123.256120] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 123.258932] postgres[1563]: ::1 2026-10-23 10:41:40.189 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 123.271574] postgres[1563]: ::1 2026-10-23 10:41:40.198 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 123.279018] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 123.279708] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 123.281617] postgres[1563]: ::1 2026-10-23 10:41:40.209 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 123.289142] postgres[1563]: ::1 2026-10-23 10:41:40.225 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 123.290385] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 123.335139] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 123.373261] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: DO vm-test-run-plv8> server # [ 123.374555] postgres[1563]: ::1 2026-10-23 10:41:40.307 UTC [1563] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-plv8> server # [ 123.383485] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: ALTER ROLE vm-test-run-plv8> server # [ 123.439020] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-plv8> server # [ 123.703220] postgres[1565]: ::1 2026-10-23 10:41:40.629 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 123.714395] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: GRANT vm-test-run-plv8> server # [ 123.718433] postgres[1565]: ::1 2026-10-23 10:41:40.647 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 123.725354] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: GRANT vm-test-run-plv8> server # [ 123.726694] postgres[1565]: ::1 2026-10-23 10:41:40.659 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 123.738094] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: GRANT vm-test-run-plv8> server # [ 123.744850] postgres[1565]: ::1 2026-10-23 10:41:40.677 UTC [1565] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 123.750812] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: ALTER TABLE vm-test-run-plv8> server # [ 123.753347] postgres[1565]: ::1 2026-10-23 10:41:40.688 UTC [1565] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 123.764657] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: ALTER TABLE vm-test-run-plv8> server # [ 123.767647] postgres[1565]: ::1 2026-10-23 10:41:40.703 UTC [1565] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 123.777794] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: ALTER TABLE vm-test-run-plv8> server # [ 123.782496] postgres[1565]: ::1 2026-10-23 10:41:40.715 UTC [1565] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 123.788034] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: ALTER TABLE vm-test-run-plv8> server # [ 123.789587] postgres[1565]: ::1 2026-10-23 10:41:40.725 UTC [1565] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 123.798526] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: ALTER TABLE vm-test-run-plv8> server # [ 123.805320] postgres[1565]: ::1 2026-10-23 10:41:40.738 UTC [1565] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 123.810878] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: GRANT vm-test-run-plv8> server # [ 123.817712] postgres[1565]: ::1 2026-10-23 10:41:40.750 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 123.823379] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: GRANT vm-test-run-plv8> server # [ 123.829818] postgres[1565]: ::1 2026-10-23 10:41:40.762 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 123.834215] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: GRANT vm-test-run-plv8> server # [ 123.840680] postgres[1565]: ::1 2026-10-23 10:41:40.774 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 123.851045] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: GRANT vm-test-run-plv8> server # [ 123.854856] postgres[1565]: ::1 2026-10-23 10:41:40.787 UTC [1565] 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-plv8> server # [ 123.867629] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 123.870569] postgres[1565]: ::1 2026-10-23 10:41:40.806 UTC [1565] 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-plv8> server # [ 123.879590] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 123.885162] postgres[1565]: ::1 2026-10-23 10:41:40.817 UTC [1565] 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-plv8> server # [ 123.891938] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 123.933779] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-plv8> server # [ 124.220835] postgres[1567]: ::1 2026-10-23 10:41:41.147 UTC [1567] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-plv8> server # [ 124.247249] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1566]: CREATE SCHEMA vm-test-run-plv8> server # [ 124.290490] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-plv8> server # [ 124.719693] postgres[1572]: ::1 2026-10-23 10:41:41.631 UTC [1572] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-plv8> server # [ 124.773368] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1568]: GRANT vm-test-run-plv8> server # [ 124.774459] postgres[1572]: ::1 2026-10-23 10:41:41.697 UTC [1572] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 124.784938] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1568]: GRANT vm-test-run-plv8> server # [ 124.806045] postgres[1572]: ::1 2026-10-23 10:41:41.723 UTC [1572] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 124.822337] postgres[1572]: ::1 2026-10-23 10:41:41.748 UTC [1572] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 124.823551] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1568]: GRANT vm-test-run-plv8> server # [ 124.845828] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1568]: GRANT vm-test-run-plv8> server # [ 124.924403] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-plv8> server # [ 125.676818] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1581]: DO vm-test-run-plv8> server # [ 125.686403] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1581]: DO vm-test-run-plv8> server # [ 125.709931] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1581]: DO vm-test-run-plv8> server # [ 125.797576] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-plv8> server # [ 126.210427] postgres[1597]: ::1 2026-10-23 10:41:43.140 UTC [1597] 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-plv8> server # [ 126.232984] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 126.240525] postgres[1597]: ::1 2026-10-23 10:41:43.170 UTC [1597] 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-plv8> server # [ 126.247348] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 126.250436] postgres[1597]: ::1 2026-10-23 10:41:43.186 UTC [1597] 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-plv8> server # [ 126.265194] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 126.295548] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-plv8> server # [ 126.562530] postgres[1599]: ::1 2026-10-23 10:41:43.488 UTC [1599] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-plv8> server # [ 126.575314] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1598]: ALTER ROLE vm-test-run-plv8> server # [ 126.618855] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-plv8> server # [ 126.991144] postgres[1604]: ::1 2026-10-23 10:41:43.923 UTC [1604] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 127.013912] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-plv8> server # [ 127.019532] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 127.026099] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-plv8> server # [ 127.027624] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: DROP FUNCTION vm-test-run-plv8> server # [ 127.029611] postgres[1604]: ::1 2026-10-23 10:41:43.941 UTC [1604] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 127.030385] postgres[1604]: ::1 2026-10-23 10:41:43.958 UTC [1604] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 127.031072] postgres[1604]: DECLARE vm-test-run-plv8> server # [ 127.031711] postgres[1604]: cmd record; vm-test-run-plv8> server # [ 127.040007] postgres[1604]: BEGIN vm-test-run-plv8> server # [ 127.049862] postgres[1604]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 127.053845] postgres[1604]: LOOP vm-test-run-plv8> server # [ 127.054358] postgres[1604]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 127.054951] postgres[1604]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 127.055933] postgres[1604]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 127.056313] postgres[1604]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 127.069750] postgres[1604]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 127.070719] postgres[1604]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 127.071121] postgres[1604]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 127.075314] postgres[1604]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 127.081741] postgres[1604]: , 'CREATE TYPE' vm-test-run-plv8> server # [ 127.083622] postgres[1604]: , 'CREATE RULE' vm-test-run-plv8> server # [ 127.086583] postgres[1604]: , 'COMMENT' vm-test-run-plv8> server # [ 127.087960] postgres[1604]: ) vm-test-run-plv8> server # [ 127.088300] postgres[1604]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 127.090154] postgres[1604]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 127.091981] postgres[1604]: THEN vm-test-run-plv8> server # [ 127.092997] postgres[1604]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 127.093369] postgres[1604]: END IF; vm-test-run-plv8> server # [ 127.096119] postgres[1604]: END LOOP; vm-test-run-plv8> server # [ 127.101093] postgres[1604]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 127.101909] postgres[1604]: ::1 2026-10-23 10:41:44.018 UTC [1604] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 127.102326] postgres[1604]: DECLARE vm-test-run-plv8> server # [ 127.103153] postgres[1604]: obj record; vm-test-run-plv8> server # [ 127.105630] postgres[1604]: BEGIN vm-test-run-plv8> server # [ 127.106434] postgres[1604]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 127.109321] postgres[1604]: LOOP vm-test-run-plv8> server # [ 127.109997] postgres[1604]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 127.110508] postgres[1604]: 'schema' vm-test-run-plv8> server # [ 127.111039] postgres[1604]: , 'table' vm-test-run-plv8> server # [ 127.112057] postgres[1604]: , 'foreign table' vm-test-run-plv8> server # [ 127.113451] postgres[1604]: , 'view' vm-test-run-plv8> server # [ 127.114056] postgres[1604]: , 'materialized view' vm-test-run-plv8> server # [ 127.114879] postgres[1604]: , 'function' vm-test-run-plv8> server # [ 127.115599] postgres[1604]: , 'trigger' vm-test-run-plv8> server # [ 127.116043] postgres[1604]: , 'type' vm-test-run-plv8> server # [ 127.118484] postgres[1604]: , 'rule' vm-test-run-plv8> server # [ 127.119006] postgres[1604]: ) vm-test-run-plv8> server # [ 127.119396] postgres[1604]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 127.119969] postgres[1604]: THEN vm-test-run-plv8> server # [ 127.121708] postgres[1604]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 127.122276] postgres[1604]: END IF; vm-test-run-plv8> server # [ 127.122556] postgres[1604]: END LOOP; vm-test-run-plv8> server # [ 127.124245] postgres[1604]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 127.127029] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: CREATE FUNCTION vm-test-run-plv8> server # [ 127.131314] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: CREATE FUNCTION vm-test-run-plv8> server # [ 127.138902] postgres[1604]: ::1 2026-10-23 10:41:44.069 UTC [1604] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 127.148148] postgres[1604]: ::1 2026-10-23 10:41:44.082 UTC [1604] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 127.153999] postgres[1604]: ON ddl_command_end vm-test-run-plv8> server # [ 127.155763] postgres[1604]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 127.156790] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-plv8> server # [ 127.169546] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 127.172816] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 127.178651] postgres[1604]: ::1 2026-10-23 10:41:44.114 UTC [1604] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 127.186680] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-plv8> server # [ 127.194617] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 127.195750] postgres[1604]: ::1 2026-10-23 10:41:44.126 UTC [1604] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 127.199014] postgres[1604]: ON sql_drop vm-test-run-plv8> server # [ 127.204018] postgres[1604]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 127.205515] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 127.293452] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-plv8> server # [ 128.354257] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1606]: DO vm-test-run-plv8> server # [ 128.406890] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-plv8> server # [ 128.966094] postgres[1625]: ::1 2026-10-23 10:41:45.878 UTC [1625] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-plv8> server # [ 129.094998] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: CREATE SCHEMA vm-test-run-plv8> server # [ 129.102424] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping vm-test-run-plv8> server # [ 129.103615] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: DROP FUNCTION vm-test-run-plv8> server # [ 129.107473] postgres[1625]: ::1 2026-10-23 10:41:46.021 UTC [1625] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-plv8> server # [ 129.113565] postgres[1625]: ::1 2026-10-23 10:41:46.038 UTC [1625] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 129.114539] postgres[1625]: "operationName" text default null, vm-test-run-plv8> server # [ 129.114942] postgres[1625]: query text default null, vm-test-run-plv8> server # [ 129.115431] postgres[1625]: variables jsonb default null, vm-test-run-plv8> server # [ 129.123139] postgres[1625]: extensions jsonb default null vm-test-run-plv8> server # [ 129.124186] postgres[1625]: ) vm-test-run-plv8> server # [ 129.124507] postgres[1625]: returns jsonb vm-test-run-plv8> server # [ 129.126158] postgres[1625]: language plpgsql vm-test-run-plv8> server # [ 129.129717] postgres[1625]: as $$ vm-test-run-plv8> server # [ 129.130778] postgres[1625]: DECLARE vm-test-run-plv8> server # [ 129.133277] postgres[1625]: server_version float; vm-test-run-plv8> server # [ 129.135037] postgres[1625]: BEGIN vm-test-run-plv8> server # [ 129.139206] postgres[1625]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 129.141501] postgres[1625]: vm-test-run-plv8> server # [ 129.142911] postgres[1625]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 129.146138] postgres[1625]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 129.146677] postgres[1625]: 'data', null::jsonb, vm-test-run-plv8> server # [ 129.146987] postgres[1625]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 129.148451] postgres[1625]: ); vm-test-run-plv8> server # [ 129.150640] postgres[1625]: ELSE vm-test-run-plv8> server # [ 129.151700] postgres[1625]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 129.153444] postgres[1625]: 'data', null::jsonb, vm-test-run-plv8> server # [ 129.155347] postgres[1625]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 129.157649] postgres[1625]: ); vm-test-run-plv8> server # [ 129.158141] postgres[1625]: END IF; vm-test-run-plv8> server # [ 129.159464] postgres[1625]: END; vm-test-run-plv8> server # [ 129.160797] postgres[1625]: $$; vm-test-run-plv8> server # [ 129.165241] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: CREATE FUNCTION vm-test-run-plv8> server # [ 129.166242] postgres[1625]: ::1 2026-10-23 10:41:46.099 UTC [1625] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 129.188151] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: GRANT vm-test-run-plv8> server # [ 129.201810] postgres[1625]: ::1 2026-10-23 10:41:46.124 UTC [1625] 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-plv8> server # [ 129.212467] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 129.218277] postgres[1625]: ::1 2026-10-23 10:41:46.148 UTC [1625] 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-plv8> server # [ 129.231057] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 129.261142] postgres[1625]: ::1 2026-10-23 10:41:46.167 UTC [1625] 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-plv8> server # [ 129.289257] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 129.305202] postgres[1625]: ::1 2026-10-23 10:41:46.214 UTC [1625] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 129.325539] postgres[1625]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 129.332507] postgres[1625]: ::1 2026-10-23 10:41:46.254 UTC [1625] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 129.334457] postgres[1625]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 129.342134] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 129.359655] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 129.366863] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 129.374215] postgres[1625]: ::1 2026-10-23 10:41:46.274 UTC [1625] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 129.376285] postgres[1625]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 129.379020] postgres[1625]: ::1 2026-10-23 10:41:46.297 UTC [1625] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 129.381553] postgres[1625]: RETURNS event_trigger vm-test-run-plv8> server # [ 129.382362] postgres[1625]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 129.386053] postgres[1625]: AS $func$ vm-test-run-plv8> server # [ 129.386567] postgres[1625]: DECLARE vm-test-run-plv8> server # [ 129.386850] postgres[1625]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 129.387693] postgres[1625]: BEGIN vm-test-run-plv8> server # [ 129.400036] postgres[1625]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 129.411702] postgres[1625]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 129.423689] postgres[1625]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 129.424794] postgres[1625]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 129.426220] postgres[1625]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 129.427436] postgres[1625]: ); vm-test-run-plv8> server # [ 129.438024] postgres[1625]: vm-test-run-plv8> server # [ 129.445290] postgres[1625]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 129.446158] postgres[1625]: THEN vm-test-run-plv8> server # [ 129.447061] postgres[1625]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 129.453549] postgres[1625]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 129.454874] postgres[1625]: vm-test-run-plv8> server # [ 129.455268] postgres[1625]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 129.462707] postgres[1625]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 129.466296] postgres[1625]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 129.475340] postgres[1625]: vm-test-run-plv8> server # [ 129.475892] postgres[1625]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 129.498174] postgres[1625]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 129.498810] postgres[1625]: "operationName" text default null, vm-test-run-plv8> server # [ 129.499355] postgres[1625]: query text default null, vm-test-run-plv8> server # [ 129.510393] postgres[1625]: variables jsonb default null, vm-test-run-plv8> server # [ 129.511563] postgres[1625]: extensions jsonb default null vm-test-run-plv8> server # [ 129.512189] postgres[1625]: ) vm-test-run-plv8> server # [ 129.512693] postgres[1625]: returns jsonb vm-test-run-plv8> server # [ 129.524754] postgres[1625]: language sql vm-test-run-plv8> server # [ 129.525883] postgres[1625]: as $$ vm-test-run-plv8> server # [ 129.526572] postgres[1625]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-plv8> server # [ 129.526918] postgres[1625]: $$; vm-test-run-plv8> server # [ 129.527647] postgres[1625]: vm-test-run-plv8> server # [ 129.533492] postgres[1625]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 129.535269] postgres[1625]: END IF; vm-test-run-plv8> server # [ 129.536132] postgres[1625]: vm-test-run-plv8> server # [ 129.537884] postgres[1625]: END; vm-test-run-plv8> server # [ 129.538416] postgres[1625]: $func$; vm-test-run-plv8> server # [ 129.539991] postgres[1625]: ::1 2026-10-23 10:41:46.327 UTC [1625] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-plv8> server # [ 129.546105] postgres[1625]: ::1 2026-10-23 10:41:46.344 UTC [1625] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION') vm-test-run-plv8> server # [ 129.547333] postgres[1625]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-plv8> server # [ 129.548402] postgres[1625]: ::1 2026-10-23 10:41:46.386 UTC [1625] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-plv8> server # [ 129.550256] postgres[1625]: ::1 2026-10-23 10:41:46.418 UTC [1625] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 129.550947] postgres[1625]: RETURNS event_trigger vm-test-run-plv8> server # [ 129.551247] postgres[1625]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 129.557201] postgres[1625]: AS $func$ vm-test-run-plv8> server # [ 129.557896] postgres[1625]: DECLARE vm-test-run-plv8> server # [ 129.558572] postgres[1625]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 129.559205] postgres[1625]: BEGIN vm-test-run-plv8> server # [ 129.559697] postgres[1625]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 129.565357] postgres[1625]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 129.566352] postgres[1625]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 129.566963] postgres[1625]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 129.567744] postgres[1625]: ); vm-test-run-plv8> server # [ 129.568205] postgres[1625]: vm-test-run-plv8> server # [ 129.572673] postgres[1625]: IF graphql_is_dropped vm-test-run-plv8> server # [ 129.573554] postgres[1625]: THEN vm-test-run-plv8> server # [ 129.574120] postgres[1625]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 129.574450] postgres[1625]: "operationName" text default null, vm-test-run-plv8> server # [ 129.574896] postgres[1625]: query text default null, vm-test-run-plv8> server # [ 129.576351] postgres[1625]: variables jsonb default null, vm-test-run-plv8> server # [ 129.580899] postgres[1625]: extensions jsonb default null vm-test-run-plv8> server # [ 129.581792] postgres[1625]: ) vm-test-run-plv8> server # [ 129.582074] postgres[1625]: returns jsonb vm-test-run-plv8> server # [ 129.582698] postgres[1625]: language plpgsql vm-test-run-plv8> server # [ 129.583467] postgres[1625]: as $$ vm-test-run-plv8> server # [ 129.589203] postgres[1625]: DECLARE vm-test-run-plv8> server # [ 129.589958] postgres[1625]: server_version float; vm-test-run-plv8> server # [ 129.590421] postgres[1625]: BEGIN vm-test-run-plv8> server # [ 129.591251] postgres[1625]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 129.591560] postgres[1625]: vm-test-run-plv8> server # [ 129.591948] postgres[1625]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 129.595636] postgres[1625]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 129.601069] postgres[1625]: 'data', null::jsonb, vm-test-run-plv8> server # [ 129.602095] postgres[1625]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 129.603217] postgres[1625]: ); vm-test-run-plv8> server # [ 129.603644] postgres[1625]: ELSE vm-test-run-plv8> server # [ 129.604173] postgres[1625]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 129.610961] postgres[1625]: 'data', null::jsonb, vm-test-run-plv8> server # [ 129.616689] postgres[1625]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 129.618083] postgres[1625]: ); vm-test-run-plv8> server # [ 129.618739] postgres[1625]: END IF; vm-test-run-plv8> server # [ 129.619876] postgres[1625]: END; vm-test-run-plv8> server # [ 129.625854] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: CREATE FUNCTION vm-test-run-plv8> server # [ 129.626581] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping vm-test-run-plv8> server # [ 129.628230] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 129.637757] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 129.638869] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: COMMENT vm-test-run-plv8> server # [ 129.640079] postgres[1625]: $$; vm-test-run-plv8> server # [ 129.647194] postgres[1625]: END IF; vm-test-run-plv8> server # [ 129.649314] postgres[1625]: vm-test-run-plv8> server # [ 129.654042] postgres[1625]: END; vm-test-run-plv8> server # [ 129.654390] postgres[1625]: $func$; vm-test-run-plv8> server # [ 129.654790] postgres[1625]: ::1 2026-10-23 10:41:46.587 UTC [1625] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-plv8> server # [ 129.655221] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: CREATE FUNCTION vm-test-run-plv8> server # [ 129.655489] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping vm-test-run-plv8> server # [ 129.665184] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 129.689338] postgres[1625]: ::1 2026-10-23 10:41:46.599 UTC [1625] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-plv8> server # [ 129.691541] postgres[1625]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-plv8> server # [ 129.697654] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 129.698366] postgres[1625]: ::1 2026-10-23 10:41:46.631 UTC [1625] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql'; vm-test-run-plv8> server # [ 129.717566] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1618]: COMMENT vm-test-run-plv8> server # [ 129.806602] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-plv8> server # [ 130.063200] postgres[1635]: ::1 2026-10-23 10:41:46.990 UTC [1635] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 130.077657] postgres[1635]: ::1 2026-10-23 10:41:47.000 UTC [1635] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 130.091033] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1634]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-plv8> server # [ 130.095933] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1634]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 130.096711] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1634]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-plv8> server # [ 130.097586] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1634]: DROP FUNCTION vm-test-run-plv8> server # [ 130.108759] postgres[1635]: ::1 2026-10-23 10:41:47.026 UTC [1635] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 130.110169] postgres[1635]: DECLARE vm-test-run-plv8> server # [ 130.110603] postgres[1635]: cmd record; vm-test-run-plv8> server # [ 130.112189] postgres[1635]: BEGIN vm-test-run-plv8> server # [ 130.117683] postgres[1635]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 130.121629] postgres[1635]: LOOP vm-test-run-plv8> server # [ 130.122342] postgres[1635]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 130.123252] postgres[1635]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 130.126783] postgres[1635]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 130.129178] postgres[1635]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 130.129804] postgres[1635]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 130.133441] postgres[1635]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 130.134000] postgres[1635]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 130.134274] postgres[1635]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 130.134522] postgres[1635]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-plv8> server # [ 130.134767] postgres[1635]: , 'CREATE RULE' vm-test-run-plv8> server # [ 130.135033] postgres[1635]: , 'COMMENT' vm-test-run-plv8> server # [ 130.136029] postgres[1635]: ) vm-test-run-plv8> server # [ 130.138139] postgres[1635]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 130.138702] postgres[1635]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 130.140001] postgres[1635]: THEN vm-test-run-plv8> server # [ 130.140997] postgres[1635]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 130.141516] postgres[1635]: END IF; vm-test-run-plv8> server # [ 130.141791] postgres[1635]: END LOOP; vm-test-run-plv8> server # [ 130.142275] postgres[1635]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 130.170351] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1634]: CREATE FUNCTION vm-test-run-plv8> server # [ 130.176794] postgres[1635]: ::1 2026-10-23 10:41:47.106 UTC [1635] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 130.178001] postgres[1635]: DECLARE vm-test-run-plv8> server # [ 130.178721] postgres[1635]: obj record; vm-test-run-plv8> server # [ 130.179050] postgres[1635]: BEGIN vm-test-run-plv8> server # [ 130.179299] postgres[1635]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 130.185941] postgres[1635]: LOOP vm-test-run-plv8> server # [ 130.186656] postgres[1635]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 130.189575] postgres[1635]: 'schema' vm-test-run-plv8> server # [ 130.199126] postgres[1635]: , 'table' vm-test-run-plv8> server # [ 130.200074] postgres[1635]: , 'foreign table' vm-test-run-plv8> server # [ 130.204589] postgres[1635]: , 'view' vm-test-run-plv8> server # [ 130.207214] postgres[1635]: , 'materialized view' vm-test-run-plv8> server # [ 130.208211] postgres[1635]: , 'function' vm-test-run-plv8> server # [ 130.216098] postgres[1635]: , 'trigger' vm-test-run-plv8> server # [ 130.219341] postgres[1635]: , 'type' vm-test-run-plv8> server # [ 130.220106] postgres[1635]: , 'rule' vm-test-run-plv8> server # [ 130.222576] postgres[1635]: ) vm-test-run-plv8> server # [ 130.229657] postgres[1635]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 130.230920] postgres[1635]: THEN vm-test-run-plv8> server # [ 130.231327] postgres[1635]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 130.235515] postgres[1635]: END IF; vm-test-run-plv8> server # [ 130.244735] postgres[1635]: END LOOP; vm-test-run-plv8> server # [ 130.246327] postgres[1635]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 130.248148] postgres[1635]: ::1 2026-10-23 10:41:47.131 UTC [1635] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 130.250363] postgres[1635]: ::1 2026-10-23 10:41:47.145 UTC [1635] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 130.258243] postgres[1635]: ON ddl_command_end vm-test-run-plv8> server # [ 130.258952] postgres[1635]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 130.261532] postgres[1635]: ::1 2026-10-23 10:41:47.163 UTC [1635] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 130.262107] postgres[1635]: ::1 2026-10-23 10:41:47.178 UTC [1635] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 130.262885] postgres[1635]: ON sql_drop vm-test-run-plv8> server # [ 130.263318] postgres[1635]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 130.264176] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1634]: CREATE FUNCTION vm-test-run-plv8> server # [ 130.265055] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1634]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 130.265378] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1634]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 130.265631] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1634]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 130.266651] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1634]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 130.317926] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-plv8> server # [ 130.570353] postgres[1637]: ::1 2026-10-23 10:41:47.499 UTC [1637] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-plv8> server # [ 130.609944] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1636]: ALTER ROLE vm-test-run-plv8> server # [ 130.617591] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-plv8> server # [ 131.015223] postgres[1642]: ::1 2026-10-23 10:41:47.931 UTC [1642] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 131.018340] postgres[1642]: returns event_trigger vm-test-run-plv8> server # [ 131.024358] postgres[1642]: language plpgsql vm-test-run-plv8> server # [ 131.025303] postgres[1642]: AS $func$ vm-test-run-plv8> server # [ 131.025640] postgres[1642]: DECLARE vm-test-run-plv8> server # [ 131.028039] postgres[1642]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 131.030125] postgres[1642]: BEGIN vm-test-run-plv8> server # [ 131.030521] postgres[1642]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 131.030781] postgres[1642]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 131.031254] postgres[1642]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 131.038010] postgres[1642]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 131.041766] postgres[1642]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 131.043625] postgres[1642]: ); vm-test-run-plv8> server # [ 131.048542] postgres[1642]: vm-test-run-plv8> server # [ 131.054576] postgres[1642]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 131.055982] postgres[1642]: THEN vm-test-run-plv8> server # [ 131.057603] postgres[1642]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 131.058170] postgres[1642]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 131.058510] postgres[1642]: vm-test-run-plv8> server # [ 131.058738] postgres[1642]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 131.059624] postgres[1642]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 131.067936] postgres[1642]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 131.073363] postgres[1642]: vm-test-run-plv8> server # [ 131.074447] postgres[1642]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 131.074781] postgres[1642]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 131.075046] postgres[1642]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 131.075379] postgres[1642]: "operationName" text default null, vm-test-run-plv8> server # [ 131.083342] postgres[1642]: query text default null, vm-test-run-plv8> server # [ 131.086095] postgres[1642]: variables jsonb default null, vm-test-run-plv8> server # [ 131.087112] postgres[1642]: extensions jsonb default null vm-test-run-plv8> server # [ 131.093750] postgres[1642]: ) vm-test-run-plv8> server # [ 131.096863] postgres[1642]: returns jsonb vm-test-run-plv8> server # [ 131.102886] postgres[1642]: language sql vm-test-run-plv8> server # [ 131.103963] postgres[1642]: as $$ vm-test-run-plv8> server # [ 131.114442] postgres[1642]: -- This changed vm-test-run-plv8> server # [ 131.115343] postgres[1642]: select graphql.resolve( vm-test-run-plv8> server # [ 131.117045] postgres[1642]: query := query, vm-test-run-plv8> server # [ 131.117478] postgres[1642]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 131.124867] postgres[1642]: "operationName" := "operationName", vm-test-run-plv8> server # [ 131.125935] postgres[1642]: extensions := extensions vm-test-run-plv8> server # [ 131.126337] postgres[1642]: ); vm-test-run-plv8> server # [ 131.126613] postgres[1642]: $$; vm-test-run-plv8> server # [ 131.126834] postgres[1642]: vm-test-run-plv8> server # [ 131.127058] postgres[1642]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 131.127340] postgres[1642]: END IF; vm-test-run-plv8> server # [ 131.131179] postgres[1642]: vm-test-run-plv8> server # [ 131.135161] postgres[1642]: END; vm-test-run-plv8> server # [ 131.138429] postgres[1642]: $func$; vm-test-run-plv8> server # [ 131.163421] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1638]: CREATE FUNCTION vm-test-run-plv8> server # [ 131.166679] postgres[1642]: ::1 2026-10-23 10:41:48.097 UTC [1642] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 131.169812] postgres[1642]: RETURNS event_trigger vm-test-run-plv8> server # [ 131.171272] postgres[1642]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 131.171616] postgres[1642]: AS $func$ vm-test-run-plv8> server # [ 131.172131] postgres[1642]: DECLARE vm-test-run-plv8> server # [ 131.173460] postgres[1642]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 131.174946] postgres[1642]: BEGIN vm-test-run-plv8> server # [ 131.176282] postgres[1642]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 131.176615] postgres[1642]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 131.178758] postgres[1642]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 131.179245] postgres[1642]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 131.179913] postgres[1642]: ); vm-test-run-plv8> server # [ 131.180197] postgres[1642]: vm-test-run-plv8> server # [ 131.181843] postgres[1642]: IF graphql_is_dropped vm-test-run-plv8> server # [ 131.182209] postgres[1642]: THEN vm-test-run-plv8> server # [ 131.182439] postgres[1642]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 131.182742] postgres[1642]: "operationName" text default null, vm-test-run-plv8> server # [ 131.182993] postgres[1642]: query text default null, vm-test-run-plv8> server # [ 131.183742] postgres[1642]: variables jsonb default null, vm-test-run-plv8> server # [ 131.185642] postgres[1642]: extensions jsonb default null vm-test-run-plv8> server # [ 131.186097] postgres[1642]: ) vm-test-run-plv8> server # [ 131.186658] postgres[1642]: returns jsonb vm-test-run-plv8> server # [ 131.187634] postgres[1642]: language plpgsql vm-test-run-plv8> server # [ 131.188033] postgres[1642]: as $$ vm-test-run-plv8> server # [ 131.189895] postgres[1642]: DECLARE vm-test-run-plv8> server # [ 131.190374] postgres[1642]: server_version float; vm-test-run-plv8> server # [ 131.191936] postgres[1642]: BEGIN vm-test-run-plv8> server # [ 131.193619] postgres[1642]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 131.194591] postgres[1642]: vm-test-run-plv8> server # [ 131.194962] postgres[1642]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 131.195274] postgres[1642]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 131.195736] postgres[1642]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 131.196418] postgres[1642]: jsonb_build_object( vm-test-run-plv8> server # [ 131.197664] postgres[1642]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 131.199136] postgres[1642]: ) vm-test-run-plv8> server # [ 131.199742] postgres[1642]: ) vm-test-run-plv8> server # [ 131.201947] postgres[1642]: ); vm-test-run-plv8> server # [ 131.202584] postgres[1642]: ELSE vm-test-run-plv8> server # [ 131.203345] postgres[1642]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 131.204084] postgres[1642]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 131.205771] postgres[1642]: jsonb_build_object( vm-test-run-plv8> server # [ 131.206224] postgres[1642]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 131.206723] postgres[1642]: ) vm-test-run-plv8> server # [ 131.206985] postgres[1642]: ) vm-test-run-plv8> server # [ 131.207217] postgres[1642]: ); vm-test-run-plv8> server # [ 131.207944] postgres[1642]: END IF; vm-test-run-plv8> server # [ 131.208619] postgres[1642]: END; vm-test-run-plv8> server # [ 131.209522] postgres[1642]: $$; vm-test-run-plv8> server # [ 131.210080] postgres[1642]: END IF; vm-test-run-plv8> server # [ 131.210325] postgres[1642]: vm-test-run-plv8> server # [ 131.210539] postgres[1642]: END; vm-test-run-plv8> server # [ 131.210749] postgres[1642]: $func$; vm-test-run-plv8> server # [ 131.226396] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1638]: CREATE FUNCTION vm-test-run-plv8> server # [ 131.230709] postgres[1642]: ::1 2026-10-23 10:41:48.165 UTC [1642] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 131.237179] postgres[1642]: "operationName" text default null, vm-test-run-plv8> server # [ 131.238389] postgres[1642]: query text default null, vm-test-run-plv8> server # [ 131.238752] postgres[1642]: variables jsonb default null, vm-test-run-plv8> server # [ 131.239017] postgres[1642]: extensions jsonb default null vm-test-run-plv8> server # [ 131.239261] postgres[1642]: ) vm-test-run-plv8> server # [ 131.239478] postgres[1642]: returns jsonb vm-test-run-plv8> server # [ 131.240347] postgres[1642]: language plpgsql vm-test-run-plv8> server # [ 131.254455] postgres[1642]: as $$ vm-test-run-plv8> server # [ 131.255426] postgres[1642]: DECLARE vm-test-run-plv8> server # [ 131.259754] postgres[1642]: server_version float; vm-test-run-plv8> server # [ 131.267014] postgres[1642]: BEGIN vm-test-run-plv8> server # [ 131.271757] postgres[1642]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 131.282293] postgres[1642]: vm-test-run-plv8> server # [ 131.282917] postgres[1642]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 131.283492] postgres[1642]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 131.283869] postgres[1642]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 131.284196] postgres[1642]: jsonb_build_object( vm-test-run-plv8> server # [ 131.293710] postgres[1642]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 131.295524] postgres[1642]: ) vm-test-run-plv8> server # [ 131.299728] postgres[1642]: ) vm-test-run-plv8> server # [ 131.305783] postgres[1642]: ); vm-test-run-plv8> server # [ 131.306243] postgres[1642]: ELSE vm-test-run-plv8> server # [ 131.307501] postgres[1642]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 131.308446] postgres[1642]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 131.309135] postgres[1642]: jsonb_build_object( vm-test-run-plv8> server # [ 131.309622] postgres[1642]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 131.309951] postgres[1642]: ) vm-test-run-plv8> server # [ 131.310505] postgres[1642]: ) vm-test-run-plv8> server # [ 131.310808] postgres[1642]: ); vm-test-run-plv8> server # [ 131.311057] postgres[1642]: END IF; vm-test-run-plv8> server # [ 131.311289] postgres[1642]: END; vm-test-run-plv8> server # [ 131.311512] postgres[1642]: $$; vm-test-run-plv8> server # [ 131.313386] postgres[1642]: ::1 2026-10-23 10:41:48.206 UTC [1642] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 131.315195] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1638]: CREATE FUNCTION vm-test-run-plv8> server # [ 131.316255] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1638]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping vm-test-run-plv8> server # [ 131.318532] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1638]: DROP EXTENSION vm-test-run-plv8> server # [ 133.551992] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1638]: DO vm-test-run-plv8> server # [ 133.626385] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql vm-test-run-plv8> server # [ 133.901523] postgres[1669]: ::1 2026-10-23 10:41:50.834 UTC [1669] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-plv8> server # [ 133.926690] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1668]: GRANT ROLE vm-test-run-plv8> server # [ 133.973238] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-plv8> server # [ 134.220103] postgres[1671]: ::1 2026-10-23 10:41:51.145 UTC [1671] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 134.228990] postgres[1671]: returns event_trigger vm-test-run-plv8> server # [ 134.230653] postgres[1671]: language plpgsql vm-test-run-plv8> server # [ 134.231041] postgres[1671]: AS $func$ vm-test-run-plv8> server # [ 134.232018] postgres[1671]: DECLARE vm-test-run-plv8> server # [ 134.234453] postgres[1671]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 134.235033] postgres[1671]: BEGIN vm-test-run-plv8> server # [ 134.235495] postgres[1671]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 134.238141] postgres[1671]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 134.239562] postgres[1671]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 134.239966] postgres[1671]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 134.240737] postgres[1671]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 134.241059] postgres[1671]: ); vm-test-run-plv8> server # [ 134.241558] postgres[1671]: vm-test-run-plv8> server # [ 134.242193] postgres[1671]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 134.243051] postgres[1671]: THEN vm-test-run-plv8> server # [ 134.243739] postgres[1671]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 134.245737] postgres[1671]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 134.246587] postgres[1671]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 134.247732] postgres[1671]: "operationName" text default null, vm-test-run-plv8> server # [ 134.248136] postgres[1671]: query text default null, vm-test-run-plv8> server # [ 134.248399] postgres[1671]: variables jsonb default null, vm-test-run-plv8> server # [ 134.252960] postgres[1671]: extensions jsonb default null vm-test-run-plv8> server # [ 134.253877] postgres[1671]: ) vm-test-run-plv8> server # [ 134.254242] postgres[1671]: returns jsonb vm-test-run-plv8> server # [ 134.254512] postgres[1671]: language sql vm-test-run-plv8> server # [ 134.254750] postgres[1671]: as $$ vm-test-run-plv8> server # [ 134.254984] postgres[1671]: select graphql.resolve( vm-test-run-plv8> server # [ 134.255213] postgres[1671]: query := query, vm-test-run-plv8> server # [ 134.258656] postgres[1671]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 134.260373] postgres[1671]: "operationName" := "operationName", vm-test-run-plv8> server # [ 134.262259] postgres[1671]: extensions := extensions vm-test-run-plv8> server # [ 134.262664] postgres[1671]: ); vm-test-run-plv8> server # [ 134.262897] postgres[1671]: $$; vm-test-run-plv8> server # [ 134.263252] postgres[1671]: vm-test-run-plv8> server # [ 134.265177] postgres[1671]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 134.269498] postgres[1671]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 134.271052] postgres[1671]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 134.272048] postgres[1671]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 134.274772] postgres[1671]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 134.275305] postgres[1671]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 134.275636] postgres[1671]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 134.281359] postgres[1671]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 134.282608] postgres[1671]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 134.283051] postgres[1671]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 134.283572] postgres[1671]: END IF; vm-test-run-plv8> server # [ 134.293031] postgres[1671]: vm-test-run-plv8> server # [ 134.294620] postgres[1671]: END; vm-test-run-plv8> server # [ 134.295366] postgres[1671]: $func$; vm-test-run-plv8> server # [ 134.307738] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1670]: CREATE FUNCTION vm-test-run-plv8> server # [ 134.309825] postgres[1671]: ::1 2026-10-23 10:41:51.242 UTC [1671] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 134.359970] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1670]: DROP EXTENSION vm-test-run-plv8> server # [ 136.459893] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1670]: DO vm-test-run-plv8> server # [ 136.489341] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-plv8> server # [ 137.370995] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1696]: DO vm-test-run-plv8> server # [ 138.160972] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1696]: DO vm-test-run-plv8> server # [ 138.241904] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-plv8> server # [ 138.634818] postgres[1709]: ::1 2026-10-23 10:41:55.557 UTC [1709] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-plv8> server # [ 138.681222] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1703]: ALTER ROLE vm-test-run-plv8> server # [ 138.719066] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-plv8> server # [ 139.302630] postgres[1720]: ::1 2026-10-23 10:41:56.202 UTC [1720] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-plv8> server # [ 139.347007] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1714]: REVOKE ROLE vm-test-run-plv8> server # [ 139.410440] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-plv8> server # [ 142.039262] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1727]: DO vm-test-run-plv8> server # [ 142.090620] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-plv8> server # [ 142.512903] postgres[1751]: ::1 2026-10-23 10:41:59.432 UTC [1751] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-plv8> server # [ 142.586555] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1745]: GRANT ROLE vm-test-run-plv8> server # [ 142.591037] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-plv8> server # [ 143.002220] postgres[1759]: ::1 2026-10-23 10:41:59.927 UTC [1759] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 143.087462] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1754]: GRANT vm-test-run-plv8> server # [ 143.093782] postgres[1759]: ::1 2026-10-23 10:42:00.003 UTC [1759] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 143.113925] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1754]: GRANT vm-test-run-plv8> server # [ 143.115683] postgres[1759]: ::1 2026-10-23 10:42:00.049 UTC [1759] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 143.127619] postgres[1759]: ::1 2026-10-23 10:42:00.059 UTC [1759] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 143.145808] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1754]: GRANT vm-test-run-plv8> server # [ 143.152856] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1754]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 143.155691] postgres[1759]: ::1 2026-10-23 10:42:00.091 UTC [1759] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option; vm-test-run-plv8> server # [ 143.182900] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1754]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 143.184175] postgres[1759]: ::1 2026-10-23 10:42:00.120 UTC [1759] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 143.203129] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1754]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 143.271159] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-plv8> server # [ 143.640177] postgres[1765]: ::1 2026-10-23 10:42:00.563 UTC [1765] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-plv8> server # [ 143.679053] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1763]: GRANT ROLE vm-test-run-plv8> server # [ 143.721531] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 144.057587] postgres[1767]: ::1 2026-10-23 10:42:00.987 UTC [1767] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-plv8> server # [ 144.083223] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1766]: GRANT ROLE vm-test-run-plv8> server # [ 144.122983] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-plv8> server # [ 144.380173] postgres[1769]: ::1 2026-10-23 10:42:01.311 UTC [1769] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-plv8> server # [ 144.397451] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1768]: ALTER ROLE vm-test-run-plv8> server # [ 144.398304] postgres[1769]: ::1 2026-10-23 10:42:01.333 UTC [1769] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-plv8> server # [ 144.406283] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1768]: ALTER ROLE vm-test-run-plv8> server # [ 144.409558] postgres[1769]: ::1 2026-10-23 10:42:01.343 UTC [1769] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-plv8> server # [ 144.420181] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1768]: ALTER ROLE vm-test-run-plv8> server # [ 144.450049] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1768]: DO vm-test-run-plv8> server # [ 144.509590] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 144.867474] postgres[1773]: ::1 2026-10-23 10:42:01.781 UTC [1773] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-plv8> server # [ 144.886963] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1770]: GRANT ROLE vm-test-run-plv8> server # [ 144.899296] postgres[1773]: ::1 2026-10-23 10:42:01.813 UTC [1773] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-plv8> server # [ 144.915730] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1770]: REVOKE ROLE vm-test-run-plv8> server # [ 144.970424] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-plv8> server # [ 145.467695] postgres[1788]: ::1 2026-10-23 10:42:02.389 UTC [1788] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 145.479614] postgres[1788]: returns event_trigger vm-test-run-plv8> server # [ 145.487604] postgres[1788]: language plpgsql vm-test-run-plv8> server # [ 145.494576] postgres[1788]: AS $func$ vm-test-run-plv8> server # [ 145.495340] postgres[1788]: DECLARE vm-test-run-plv8> server # [ 145.500839] postgres[1788]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 145.503541] postgres[1788]: BEGIN vm-test-run-plv8> server # [ 145.508024] postgres[1788]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 145.513355] postgres[1788]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 145.514919] postgres[1788]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 145.515342] postgres[1788]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 145.524773] postgres[1788]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 145.527082] postgres[1788]: ); vm-test-run-plv8> server # [ 145.527494] postgres[1788]: vm-test-run-plv8> server # [ 145.528067] postgres[1788]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 145.538675] postgres[1788]: THEN vm-test-run-plv8> server # [ 145.541029] postgres[1788]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 145.541807] postgres[1788]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 145.543506] postgres[1788]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 145.551696] postgres[1788]: "operationName" text default null, vm-test-run-plv8> server # [ 145.553285] postgres[1788]: query text default null, vm-test-run-plv8> server # [ 145.555867] postgres[1788]: variables jsonb default null, vm-test-run-plv8> server # [ 145.564327] postgres[1788]: extensions jsonb default null vm-test-run-plv8> server # [ 145.565687] postgres[1788]: ) vm-test-run-plv8> server # [ 145.566002] postgres[1788]: returns jsonb vm-test-run-plv8> server # [ 145.566806] postgres[1788]: language sql vm-test-run-plv8> server # [ 145.567601] postgres[1788]: as $$ vm-test-run-plv8> server # [ 145.579710] postgres[1788]: select graphql.resolve( vm-test-run-plv8> server # [ 145.585685] postgres[1788]: query := query, vm-test-run-plv8> server # [ 145.587436] postgres[1788]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 145.587955] postgres[1788]: "operationName" := "operationName", vm-test-run-plv8> server # [ 145.593328] postgres[1788]: extensions := extensions vm-test-run-plv8> server # [ 145.601258] postgres[1788]: ); vm-test-run-plv8> server # [ 145.609401] postgres[1788]: $$; vm-test-run-plv8> server # [ 145.611213] postgres[1788]: vm-test-run-plv8> server # [ 145.616964] postgres[1788]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 145.618318] postgres[1788]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 145.619194] postgres[1788]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 145.626803] postgres[1788]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 145.633030] postgres[1788]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 145.634275] postgres[1788]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 145.636558] postgres[1788]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 145.647685] postgres[1788]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 145.661509] postgres[1788]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 145.672822] postgres[1788]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 145.673699] postgres[1788]: vm-test-run-plv8> server # [ 145.674270] postgres[1788]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-plv8> server # [ 145.674991] postgres[1788]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-plv8> server # [ 145.675368] postgres[1788]: grant usage on schema graphql to postgres with grant option; vm-test-run-plv8> server # [ 145.675686] postgres[1788]: END IF; vm-test-run-plv8> server # [ 145.676036] postgres[1788]: vm-test-run-plv8> server # [ 145.680797] postgres[1788]: END; vm-test-run-plv8> server # [ 145.681451] postgres[1788]: $func$; vm-test-run-plv8> server # [ 145.681903] postgres[1788]: ::1 2026-10-23 10:42:02.607 UTC [1788] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 145.694718] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1780]: CREATE FUNCTION vm-test-run-plv8> server # [ 145.742276] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1780]: DROP EXTENSION vm-test-run-plv8> server # [ 147.547072] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1780]: DO vm-test-run-plv8> server # [ 147.625421] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-plv8> server # [ 148.038609] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1802]: DO vm-test-run-plv8> server # [ 148.047598] postgres[1803]: ::1 2026-10-23 10:42:04.958 UTC [1803] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-plv8> server # [ 148.048514] postgres[1803]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 148.053177] postgres[1803]: AS $$ vm-test-run-plv8> server # [ 148.053931] postgres[1803]: BEGIN vm-test-run-plv8> server # [ 148.055380] postgres[1803]: IF EXISTS ( vm-test-run-plv8> server # [ 148.061885] postgres[1803]: SELECT vm-test-run-plv8> server # [ 148.062585] postgres[1803]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 148.063255] postgres[1803]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 148.063601] postgres[1803]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 148.065729] postgres[1803]: WHERE ext.extname = 'pg_cron' vm-test-run-plv8> server # [ 148.074295] postgres[1803]: ) vm-test-run-plv8> server # [ 148.075038] postgres[1803]: THEN vm-test-run-plv8> server # [ 148.075346] postgres[1803]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 148.076718] postgres[1803]: vm-test-run-plv8> server # [ 148.081589] postgres[1803]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 148.082394] postgres[1803]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 148.083936] postgres[1803]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 148.085799] postgres[1803]: vm-test-run-plv8> server # [ 148.086301] postgres[1803]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 148.087144] postgres[1803]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 148.093794] postgres[1803]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 148.095601] postgres[1803]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 148.097271] postgres[1803]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 148.097863] postgres[1803]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 148.098814] postgres[1803]: vm-test-run-plv8> server # [ 148.099932] postgres[1803]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 148.105297] postgres[1803]: revoke all on table cron.job from postgres; vm-test-run-plv8> server # [ 148.106400] postgres[1803]: grant select on table cron.job to postgres with grant option; vm-test-run-plv8> server # [ 148.111513] postgres[1803]: END IF; vm-test-run-plv8> server # [ 148.112240] postgres[1803]: END; vm-test-run-plv8> server # [ 148.113646] postgres[1803]: $$; vm-test-run-plv8> server # [ 148.118348] postgres[1803]: ::1 2026-10-23 10:42:05.031 UTC [1803] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-plv8> server # [ 148.119182] postgres[1803]: ::1 2026-10-23 10:42:05.047 UTC [1803] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-plv8> server # [ 148.125219] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1802]: CREATE FUNCTION vm-test-run-plv8> server # [ 148.126946] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1802]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 148.129958] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1802]: ALTER FUNCTION vm-test-run-plv8> server # [ 148.131138] postgres[1803]: ::1 2026-10-23 10:42:05.066 UTC [1803] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-plv8> server # [ 148.137435] postgres[1803]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-plv8> server # [ 148.138942] postgres[1803]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 148.143431] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1802]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 148.178162] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-plv8> server # [ 148.624203] postgres[1815]: ::1 2026-10-23 10:42:05.527 UTC [1815] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-plv8> server # [ 148.671334] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1809]: ALTER ROLE vm-test-run-plv8> server # [ 148.725718] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-plv8> server # [ 149.204527] postgres[1827]: ::1 2026-10-23 10:42:06.113 UTC [1827] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-plv8> server # [ 149.270061] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1820]: ALTER FUNCTION vm-test-run-plv8> server # [ 149.271736] postgres[1827]: ::1 2026-10-23 10:42:06.180 UTC [1827] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-plv8> server # [ 149.282854] postgres[1827]: ::1 2026-10-23 10:42:06.213 UTC [1827] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-plv8> server # [ 149.287711] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1820]: ALTER FUNCTION vm-test-run-plv8> server # [ 149.293541] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1820]: ALTER FUNCTION vm-test-run-plv8> server # [ 149.351161] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-plv8> server # [ 149.685976] postgres[1833]: ::1 2026-10-23 10:42:06.609 UTC [1833] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-plv8> server # [ 149.722357] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1832]: GRANT ROLE vm-test-run-plv8> server # [ 149.798485] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-plv8> server # [ 150.718253] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1834]: DO vm-test-run-plv8> server # [ 150.752036] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-plv8> server # [ 151.445639] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1836]: DO vm-test-run-plv8> server # [ 151.451132] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1836]: DO vm-test-run-plv8> server # [ 151.530061] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-plv8> server # [ 151.998400] postgres[1854]: ::1 2026-10-23 10:42:08.918 UTC [1854] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-plv8> server # [ 152.013168] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1851]: ALTER ROLE vm-test-run-plv8> server # [ 152.014273] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1851]: ALTER ROLE vm-test-run-plv8> server # [ 152.015273] postgres[1854]: ::1 2026-10-23 10:42:08.937 UTC [1854] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-plv8> server # [ 152.016021] postgres[1854]: ::1 2026-10-23 10:42:08.950 UTC [1854] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-plv8> server # [ 152.033595] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1851]: ALTER ROLE vm-test-run-plv8> server # [ 152.082409] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-plv8> server # [ 152.569518] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1858]: DO vm-test-run-plv8> server # [ 152.615362] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-plv8> server # [ 152.879423] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1866]: DO vm-test-run-plv8> server # [ 152.919001] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-plv8> server # [ 153.464269] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1868]: CREATE FUNCTION vm-test-run-plv8> server # [ 153.482273] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1868]: DO vm-test-run-plv8> server # [ 153.547820] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-plv8> server # [ 153.908883] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1874]: ALTER FUNCTION vm-test-run-plv8> server # [ 153.913399] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1874]: GRANT vm-test-run-plv8> server # [ 153.987605] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-plv8> server # [ 154.416640] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1876]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 154.450166] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1876]: ALTER FUNCTION vm-test-run-plv8> server # [ 154.472924] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1876]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 154.522590] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 155.077586] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1887]: DO vm-test-run-plv8> server # [ 155.142933] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-plv8> server # [ 155.780142] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1899]: CREATE FUNCTION vm-test-run-plv8> server # [ 155.805925] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1899]: GRANT vm-test-run-plv8> server # [ 155.852010] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-plv8> server # [ 156.150217] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1906]: REVOKE ROLE vm-test-run-plv8> server # [ 156.175214] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1906]: DO vm-test-run-plv8> server # [ 156.186532] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1906]: DO vm-test-run-plv8> server # [ 156.195900] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1906]: REVOKE ROLE vm-test-run-plv8> server # [ 156.209207] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1906]: REVOKE vm-test-run-plv8> server # [ 156.237148] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1906]: DO vm-test-run-plv8> server # [ 156.279269] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 156.524776] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1908]: DO vm-test-run-plv8> server # [ 156.573183] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 157.006672] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1910]: DO vm-test-run-plv8> server # [ 157.016317] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 157.476176] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1915]: DO vm-test-run-plv8> server # [ 157.588093] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-plv8> server # [ 158.075183] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1922]: ALTER ROLE vm-test-run-plv8> server # [ 158.105037] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-plv8> server # [ 158.594883] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1931]: GRANT ROLE vm-test-run-plv8> server # [ 158.622126] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1931]: DO vm-test-run-plv8> server # [ 158.702080] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-plv8> server # [ 159.174321] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1942]: GRANT vm-test-run-plv8> server # [ 159.186550] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-plv8> server # [ 159.616277] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1948]: CREATE FUNCTION vm-test-run-plv8> server # [ 159.623633] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1948]: REVOKE vm-test-run-plv8> server # [ 159.633135] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1948]: REVOKE vm-test-run-plv8> server # [ 159.646281] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1948]: GRANT vm-test-run-plv8> server # [ 159.696597] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-plv8> server # [ 159.978352] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1950]: DO vm-test-run-plv8> server # [ 160.009496] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-plv8> server # [ 160.391933] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1952]: ALTER ROLE vm-test-run-plv8> server # [ 160.429495] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-plv8> server # [ 161.138693] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1954]: DROP EXTENSION vm-test-run-plv8> server # [ 161.213957] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-plv8> server # [ 161.705339] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1970]: CREATE FUNCTION vm-test-run-plv8> server # [ 161.716048] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1970]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 161.732726] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1970]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 161.772974] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-plv8> server # [ 162.177203] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1982]: DO vm-test-run-plv8> server # [ 162.212664] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1982]: CREATE FUNCTION vm-test-run-plv8> server # [ 162.271330] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-plv8> server # [ 162.549464] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1984]: CREATE FUNCTION vm-test-run-plv8> server # [ 162.564902] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1984]: CREATE FUNCTION vm-test-run-plv8> server # [ 162.629557] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql vm-test-run-plv8> server # [ 163.065216] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1987]: CREATE FUNCTION vm-test-run-plv8> server # [ 163.085931] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1987]: CREATE FUNCTION vm-test-run-plv8> server # [ 163.104450] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1987]: CREATE FUNCTION vm-test-run-plv8> server # [ 163.139447] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1987]: CREATE FUNCTION vm-test-run-plv8> server # [ 163.161763] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1987]: CREATE FUNCTION vm-test-run-plv8> server # [ 163.183554] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1987]: CREATE FUNCTION vm-test-run-plv8> server # [ 163.233207] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Running postgresql schema... vm-test-run-plv8> server # [ 163.586088] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER DATABASE vm-test-run-plv8> server # [ 163.595907] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER DATABASE vm-test-run-plv8> server # [ 163.725544] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER ROLE vm-test-run-plv8> server # [ 163.843626] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER ROLE vm-test-run-plv8> server # [ 163.958119] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER ROLE vm-test-run-plv8> server # [ 164.077117] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER ROLE vm-test-run-plv8> server # [ 164.178363] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER ROLE vm-test-run-plv8> server # [ 164.308292] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER ROLE vm-test-run-plv8> server # [ 164.423681] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER ROLE vm-test-run-plv8> server # [ 164.521681] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER ROLE vm-test-run-plv8> server # [ 164.637933] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER ROLE vm-test-run-plv8> server # [ 164.663401] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1992]: ALTER ROLE vm-test-run-plv8> server # [ 164.699240] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1429]: Database initialization complete vm-test-run-plv8> server # [ 164.742106] systemd[1]: Finished Supabase Database Initialization. vm-test-run-plv8> server # [ 164.767325] systemd[1]: Reached target Multi-User System. vm-test-run-plv8> server # [ 164.778425] systemd[1]: Startup finished in 14.398s (kernel) + 2min 30.361s (userspace) = 2min 44.759s. vm-test-run-plv8> server: (finished: waiting for unit supabase-db-init.service, in 166.37 seconds) vm-test-run-plv8> subtest: Check upgrade path with postgresql 15 vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" vm-test-run-plv8> server # NOTICE: extension "plv8" does not exist, skipping vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.54 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.4' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.4' CASCADE;" , in 6.93 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.80 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.64 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.5' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.5' CASCADE;" , in 7.13 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.81 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.84 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 7.37 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.69 seconds) vm-test-run-plv8> (finished: subtest: Check upgrade path with postgresql 15, in 25.74 seconds) vm-test-run-plv8> subtest: Check the install of the last version of the extension vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.57 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 1.53 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.56 seconds) vm-test-run-plv8> (finished: subtest: Check the install of the last version of the extension, in 2.67 seconds) vm-test-run-plv8> (finished: run the VM test script, in 194.89 seconds) vm-test-run-plv8> test script finished in 195.31s vm-test-run-plv8> cleanup vm-test-run-plv8> kill machine (pid 9) vm-test-run-plv8> qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13) vm-test-run-plv8> vde_switch: EOF data port: Interrupted system call vm-test-run-plv8> kill vlan (pid 7) vm-test-run-plv8> (finished: cleanup, in 0.00 seconds) vm-test-run-plv8> vde_switch: Caught signal 15, cleaning up and exiting