these 11 derivations will be built: /nix/store/irbwyi814yh17h0r8xs9m4fpygffckri-postgresql-init.drv /nix/store/hzkcnhq54zwv2wvn8i29x2cmy4krzaxd-unit-postgresql.service.drv /nix/store/l95inhc11qw74iiilzp7i7l8gls8984k-system-units.drv /nix/store/jmf70jn8mmdz59fa360x6pfv7yz02jcn-etc.drv /nix/store/2by7z61za829j2dds7ngxsn6camxlgn9-activate.drv /nix/store/b38a9112bqg1njlf2m4hv6bk8fv06pfg-nixos-system-server-test.drv /nix/store/7qz6cmwyr9y3zc10zmgfh5gk24wd57if-closure-info.drv /nix/store/f5v6s043b94amc51ll3aa8i6mr3vlr7l-run-nixos-vm.drv /nix/store/izakghrvjsydlwlblhklm56kajzh4zsd-nixos-vm.drv /nix/store/hv4zin45x2r95k2j1cv32cf8bvzsy89p-nixos-test-driver-plv8.drv /nix/store/hb79sqczag5256kxa9r1n95cwm58v9cg-vm-test-run-plv8.drv building '/nix/store/irbwyi814yh17h0r8xs9m4fpygffckri-postgresql-init.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/irbwyi814yh17h0r8xs9m4fpygffckri-postgresql-init.drv' building '/nix/store/hzkcnhq54zwv2wvn8i29x2cmy4krzaxd-unit-postgresql.service.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/hzkcnhq54zwv2wvn8i29x2cmy4krzaxd-unit-postgresql.service.drv' building '/nix/store/l95inhc11qw74iiilzp7i7l8gls8984k-system-units.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/l95inhc11qw74iiilzp7i7l8gls8984k-system-units.drv' building '/nix/store/jmf70jn8mmdz59fa360x6pfv7yz02jcn-etc.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/jmf70jn8mmdz59fa360x6pfv7yz02jcn-etc.drv' building '/nix/store/2by7z61za829j2dds7ngxsn6camxlgn9-activate.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/2by7z61za829j2dds7ngxsn6camxlgn9-activate.drv' building '/nix/store/b38a9112bqg1njlf2m4hv6bk8fv06pfg-nixos-system-server-test.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/b38a9112bqg1njlf2m4hv6bk8fv06pfg-nixos-system-server-test.drv' building '/nix/store/7qz6cmwyr9y3zc10zmgfh5gk24wd57if-closure-info.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/7qz6cmwyr9y3zc10zmgfh5gk24wd57if-closure-info.drv' closure-info> structuredAttrs is enabled building '/nix/store/f5v6s043b94amc51ll3aa8i6mr3vlr7l-run-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/f5v6s043b94amc51ll3aa8i6mr3vlr7l-run-nixos-vm.drv' building '/nix/store/izakghrvjsydlwlblhklm56kajzh4zsd-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/izakghrvjsydlwlblhklm56kajzh4zsd-nixos-vm.drv' building '/nix/store/hv4zin45x2r95k2j1cv32cf8bvzsy89p-nixos-test-driver-plv8.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/hv4zin45x2r95k2j1cv32cf8bvzsy89p-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/hb79sqczag5256kxa9r1n95cwm58v9cg-vm-test-run-plv8.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/hb79sqczag5256kxa9r1n95cwm58v9cg-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> (finished: start all VMs, in 0.11 seconds) vm-test-run-plv8> server: waiting for unit supabase-db-init.service vm-test-run-plv8> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-plv8> server: waiting for the VM to finish booting vm-test-run-plv8> server # Formatting '/build/vm-state-server/tmp.8xhlVlapvz', 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: 1f571b5a-2cc9-4fc4-9125-2d80681decde 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> 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/w4y2xgy5xkwyxpfpy4355apj6wnfdia8-nixos-system-server-test/init regInfo=/nix/store/wdxi9f0a1mhjln2pqw6vsvfmdmscfs0q-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-plv8> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/wdxi9f0a1mhjln2pqw6vsvfmdmscfs0q-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 @100ae0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-plv8> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100af0000 (flat, esz 8, psz 64K, shr 1) vm-test-run-plv8> server # [ 0.000000] GICv3: using LPI property table @0x0000000100b00000 vm-test-run-plv8> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b10000 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.000028] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-plv8> server # [ 0.002579] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-plv8> server # [ 0.010535] Console: colour dummy device 80x25 vm-test-run-plv8> server # [ 0.011580] printk: legacy console [tty0] enabled vm-test-run-plv8> server # [ 0.015880] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-plv8> server # [ 0.016171] pid_max: default: 32768 minimum: 301 vm-test-run-plv8> server # [ 0.017608] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-plv8> server # [ 0.018998] landlock: Up and running. vm-test-run-plv8> server # [ 0.019047] Yama: becoming mindful. vm-test-run-plv8> server # [ 0.021102] LSM support for eBPF active vm-test-run-plv8> server # [ 0.023133] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.023437] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.044659] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-plv8> server # [ 0.052782] rcu: Hierarchical SRCU implementation. vm-test-run-plv8> server # [ 0.052845] rcu: Max phase no-delay instances is 1000. vm-test-run-plv8> server # [ 0.054118] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-plv8> server # [ 0.058846] fsl-mc MSI: its@8080000 domain created vm-test-run-plv8> server # [ 0.061149] EFI services will not be available. vm-test-run-plv8> server # [ 0.063052] smp: Bringing up secondary CPUs ... vm-test-run-plv8> server # [ 0.067571] Detected PIPT I-cache on CPU1 vm-test-run-plv8> server # [ 0.068445] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-plv8> server # [ 0.068960] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000 vm-test-run-plv8> server # [ 0.070202] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-plv8> server # [ 0.073108] smp: Brought up 1 node, 2 CPUs vm-test-run-plv8> server # [ 0.073232] SMP: Total of 2 processors activated. vm-test-run-plv8> server # [ 0.073273] CPU: All CPU(s) started at EL1 vm-test-run-plv8> server # [ 0.073427] CPU features: detected: Branch Target Identification vm-test-run-plv8> server # [ 0.073478] CPU features: detected: 32-bit EL0 Support vm-test-run-plv8> server # [ 0.073507] CPU features: detected: 32-bit EL1 Support vm-test-run-plv8> server # [ 0.073531] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-plv8> server # [ 0.073563] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-plv8> server # [ 0.073600] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-plv8> server # [ 0.073656] CPU features: detected: Common not Private translations vm-test-run-plv8> server # [ 0.073676] CPU features: detected: CRC32 instructions vm-test-run-plv8> server # [ 0.073693] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-plv8> server # [ 0.073721] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-plv8> server # [ 0.073743] CPU features: detected: Data independent timing control (DIT) vm-test-run-plv8> server # [ 0.073761] CPU features: detected: E0PD vm-test-run-plv8> server # [ 0.073775] CPU features: detected: Enhanced Counter Virtualization vm-test-run-plv8> server # [ 0.073792] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-plv8> server # [ 0.073810] CPU features: detected: Enhanced Privileged Access Never vm-test-run-plv8> server # [ 0.073827] CPU features: detected: Enhanced Virtualization Traps vm-test-run-plv8> server # [ 0.073844] CPU features: detected: Fine Grained Traps vm-test-run-plv8> server # [ 0.073895] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-plv8> server # [ 0.073967] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-plv8> server # [ 0.074003] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-plv8> server # [ 0.074024] CPU features: detected: LSE atomic instructions vm-test-run-plv8> server # [ 0.074042] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-plv8> server # [ 0.074062] CPU features: detected: Privileged Access Never vm-test-run-plv8> server # [ 0.074080] CPU features: detected: RAS Extension Support vm-test-run-plv8> server # [ 0.074098] CPU features: detected: Random Number Generator vm-test-run-plv8> server # [ 0.074120] CPU features: detected: Speculation barrier (SB) vm-test-run-plv8> server # [ 0.074143] CPU features: detected: Stage-2 Force Write-Back vm-test-run-plv8> server # [ 0.074163] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-plv8> server # [ 0.074188] CPU features: detected: TLB range maintenance instructions vm-test-run-plv8> server # [ 0.074213] CPU features: detected: WFx with timeout vm-test-run-plv8> server # [ 0.074253] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-plv8> server # [ 0.074274] CPU features: detected: Scalable Vector Extension vm-test-run-plv8> server # [ 0.081018] alternatives: applying system-wide alternatives vm-test-run-plv8> server # [ 0.101649] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-plv8> server # [ 0.102745] SVE: maximum available vector length 256 bytes per vector vm-test-run-plv8> server # [ 0.103063] SVE: default vector length 64 bytes per vector vm-test-run-plv8> server # [ 0.121079] Memory: 3922904K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-plv8> server # [ 0.136917] devtmpfs: initialized vm-test-run-plv8> server # [ 0.155931] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-plv8> server # [ 0.156295] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.158173] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-plv8> server # [ 0.158216] 0 pages in range for non-PLT usage vm-test-run-plv8> server # [ 0.158244] 509248 pages in range for PLT usage vm-test-run-plv8> server # [ 0.160307] pinctrl core: initialized pinctrl subsystem vm-test-run-plv8> server # [ 0.167748] DMI not present or invalid. vm-test-run-plv8> server # [ 0.180704] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-plv8> server # [ 0.189099] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-plv8> server # [ 0.189747] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-plv8> server # [ 0.190477] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-plv8> server # [ 0.190653] audit: initializing netlink subsys (disabled) vm-test-run-plv8> server # [ 0.191960] audit: type=2000 audit(0.072:1): state=initialized audit_enabled=0 res=1 vm-test-run-plv8> server # [ 0.195960] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-plv8> server # [ 0.195992] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-plv8> server # [ 0.196026] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-plv8> server # [ 0.196048] thermal_sys: Registered thermal governor 'user_space' vm-test-run-plv8> server # [ 0.196068] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-plv8> server # [ 0.196489] cpuidle: using governor ladder vm-test-run-plv8> server # [ 0.196669] cpuidle: using governor menu vm-test-run-plv8> server # [ 0.197998] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-plv8> server # [ 0.198542] ASID allocator initialised with 65536 entries vm-test-run-plv8> server # [ 0.203472] Serial: AMBA PL011 UART driver vm-test-run-plv8> server # [ 0.239520] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-plv8> server # [ 0.240285] printk: legacy console [ttyAMA0] enabled vm-test-run-plv8> server # [ 0.271814] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.271982] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-plv8> server # [ 0.272126] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.272237] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-plv8> server # [ 0.272342] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.272435] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-plv8> server # [ 0.272625] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.272714] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-plv8> server # [ 0.282785] fbcon: Taking over console vm-test-run-plv8> server # [ 0.283452] ACPI: Interpreter disabled. vm-test-run-plv8> server # [ 0.290105] iommu: Default domain type: Translated vm-test-run-plv8> server # [ 0.290240] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-plv8> server # [ 0.298028] SCSI subsystem initialized vm-test-run-plv8> server # [ 0.299878] usbcore: registered new interface driver usbfs vm-test-run-plv8> server # [ 0.300250] usbcore: registered new interface driver hub vm-test-run-plv8> server # [ 0.300783] usbcore: registered new device driver usb vm-test-run-plv8> server # [ 0.302795] pps_core: LinuxPPS API ver. 1 registered vm-test-run-plv8> server # [ 0.302903] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-plv8> server # [ 0.303117] PTP clock support registered vm-test-run-plv8> server # [ 0.303676] EDAC MC: Ver: 3.0.0 vm-test-run-plv8> server # [ 0.305008] scmi_core: SCMI protocol bus registered vm-test-run-plv8> server # [ 0.307404] FPGA manager framework vm-test-run-plv8> server # [ 0.308602] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-plv8> server # [ 0.315821] vgaarb: loaded vm-test-run-plv8> server # [ 0.320350] clocksource: Switched to clocksource arch_sys_counter vm-test-run-plv8> server # [ 0.349411] VFS: Disk quotas dquot_6.6.0 vm-test-run-plv8> server # [ 0.349663] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-plv8> server # [ 0.351546] netfs: FS-Cache loaded vm-test-run-plv8> server # [ 0.352500] pnp: PnP ACPI: disabled vm-test-run-plv8> server # [ 0.369550] NET: Registered PF_INET protocol family vm-test-run-plv8> server # [ 0.370918] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-plv8> server # [ 0.457015] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.457467] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.457736] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.459079] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-plv8> server # [ 0.459893] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-plv8> server # [ 0.461626] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-plv8> server # [ 0.462021] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.462362] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.463899] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-plv8> server # [ 0.464362] NET: Registered PF_XDP protocol family vm-test-run-plv8> server # [ 0.464587] PCI: CLS 0 bytes, default 64 vm-test-run-plv8> server # [ 0.466382] kvm [1]: HYP mode not available vm-test-run-plv8> server # [ 0.467821] Trying to unpack rootfs image as initramfs... vm-test-run-plv8> server # [ 0.556548] Initialise system trusted keyrings vm-test-run-plv8> server # [ 0.558748] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-plv8> server # [ 0.562282] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-plv8> server # [ 0.563358] 9p: Installing v9fs 9p2000 file system support vm-test-run-plv8> server # [ 0.611018] Key type asymmetric registered vm-test-run-plv8> server # [ 0.611265] Asymmetric key parser 'x509' registered vm-test-run-plv8> server # [ 0.611945] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-plv8> server # [ 0.613387] io scheduler mq-deadline registered vm-test-run-plv8> server # [ 0.613530] io scheduler kyber registered vm-test-run-plv8> server # [ 0.632384] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-plv8> server # [ 0.637169] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-plv8> server # [ 0.640029] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-plv8> server # [ 0.640600] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-plv8> server # [ 0.641312] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-plv8> server # [ 0.641492] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-plv8> server # [ 0.642011] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-plv8> server # [ 0.642538] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-plv8> server # [ 0.643859] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-plv8> server # [ 0.644216] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-plv8> server # [ 0.644696] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.645009] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.645183] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.646215] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.648869] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.649600] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.649761] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.649908] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.650092] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.650546] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.650781] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.650873] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.650965] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.651438] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.651653] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.651746] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.651892] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.652272] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.652902] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.653227] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.653336] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.653853] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.654017] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.654107] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.654203] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.654652] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.654891] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-plv8> server # [ 0.655035] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.655237] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.655658] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.655906] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.655996] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.656094] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.656244] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.656714] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.657241] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.657395] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.657893] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.658045] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.658149] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.658650] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-plv8> server # [ 0.659021] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.659469] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.659676] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.659763] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.660022] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.660534] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.661237] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.661379] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.661504] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.663077] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-plv8> server # [ 0.663322] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-plv8> server # [ 0.663482] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.663669] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.663858] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.663998] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.664179] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.664887] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.665143] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.665265] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.665379] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.665495] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.665687] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.666080] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-plv8> server # [ 0.666280] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-plv8> server # [ 0.666403] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-plv8> server # [ 0.666597] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-plv8> server # [ 0.666813] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-plv8> server # [ 0.666908] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-plv8> server # [ 0.667003] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-plv8> server # [ 0.667104] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-plv8> server # [ 0.667267] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-plv8> server # [ 0.667365] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-plv8> server # [ 0.667690] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-plv8> server # [ 0.667788] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-plv8> server # [ 0.667908] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-plv8> server # [ 0.668053] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-plv8> server # [ 0.668148] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-plv8> server # [ 0.668238] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-plv8> server # [ 0.668331] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-plv8> server # [ 0.668419] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-plv8> server # [ 0.668512] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-plv8> server # [ 0.669250] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-plv8> server # [ 0.669572] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-plv8> server # [ 0.669889] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.670118] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.670211] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.670989] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.710323] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.713234] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.714551] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.715848] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.717795] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.719158] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.720364] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.722083] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.723588] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.724964] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.726164] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.736507] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-plv8> server # [ 0.743091] msm_serial: driver initialized vm-test-run-plv8> server # [ 0.743947] SuperH (H)SCI(F) driver initialized vm-test-run-plv8> server # [ 0.744334] STM32 USART driver initialized vm-test-run-plv8> server # [ 0.779917] loop: module loaded vm-test-run-plv8> server # [ 0.780454] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-plv8> server # [ 0.784181] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-plv8> server # [ 0.789335] Freeing initrd memory: 10684K vm-test-run-plv8> server # [ 0.794253] megasas: 07.727.03.00-rc1 vm-test-run-plv8> server # [ 0.798626] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-plv8> server # [ 0.800819] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 0.801331] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 0.802602] Using buffer write method vm-test-run-plv8> server # [ 0.803104] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-plv8> server # [ 0.804607] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 0.804878] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 0.806257] Using buffer write method vm-test-run-plv8> server # [ 0.806498] Concatenating MTD devices: vm-test-run-plv8> server # [ 0.806599] (0): "0.flash" vm-test-run-plv8> server # [ 0.806656] (1): "0.flash" vm-test-run-plv8> server # [ 0.806708] into device "0.flash" vm-test-run-plv8> server # [ 0.824879] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-plv8> server # [ 0.834817] thunder_xcv, ver 1.0 vm-test-run-plv8> server # [ 0.834999] thunder_bgx, ver 1.0 vm-test-run-plv8> server # [ 0.835253] nicpf, ver 1.0 vm-test-run-plv8> server # [ 0.837840] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-plv8> server # [ 0.838004] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-plv8> server # [ 0.838384] hclge is initializing vm-test-run-plv8> server # [ 0.838877] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 0.838968] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-plv8> server # [ 0.839516] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 0.839615] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-plv8> server # [ 0.839789] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-plv8> server # [ 0.839909] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-plv8> server # [ 0.840100] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-plv8> server # [ 0.840187] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-plv8> server # [ 0.841425] sky2: driver version 1.30 vm-test-run-plv8> server # [ 0.847858] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-plv8> server # [ 0.848286] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-plv8> server # [ 0.849759] usbcore: registered new interface driver usb-storage vm-test-run-plv8> server # [ 0.850222] usbcore: registered new interface driver usbserial_generic vm-test-run-plv8> server # [ 0.850573] usbserial: USB Serial support registered for generic vm-test-run-plv8> server # [ 0.850967] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-plv8> server # [ 0.857919] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-plv8> server # [ 0.858495] rtc-pl031 9010000.pl031: setting system clock to 2026-10-27T15:59:15 UTC (1793116755) vm-test-run-plv8> server # [ 0.860081] i2c_dev: i2c /dev entries driver vm-test-run-plv8> server # [ 0.867743] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-plv8> server # [ 0.872205] sdhci: Secure Digital Host Controller Interface driver vm-test-run-plv8> server # [ 0.872323] sdhci: Copyright(c) Pierre Ossman vm-test-run-plv8> server # [ 0.873832] hub 1-0:1.0: USB hub found vm-test-run-plv8> server # [ 0.874040] Synopsys Designware Multimedia Card Interface Driver vm-test-run-plv8> server # [ 0.874341] hub 1-0:1.0: 6 ports detected vm-test-run-plv8> server # [ 0.875749] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-plv8> server # [ 0.881219] hid: raw HID events driver (C) Jiri Kosina vm-test-run-plv8> server # [ 0.883254] usbcore: registered new interface driver usbhid vm-test-run-plv8> server # [ 0.883390] usbhid: USB HID core driver vm-test-run-plv8> server # [ 0.889749] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-plv8> server # [ 0.899915] drop_monitor: Initializing network drop monitor service vm-test-run-plv8> server # [ 0.901361] NET: Registered PF_INET6 protocol family vm-test-run-plv8> server # [ 0.912991] Segment Routing with IPv6 vm-test-run-plv8> server # [ 0.913248] In-situ OAM (IOAM) with IPv6 vm-test-run-plv8> server # [ 0.914341] NET: Registered PF_PACKET protocol family vm-test-run-plv8> server # [ 0.915321] 9pnet: Installing 9P2000 support vm-test-run-plv8> server # [ 0.918744] Key type dns_resolver registered vm-test-run-plv8> server # [ 0.948789] registered taskstats version 1 vm-test-run-plv8> server # [ 0.951007] Loading compiled-in X.509 certificates vm-test-run-plv8> server # [ 0.999514] Demotion targets for Node 0: null vm-test-run-plv8> server # [ 1.000897] Key type .fscrypt registered vm-test-run-plv8> server # [ 1.001071] Key type fscrypt-provisioning registered vm-test-run-plv8> server # [ 1.008285] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-plv8> server # [ 1.045942] clk: Disabling unused clocks vm-test-run-plv8> server # [ 1.046178] PM: genpd: Disabling unused power domains vm-test-run-plv8> server # [ 1.046415] ALSA device list: vm-test-run-plv8> server # [ 1.046505] No soundcards found. vm-test-run-plv8> server # [ 1.118366] Freeing unused kernel memory: 4416K vm-test-run-plv8> server # [ 1.119836] Run /init as init process vm-test-run-plv8> server # [ 1.157486] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-plv8> server # [ 1.435687] 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.448313] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-plv8> server # [ 1.523531] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-plv8> server # [ 1.524850] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-plv8> server # [ 1.524872] [drm] features: -context_init vm-test-run-plv8> server # [ 1.526466] [drm] number of scanouts: 1 vm-test-run-plv8> server # [ 1.526573] [drm] number of cap sets: 0 vm-test-run-plv8> server # [ 1.533368] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-plv8> server # [ 1.558791] Console: switching to colour frame buffer device 160x50 vm-test-run-plv8> server # [ 1.566740] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-plv8> server # [ 1.567933] 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.691703] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-plv8> server # [ 1.881277] 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 # [ 1.898691] 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.292206] EXT4-fs (vda): mounted filesystem 1f571b5a-2cc9-4fc4-9125-2d80681decde r/w with ordered data mode. Quota mode: none. vm-test-run-plv8> server # [ 4.737932] EXT4-fs (vda): re-mounted 1f571b5a-2cc9-4fc4-9125-2d80681decde. vm-test-run-plv8> server # [ 4.751418] booting system configuration /nix/store/w4y2xgy5xkwyxpfpy4355apj6wnfdia8-nixos-system-server-test vm-test-run-plv8> server # [ 11.352369] 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 # [ 11.359762] systemd[1]: Detected virtualization qemu. vm-test-run-plv8> server # [ 11.362870] systemd[1]: Detected architecture arm64. vm-test-run-plv8> server # [ 11.366191] systemd[1]: Detected first boot. vm-test-run-plv8> server # [ 11.381258] systemd[1]: Initializing machine ID from random generator. vm-test-run-plv8> server # [ 11.397993] systemd[1]: Hostname set to . vm-test-run-plv8> server # [ 12.308089] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-plv8> server # [ 12.931743] systemd[1]: Applying preset policy. vm-test-run-plv8> server # [ 14.739864] systemd[1]: Populated /etc with preset unit settings. vm-test-run-plv8> server # [ 16.414771] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-plv8> server # [ 16.534825] systemd[1]: Created slice Slice /system/getty. vm-test-run-plv8> server # [ 16.545526] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-plv8> server # [ 16.554204] systemd[1]: Created slice User and Session Slice. vm-test-run-plv8> server # [ 16.560209] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-plv8> server # [ 16.564562] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-plv8> server # [ 16.568367] systemd[1]: Expecting device /dev/hvc0... vm-test-run-plv8> server # [ 16.572085] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-plv8> server # [ 16.575222] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-plv8> server # [ 16.578986] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-plv8> server # [ 16.582417] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-plv8> server # [ 16.585935] systemd[1]: Reached target Path Units. vm-test-run-plv8> server # [ 16.588815] systemd[1]: Reached target Remote File Systems. vm-test-run-plv8> server # [ 16.591100] systemd[1]: Reached target Slice Units. vm-test-run-plv8> server # [ 16.593323] systemd[1]: Reached target Swaps. vm-test-run-plv8> server # [ 16.615165] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-plv8> server # [ 16.629158] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-plv8> server # [ 16.636205] systemd[1]: Listening on Journal Audit Socket. vm-test-run-plv8> server # [ 16.640824] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-plv8> server # [ 16.644684] systemd[1]: Listening on Journal Sockets. vm-test-run-plv8> server # [ 16.650184] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-plv8> server # [ 16.654200] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 16.658439] systemd[1]: Listening on udev Control Socket. vm-test-run-plv8> server # [ 16.662155] systemd[1]: Listening on udev Kernel Socket. vm-test-run-plv8> server # [ 16.691013] systemd[1]: Mounting Huge Pages File System... vm-test-run-plv8> server # [ 16.711581] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-plv8> server # [ 16.735941] systemd[1]: Mounting Kernel Debug File System... vm-test-run-plv8> server # [ 16.790555] systemd[1]: Mounting Kernel Trace File System... vm-test-run-plv8> server # [ 16.898044] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-plv8> server # [ 16.971979] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-plv8> server # [ 16.979096] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-plv8> server # [ 17.040747] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-plv8> server # [ 17.050639] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-plv8> server # [ 17.058977] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-plv8> server # [ 17.100199] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-plv8> server # [ 17.107758] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-plv8> server # [ 17.111821] 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 # [ 17.194011] systemd[1]: Starting Journal Service... vm-test-run-plv8> server # [ 17.227501] systemd[1]: Starting Load Kernel Modules... vm-test-run-plv8> server # [ 17.275766] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-plv8> server # [ 17.323321] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-plv8> server # [ 17.329322] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 17.354595] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-plv8> server # [ 17.420265] systemd[1]: Mounted Huge Pages File System. vm-test-run-plv8> server # [ 17.431078] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-plv8> server # [ 17.438820] systemd[1]: Mounted Kernel Debug File System. vm-test-run-plv8> server # [ 17.446583] systemd[1]: Mounted Kernel Trace File System. vm-test-run-plv8> server # [ 17.470047] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-plv8> server # [ 17.490142] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-plv8> server # [ 17.498850] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-plv8> server # [ 17.514821] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-plv8> server # [ 17.550362] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-plv8> server # [ 17.740796] fuse: init (API version 7.41) vm-test-run-plv8> server # [ 17.795768] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-plv8> server # [ 17.803015] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-plv8> server # [ 17.836840] systemd[1]: Mounting FUSE Control File System... vm-test-run-plv8> server # [ 17.946588] systemd[1]: Finished Load Kernel Modules. vm-test-run-plv8> server # [ 17.951584] EXT4-fs (vda): re-mounted 1f571b5a-2cc9-4fc4-9125-2d80681decde. vm-test-run-plv8> server # [ 17.994369] systemd[1]: Starting Firewall... vm-test-run-plv8> server # [ 18.037974] systemd[1]: Starting Apply Kernel Variables... vm-test-run-plv8> server # [ 18.077085] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-plv8> server # [ 18.082313] systemd[1]: Mounted FUSE Control File System. vm-test-run-plv8> server # [ 18.092340] systemd-journald[410]: Collecting audit messages is enabled. vm-test-run-plv8> server # [ 18.099318] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-plv8> server # [ 18.146085] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-plv8> server # [ 18.150138] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 18.658035] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-plv8> server # [ 18.663737] systemd[1]: Reached target First Boot Complete. vm-test-run-plv8> server # [ 18.947422] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-plv8> server # [ 18.978638] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-plv8> server # [ 19.007062] systemd[1]: Finished Apply Kernel Variables. vm-test-run-plv8> server # [ 19.074792] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-plv8> server # [ 19.464616] systemd[1]: Started Journal Service. vm-test-run-plv8> server # [ 19.306972] systemd-modules-load[411]: Module 'atkbd' is built in vm-test-run-plv8> server # [ 19.313137] systemd-modules-load[411]: Module 'loop' is built in vm-test-run-plv8> server # [ 19.320421] systemd-oomd[412]: No swap; memory pressure usage will be degraded vm-test-run-plv8> server # [ 19.339531] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-plv8> server # [ 19.638226] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-plv8> server # [ 19.640484] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-plv8> server # [ 19.661646] systemd[1]: Mounting /run/wrappers... vm-test-run-plv8> server # [ 19.674713] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-plv8> server # [ 19.887849] systemd-journald[410]: Received client request to flush runtime journal. vm-test-run-plv8> server # [ 19.999742] systemd[1]: Mounted /run/wrappers. vm-test-run-plv8> server # [ 20.012357] systemd[1]: Reached target Local File Systems. vm-test-run-plv8> server # [ 20.054189] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-plv8> server # [ 20.062727] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-plv8> server # [ 20.064292] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-plv8> server # [ 20.066160] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-plv8> server # [ 20.072440] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-plv8> server # [ 20.091109] systemd[1]: Starting Create System Files and Directories... vm-test-run-plv8> server # [ 20.560573] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-plv8> server # [ 20.588622] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-plv8> server # [ 20.642081] systemd-udevd[456]: Using default interface naming scheme 'v258'. vm-test-run-plv8> server # [ 21.297142] systemd[1]: Finished Create System Files and Directories. vm-test-run-plv8> server # [ 21.336995] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-plv8> server # [ 21.372715] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-plv8> server # [ 21.899791] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-plv8> server # [ 22.236707] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-plv8> server # [ 22.652798] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-plv8> server # [ 22.707524] systemd[1]: Starting Update is Completed... vm-test-run-plv8> server # [ 23.087708] systemd[1]: Finished Update is Completed. vm-test-run-plv8> server # [ 25.240561] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-plv8> server # [ 25.249979] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-plv8> server # [ 25.253734] systemd[1]: suid-sgid-wrappers.service: Consumed 1.581s CPU time, 5.7M memory peak. vm-test-run-plv8> server # [ 26.586298] systemd[1]: Finished Firewall. vm-test-run-plv8> server # [ 27.581542] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-plv8> server # [ 27.583255] systemd[1]: Reached target System Initialization. vm-test-run-plv8> server # [ 27.594548] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-plv8> server # [ 27.601510] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-plv8> server # [ 27.604321] systemd[1]: Reached target Timer Units. vm-test-run-plv8> server # [ 27.613297] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-plv8> server # [ 27.614573] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-plv8> server # [ 27.621228] systemd[1]: Listening on Hostname Service Socket. vm-test-run-plv8> server # [ 27.625580] systemd[1]: Reached target Socket Units. vm-test-run-plv8> server # [ 27.627251] systemd[1]: Reached target Basic System. vm-test-run-plv8> server # [ 27.643498] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-plv8> server # [ 27.670384] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 27.708765] systemd[1]: Started Reset console on configuration changes. vm-test-run-plv8> server # [ 27.734884] systemd[1]: Starting resolvconf update... vm-test-run-plv8> server # [ 27.801662] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-plv8> server # [ 28.409853] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-plv8> server # [ 28.513551] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 28.519393] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 28.532817] nsncd[642]: Oct 27 15:59:43.312 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 28.541283] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 28.589269] systemd[1]: Starting User Login Management... vm-test-run-plv8> server # [ 28.712316] dbus-daemon[645]: dbus[645]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-plv8> server # [ 28.984101] systemd[1]: Started D-Bus System Message Bus. 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.427828] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-plv8> server # [ 29.430892] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-plv8> server # [ 29.441978] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-plv8> server # [ 29.445702] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-plv8> server # [ 29.453990] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 29.463652] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-plv8> server # [ 29.474556] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 29.581227] systemd-logind[665]: New seat seat0. vm-test-run-plv8> server # [ 29.597100] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 29.601794] systemd[1]: Started User Login Management. vm-test-run-plv8> server # [ 29.648615] systemd[1]: Starting linger-users.service... vm-test-run-plv8> server # [ 29.965453] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-plv8> server # [ 29.979044] systemd[1]: Finished linger-users.service. vm-test-run-plv8> server # [ 30.109106] nsncd[709]: Oct 27 15:59:44.930 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 30.124194] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 30.127385] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 30.129614] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 30.287159] systemd[1]: Finished resolvconf update. vm-test-run-plv8> server # [ 30.298348] systemd[1]: Reached target Preparation for Network. vm-test-run-plv8> server # [ 30.321715] systemd[1]: Starting DHCP Client... vm-test-run-plv8> server # [ 31.152789] systemd[1]: Found device /dev/hvc0. vm-test-run-plv8> server # [ 31.325016] dhcpcd[753]: dhcpcd-10.2.4 starting vm-test-run-plv8> server # [ 31.387683] dhcpcd[758]: dev: loaded udev vm-test-run-plv8> server # [ 31.553135] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-plv8> server # [ 31.762916] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-plv8> server # [ 31.583953] systemd[1]: Started backdoor.service. vm-test-run-plv8> server # [ 32.146969] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-plv8> server # [ 32.360481] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-plv8> server # [ 32.368060] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-plv8> server # [ 32.382672] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-plv8> server # [ 32.386850] cfg80211: failed to load regulatory.db 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 33.41 seconds) vm-test-run-plv8> server: (finished: waiting for the VM to finish booting, in 33.41 seconds) vm-test-run-plv8> server # [ 33.125018] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-plv8> server # [ 32.963493] dhcpcd[758]: eth0: waiting for carrier vm-test-run-plv8> server # [ 32.978760] dhcpcd[758]: eth0: carrier acquired vm-test-run-plv8> server # [ 33.116064] dhcpcd[758]: DUID 00:01:00:01:32:73:86:f3:52:54:00:12:34:56 vm-test-run-plv8> server # [ 33.129570] dhcpcd[758]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 33.137965] dhcpcd[758]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-plv8> server # [ 34.010199] dhcpcd[758]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 34.052104] dhcpcd[758]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 34.085126] dhcpcd[758]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 34.319102] (udev-worker)[797]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 34.333592] (udev-worker)[801]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-plv8> server # [ 34.335194] (udev-worker)[801]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 34.763496] dhcpcd[758]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 34.772005] dhcpcd[758]: eth0: Router Advertisement from fe80::2 vm-test-run-plv8> server # [ 34.777940] dhcpcd[758]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-plv8> server # [ 34.794118] dhcpcd[758]: eth0: adding route to fec0::/64 vm-test-run-plv8> server # [ 34.802832] dhcpcd[758]: eth0: adding default route via fe80::2 vm-test-run-plv8> server # [ 35.126297] dhcpcd[758]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 35.215678] systemd[1]: Found device Virtio network device. vm-test-run-plv8> server # [ 35.254642] systemd[1]: Starting Address configuration of eth1... vm-test-run-plv8> server # [ 36.421362] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-plv8> server # [ 36.658513] network-addresses-eth1-start[815]: adding address 192.168.1.1/24... done vm-test-run-plv8> server # [ 36.857337] dhcpcd[758]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 36.890242] dhcpcd[758]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 36.915182] network-addresses-eth1-start[815]: adding address 2001:db8:1::1/64... done vm-test-run-plv8> server # [ 37.266515] systemd[1]: Finished Address configuration of eth1. vm-test-run-plv8> server # [ 37.304860] systemd[1]: Starting Networking Setup... vm-test-run-plv8> server # [ 37.774102] dhcpcd[758]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 37.775922] dhcpcd[758]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 39.802241] dhcpcd[758]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-plv8> server # [ 39.813733] dhcpcd[758]: eth0: adding route to 10.0.2.0/24 vm-test-run-plv8> server # [ 39.814506] dhcpcd[758]: eth0: adding default route via 10.0.2.2 vm-test-run-plv8> server # [ 40.045830] systemd[1]: Finished Networking Setup. vm-test-run-plv8> server # [ 40.057984] systemd[1]: Reached target Network. vm-test-run-plv8> server # [ 40.097198] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-plv8> server # [ 40.158495] systemd[1]: Starting Permit User Sessions... vm-test-run-plv8> server # [ 40.857212] systemd[1]: Finished Permit User Sessions. vm-test-run-plv8> server # [ 40.915120] systemd[1]: Started Getty on tty1. vm-test-run-plv8> server # [ 40.923882] systemd[1]: Reached target Login Prompts. vm-test-run-plv8> server # [ 41.787255] systemd-logind[665]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-plv8> server # [ 41.819875] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[958]: Initializing database at /var/lib/postgresql/data vm-test-run-plv8> server # [ 43.392198] systemd[1]: Started DHCP Client. vm-test-run-plv8> server # [ 43.771951] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: The files belonging to this database system will be owned by user "postgres". vm-test-run-plv8> server # [ 43.785250] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: This user must also own the server process. vm-test-run-plv8> server # [ 43.885814] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-plv8> server # [ 43.887478] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: The default database encoding has accordingly been set to "UTF8". vm-test-run-plv8> server # [ 43.888034] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: The default text search configuration will be set to "english". vm-test-run-plv8> server # [ 43.893960] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: Data page checksums are enabled. vm-test-run-plv8> server # [ 43.901939] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-plv8> server # [ 43.925569] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: creating subdirectories ... ok vm-test-run-plv8> server # [ 43.936237] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: selecting dynamic shared memory implementation ... posix vm-test-run-plv8> server # [ 45.206866] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: selecting default max_connections ... 100 vm-test-run-plv8> server # [ 45.886726] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: selecting default shared_buffers ... 128MB vm-test-run-plv8> server # [ 48.527931] mousedev: PS/2 mouse device common for all mice vm-test-run-plv8> server # [ 51.278934] systemd-logind[665]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-plv8> server # [ 55.417936] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: selecting default time zone ... UTC vm-test-run-plv8> server # [ 55.528745] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: creating configuration files ... ok vm-test-run-plv8> server # [ 59.793950] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: running bootstrap script ... ok vm-test-run-plv8> server # [ 72.400503] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: performing post-bootstrap initialization ... ok vm-test-run-plv8> server # [ 75.562651] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: syncing data to disk ... ok vm-test-run-plv8> server # [ 75.588269] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-plv8> server # [ 75.598767] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: 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 # [ 75.614107] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: Success. You can now start the database server using: vm-test-run-plv8> server # [ 75.615793] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[971]: /nix/store/1zk32bp26apmbl88jx2hy94jccll7bp8-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-plv8> server # [ 77.470646] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[958]: Validating PostgreSQL configuration... vm-test-run-plv8> server # [ 78.058245] sm4d35d18w96ga7xb248dzm3g5nmgwnv-postgresql-init[1352]: 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 # [ 79.440203] postgres[1362]: 2026-10-27 16:00:34.252 UTC [1362] LOG: pgaudit extension initialized vm-test-run-plv8> server # [ 80.238380] postgres[1362]: 2026-10-27 16:00:35.061 UTC [1362] LOG: pgsodium primary server secret key loaded vm-test-run-plv8> server # [ 80.727658] postgres[1362]: 2026-10-27 16:00:35.545 UTC [1362] LOG: vault primary server secret key loaded vm-test-run-plv8> server # [ 81.486027] postgres[1362]: 2026-10-27 16:00:36.307 UTC [1362] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-plv8> server # [ 81.537720] postgres[1362]: 2026-10-27 16:00:36.357 UTC [1362] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-plv8> server # [ 81.546051] postgres[1362]: 2026-10-27 16:00:36.361 UTC [1362] LOG: listening on IPv6 address "::", port 5432 vm-test-run-plv8> server # [ 81.555835] postgres[1362]: 2026-10-27 16:00:36.380 UTC [1362] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-plv8> server # [ 81.700176] postgres[1406]: 2026-10-27 16:00:36.520 UTC [1406] LOG: database system was shut down at 2026-10-27 16:00:27 UTC vm-test-run-plv8> server # [ 82.152781] postgres[1362]: 2026-10-27 16:00:36.922 UTC [1362] LOG: database system is ready to accept connections vm-test-run-plv8> server # [ 82.238792] postgres[1412]: 2026-10-27 16:00:37.047 UTC [1412] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 82.291203] postgres[1411]: 2026-10-27 16:00:37.072 UTC [1411] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-plv8> server # [ 82.315013] systemd[1]: Started PostgreSQL Database Server. vm-test-run-plv8> server # [ 82.337193] systemd[1]: Starting Supabase Database Initialization... vm-test-run-plv8> server # [ 82.557450] postgres[1362]: 2026-10-27 16:00:37.377 UTC [1362] LOG: background worker "pg_net 0.20.4 worker" (PID 1412) exited with exit code 1 vm-test-run-plv8> server # [ 82.798763] postgres[1414]: 2026-10-27 16:00:37.606 UTC [1414] LOG: pg_cron scheduler started vm-test-run-plv8> server # [ 82.852631] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Waiting for PostgreSQL to be ready... vm-test-run-plv8> server # [ 83.493243] postgres[1428]: ::1 2026-10-27 16:00:38.303 UTC [1428] root@root FATAL: role "root" does not exist vm-test-run-plv8> server # [ 83.533869] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: PostgreSQL is ready vm-test-run-plv8> server # [ 83.535153] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Creating postgres role... vm-test-run-plv8> server # [ 83.627164] postgres[1430]: 2026-10-27 16:00:38.434 UTC [1430] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 83.661832] postgres[1362]: 2026-10-27 16:00:38.479 UTC [1362] LOG: background worker "pg_net 0.20.4 worker" (PID 1430) exited with exit code 1 vm-test-run-plv8> server # [ 83.919027] postgres[1431]: ::1 2026-10-27 16:00:38.741 UTC [1431] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-plv8> server # [ 83.968780] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1429]: CREATE ROLE vm-test-run-plv8> server # [ 84.287541] postgres[1433]: ::1 2026-10-27 16:00:39.097 UTC [1433] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-plv8> server # [ 84.331189] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1432]: ALTER DATABASE vm-test-run-plv8> server # [ 84.395569] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-plv8> server # [ 84.920440] postgres[1443]: ::1 2026-10-27 16:00:39.740 UTC [1443] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-plv8> server # [ 85.037213] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: CREATE PUBLICATION vm-test-run-plv8> server # [ 85.039665] postgres[1443]: ::1 2026-10-27 16:00:39.843 UTC [1443] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-plv8> server # [ 85.078460] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: ALTER ROLE vm-test-run-plv8> server # [ 85.094495] postgres[1443]: ::1 2026-10-27 16:00:39.899 UTC [1443] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-plv8> server # [ 85.109641] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: CREATE ROLE vm-test-run-plv8> server # [ 85.117103] postgres[1443]: ::1 2026-10-27 16:00:39.941 UTC [1443] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-plv8> server # [ 85.142430] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: CREATE ROLE vm-test-run-plv8> server # [ 85.144145] postgres[1443]: ::1 2026-10-27 16:00:39.968 UTC [1443] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-plv8> server # [ 85.157491] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: GRANT ROLE vm-test-run-plv8> server # [ 85.159179] postgres[1443]: ::1 2026-10-27 16:00:39.983 UTC [1443] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-plv8> server # [ 85.172911] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: GRANT vm-test-run-plv8> server # [ 85.181996] postgres[1443]: ::1 2026-10-27 16:00:40.002 UTC [1443] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-plv8> server # [ 85.194219] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: CREATE ROLE vm-test-run-plv8> server # [ 85.195283] postgres[1443]: ::1 2026-10-27 16:00:40.020 UTC [1443] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-plv8> server # [ 85.209364] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: GRANT ROLE vm-test-run-plv8> server # [ 85.210796] postgres[1443]: ::1 2026-10-27 16:00:40.036 UTC [1443] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-plv8> server # [ 85.229553] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: CREATE SCHEMA vm-test-run-plv8> server # [ 85.230658] postgres[1443]: ::1 2026-10-27 16:00:40.053 UTC [1443] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-plv8> server # [ 87.987678] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: CREATE EXTENSION vm-test-run-plv8> server # [ 88.011516] postgres[1443]: ::1 2026-10-27 16:00:42.806 UTC [1443] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-plv8> server # [ 89.342595] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: CREATE EXTENSION vm-test-run-plv8> server # [ 89.347593] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: CREATE ROLE vm-test-run-plv8> server # [ 89.364058] postgres[1443]: ::1 2026-10-27 16:00:44.152 UTC [1443] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-plv8> server # [ 89.370075] postgres[1443]: ::1 2026-10-27 16:00:44.168 UTC [1443] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-plv8> server # [ 89.371357] postgres[1443]: ::1 2026-10-27 16:00:44.183 UTC [1443] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-plv8> server # [ 89.377859] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: CREATE ROLE vm-test-run-plv8> server # [ 89.391616] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: CREATE ROLE vm-test-run-plv8> server # [ 89.406817] postgres[1443]: ::1 2026-10-27 16:00:44.228 UTC [1443] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-plv8> server # [ 89.453147] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: CREATE ROLE vm-test-run-plv8> server # [ 89.470948] postgres[1443]: ::1 2026-10-27 16:00:44.291 UTC [1443] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-plv8> server # [ 89.489621] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: GRANT ROLE vm-test-run-plv8> server # [ 89.490998] postgres[1443]: ::1 2026-10-27 16:00:44.316 UTC [1443] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-plv8> server # [ 89.506658] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: GRANT ROLE vm-test-run-plv8> server # [ 89.507941] postgres[1443]: ::1 2026-10-27 16:00:44.332 UTC [1443] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-plv8> server # [ 89.518772] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: GRANT ROLE vm-test-run-plv8> server # [ 89.520199] postgres[1443]: ::1 2026-10-27 16:00:44.345 UTC [1443] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-plv8> server # [ 89.532230] postgres[1443]: ::1 2026-10-27 16:00:44.357 UTC [1443] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 89.533262] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: GRANT ROLE vm-test-run-plv8> server # [ 89.549159] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: GRANT vm-test-run-plv8> server # [ 89.550761] postgres[1443]: ::1 2026-10-27 16:00:44.374 UTC [1443] 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 # [ 89.574277] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 89.575663] postgres[1443]: ::1 2026-10-27 16:00:44.400 UTC [1443] 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 # [ 89.588200] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 89.590578] postgres[1443]: ::1 2026-10-27 16:00:44.411 UTC [1443] 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 # [ 89.601956] postgres[1443]: ::1 2026-10-27 16:00:44.423 UTC [1443] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 89.614401] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 89.615092] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: GRANT vm-test-run-plv8> server # [ 89.615513] postgres[1443]: ::1 2026-10-27 16:00:44.438 UTC [1443] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-plv8> server # [ 89.625491] postgres[1443]: ::1 2026-10-27 16:00:44.450 UTC [1443] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 89.626919] postgres[1443]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 89.653959] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: ALTER ROLE vm-test-run-plv8> server # [ 89.654726] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 89.655195] postgres[1443]: ::1 2026-10-27 16:00:44.480 UTC [1443] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 89.674302] postgres[1443]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 89.695181] postgres[1443]: ::1 2026-10-27 16:00:44.507 UTC [1443] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 89.701957] postgres[1443]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 89.703118] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 89.717691] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 89.734425] postgres[1443]: ::1 2026-10-27 16:00:44.525 UTC [1443] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-plv8> server # [ 89.749965] postgres[1443]: ::1 2026-10-27 16:00:44.539 UTC [1443] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-plv8> server # [ 89.761447] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: ALTER ROLE vm-test-run-plv8> server # [ 89.789465] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1436]: ALTER ROLE vm-test-run-plv8> server # [ 89.819830] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-plv8> server # [ 90.092275] postgres[1490]: ::1 2026-10-27 16:00:44.912 UTC [1490] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 90.119113] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE SCHEMA vm-test-run-plv8> server # [ 90.120222] postgres[1490]: ::1 2026-10-27 16:00:44.939 UTC [1490] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-plv8> server # [ 90.126279] postgres[1490]: instance_id uuid NULL, vm-test-run-plv8> server # [ 90.127985] postgres[1490]: id uuid NOT NULL UNIQUE, vm-test-run-plv8> server # [ 90.132748] postgres[1490]: aud varchar(255) NULL, vm-test-run-plv8> server # [ 90.141537] postgres[1490]: "role" varchar(255) NULL, vm-test-run-plv8> server # [ 90.142818] postgres[1490]: email varchar(255) NULL UNIQUE, vm-test-run-plv8> server # [ 90.143211] postgres[1490]: encrypted_password varchar(255) NULL, vm-test-run-plv8> server # [ 90.143506] postgres[1490]: confirmed_at timestamptz NULL, vm-test-run-plv8> server # [ 90.144027] postgres[1490]: invited_at timestamptz NULL, vm-test-run-plv8> server # [ 90.149611] postgres[1490]: confirmation_token varchar(255) NULL, vm-test-run-plv8> server # [ 90.150614] postgres[1490]: confirmation_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 90.151602] postgres[1490]: recovery_token varchar(255) NULL, vm-test-run-plv8> server # [ 90.157530] postgres[1490]: recovery_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 90.159352] postgres[1490]: email_change_token varchar(255) NULL, vm-test-run-plv8> server # [ 90.161481] postgres[1490]: email_change varchar(255) NULL, vm-test-run-plv8> server # [ 90.162417] postgres[1490]: email_change_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 90.163932] postgres[1490]: last_sign_in_at timestamptz NULL, vm-test-run-plv8> server # [ 90.168815] postgres[1490]: raw_app_meta_data jsonb NULL, vm-test-run-plv8> server # [ 90.170836] postgres[1490]: raw_user_meta_data jsonb NULL, vm-test-run-plv8> server # [ 90.172148] postgres[1490]: is_super_admin bool NULL, vm-test-run-plv8> server # [ 90.177328] postgres[1490]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 90.178528] postgres[1490]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 90.179246] postgres[1490]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 90.180476] postgres[1490]: ); vm-test-run-plv8> server # [ 90.255804] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE TABLE vm-test-run-plv8> server # [ 90.265331] postgres[1490]: ::1 2026-10-27 16:00:45.085 UTC [1490] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-plv8> server # [ 90.296235] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE INDEX vm-test-run-plv8> server # [ 90.299078] postgres[1490]: ::1 2026-10-27 16:00:45.124 UTC [1490] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-plv8> server # [ 90.334791] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE INDEX vm-test-run-plv8> server # [ 90.340407] postgres[1490]: ::1 2026-10-27 16:00:45.162 UTC [1490] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-plv8> server # [ 90.346274] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: COMMENT vm-test-run-plv8> server # [ 90.349945] postgres[1490]: ::1 2026-10-27 16:00:45.172 UTC [1490] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-plv8> server # [ 90.353406] postgres[1490]: instance_id uuid NULL, vm-test-run-plv8> server # [ 90.354285] postgres[1490]: id bigserial NOT NULL, vm-test-run-plv8> server # [ 90.354652] postgres[1490]: "token" varchar(255) NULL, vm-test-run-plv8> server # [ 90.354953] postgres[1490]: user_id varchar(255) NULL, vm-test-run-plv8> server # [ 90.355190] postgres[1490]: revoked bool NULL, vm-test-run-plv8> server # [ 90.355722] postgres[1490]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 90.356180] postgres[1490]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 90.358081] postgres[1490]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 90.358754] postgres[1490]: ); vm-test-run-plv8> server # [ 90.425003] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE TABLE vm-test-run-plv8> server # [ 90.426741] postgres[1490]: ::1 2026-10-27 16:00:45.249 UTC [1490] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-plv8> server # [ 90.459227] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE INDEX vm-test-run-plv8> server # [ 90.460155] postgres[1490]: ::1 2026-10-27 16:00:45.285 UTC [1490] 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 # [ 90.490905] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE INDEX vm-test-run-plv8> server # [ 90.501340] postgres[1490]: ::1 2026-10-27 16:00:45.322 UTC [1490] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-plv8> server # [ 90.529384] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE INDEX vm-test-run-plv8> server # [ 90.530404] postgres[1490]: ::1 2026-10-27 16:00:45.352 UTC [1490] 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 # [ 90.537681] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: COMMENT vm-test-run-plv8> server # [ 90.543189] postgres[1490]: ::1 2026-10-27 16:00:45.365 UTC [1490] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-plv8> server # [ 90.551852] postgres[1490]: id uuid NOT NULL, vm-test-run-plv8> server # [ 90.555076] postgres[1490]: uuid uuid NULL, vm-test-run-plv8> server # [ 90.555649] postgres[1490]: raw_base_config text NULL, vm-test-run-plv8> server # [ 90.555993] postgres[1490]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 90.556727] postgres[1490]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 90.558368] postgres[1490]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 90.563624] postgres[1490]: ); vm-test-run-plv8> server # [ 90.603451] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE TABLE vm-test-run-plv8> server # [ 90.609279] postgres[1490]: ::1 2026-10-27 16:00:45.431 UTC [1490] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-plv8> server # [ 90.618638] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: COMMENT vm-test-run-plv8> server # [ 90.619460] postgres[1490]: ::1 2026-10-27 16:00:45.442 UTC [1490] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-plv8> server # [ 90.620211] postgres[1490]: instance_id uuid NULL, vm-test-run-plv8> server # [ 90.620584] postgres[1490]: id uuid NOT NULL, vm-test-run-plv8> server # [ 90.625730] postgres[1490]: payload json NULL, vm-test-run-plv8> server # [ 90.626192] postgres[1490]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 90.626498] postgres[1490]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 90.630976] postgres[1490]: ); vm-test-run-plv8> server # [ 90.674683] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE TABLE vm-test-run-plv8> server # [ 90.681435] postgres[1490]: ::1 2026-10-27 16:00:45.501 UTC [1490] 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 # [ 90.706830] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE INDEX vm-test-run-plv8> server # [ 90.710854] postgres[1490]: ::1 2026-10-27 16:00:45.534 UTC [1490] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-plv8> server # [ 90.718447] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: COMMENT vm-test-run-plv8> server # [ 90.721135] postgres[1490]: ::1 2026-10-27 16:00:45.545 UTC [1490] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-plv8> server # [ 90.722744] postgres[1490]: "version" varchar(255) NOT NULL, vm-test-run-plv8> server # [ 90.723246] postgres[1490]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-plv8> server # [ 90.723839] postgres[1490]: ); vm-test-run-plv8> server # [ 90.763265] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE TABLE vm-test-run-plv8> server # [ 90.769453] postgres[1490]: ::1 2026-10-27 16:00:45.589 UTC [1490] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-plv8> server # [ 90.775774] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: COMMENT vm-test-run-plv8> server # [ 90.799179] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: INSERT 0 7 vm-test-run-plv8> server # [ 90.803212] postgres[1490]: ::1 2026-10-27 16:00:45.627 UTC [1490] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-plv8> server # [ 90.806005] postgres[1490]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-plv8> server # [ 90.813074] postgres[1490]: $$ language sql stable; vm-test-run-plv8> server # [ 90.821457] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE FUNCTION vm-test-run-plv8> server # [ 90.823743] postgres[1490]: ::1 2026-10-27 16:00:45.644 UTC [1490] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-plv8> server # [ 90.825314] postgres[1490]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-plv8> server # [ 90.827121] postgres[1490]: $$ language sql stable; vm-test-run-plv8> server # [ 90.839074] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE FUNCTION vm-test-run-plv8> server # [ 90.841859] postgres[1490]: ::1 2026-10-27 16:00:45.666 UTC [1490] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-plv8> server # [ 90.843104] postgres[1490]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-plv8> server # [ 90.848559] postgres[1490]: $$ language sql stable; vm-test-run-plv8> server # [ 90.857861] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE FUNCTION vm-test-run-plv8> server # [ 90.858931] postgres[1490]: ::1 2026-10-27 16:00:45.681 UTC [1490] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-plv8> server # [ 90.866721] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: GRANT vm-test-run-plv8> server # [ 90.867604] postgres[1490]: ::1 2026-10-27 16:00:45.693 UTC [1490] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 90.879295] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: CREATE ROLE vm-test-run-plv8> server # [ 90.882452] postgres[1490]: ::1 2026-10-27 16:00:45.703 UTC [1490] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 90.887261] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: GRANT vm-test-run-plv8> server # [ 90.889482] postgres[1490]: ::1 2026-10-27 16:00:45.713 UTC [1490] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 90.902585] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: GRANT vm-test-run-plv8> server # [ 90.905603] postgres[1490]: ::1 2026-10-27 16:00:45.726 UTC [1490] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 90.910744] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: GRANT vm-test-run-plv8> server # [ 90.915135] postgres[1490]: ::1 2026-10-27 16:00:45.738 UTC [1490] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-plv8> server # [ 90.922543] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: ALTER ROLE vm-test-run-plv8> server # [ 90.931259] postgres[1490]: ::1 2026-10-27 16:00:45.749 UTC [1490] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 90.945261] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: ALTER TABLE vm-test-run-plv8> server # [ 90.959982] postgres[1490]: ::1 2026-10-27 16:00:45.783 UTC [1490] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 91.003497] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: ALTER TABLE vm-test-run-plv8> server # [ 91.005378] postgres[1490]: ::1 2026-10-27 16:00:45.829 UTC [1490] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 91.030158] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: ALTER TABLE vm-test-run-plv8> server # [ 91.043201] postgres[1490]: ::1 2026-10-27 16:00:45.862 UTC [1490] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 91.059987] postgres[1490]: ::1 2026-10-27 16:00:45.877 UTC [1490] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 91.102053] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: ALTER TABLE vm-test-run-plv8> server # [ 91.102913] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1489]: ALTER TABLE vm-test-run-plv8> server # [ 91.147902] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-plv8> server # [ 91.662931] postgres[1500]: ::1 2026-10-27 16:00:46.477 UTC [1500] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 91.713742] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1494]: CREATE SCHEMA vm-test-run-plv8> server # [ 91.716318] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1494]: CREATE ROLE vm-test-run-plv8> server # [ 91.723368] postgres[1500]: ::1 2026-10-27 16:00:46.520 UTC [1500] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 91.730703] postgres[1500]: ::1 2026-10-27 16:00:46.543 UTC [1500] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-plv8> server # [ 91.731828] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1494]: ALTER ROLE vm-test-run-plv8> server # [ 91.737956] postgres[1500]: ::1 2026-10-27 16:00:46.559 UTC [1500] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-plv8> server # [ 91.756002] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1494]: GRANT vm-test-run-plv8> server # [ 91.821477] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1494]: DO vm-test-run-plv8> server # [ 91.852740] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-plv8> server # [ 92.318143] postgres[1510]: ::1 2026-10-27 16:00:47.124 UTC [1510] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-plv8> server # [ 92.353257] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: ALTER ROLE vm-test-run-plv8> server # [ 92.359926] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: ALTER ROLE vm-test-run-plv8> server # [ 92.368199] postgres[1510]: ::1 2026-10-27 16:00:47.169 UTC [1510] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-plv8> server # [ 92.371097] postgres[1510]: ::1 2026-10-27 16:00:47.183 UTC [1510] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-plv8> server # [ 92.374319] postgres[1510]: RETURNS event_trigger vm-test-run-plv8> server # [ 92.374995] postgres[1510]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 92.375448] postgres[1510]: AS $$ vm-test-run-plv8> server # [ 92.376520] postgres[1510]: DECLARE vm-test-run-plv8> server # [ 92.381675] postgres[1510]: schema_is_cron bool; vm-test-run-plv8> server # [ 92.382957] postgres[1510]: BEGIN vm-test-run-plv8> server # [ 92.389646] postgres[1510]: schema_is_cron = ( vm-test-run-plv8> server # [ 92.401121] postgres[1510]: SELECT n.nspname = 'cron' vm-test-run-plv8> server # [ 92.403589] postgres[1510]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 92.417971] postgres[1510]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-plv8> server # [ 92.419157] postgres[1510]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 92.420074] postgres[1510]: ); vm-test-run-plv8> server # [ 92.430079] postgres[1510]: vm-test-run-plv8> server # [ 92.431931] postgres[1510]: IF schema_is_cron vm-test-run-plv8> server # [ 92.438665] postgres[1510]: THEN vm-test-run-plv8> server # [ 92.445799] postgres[1510]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 92.447604] postgres[1510]: vm-test-run-plv8> server # [ 92.448453] postgres[1510]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 92.458061] postgres[1510]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 92.458737] postgres[1510]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 92.459285] postgres[1510]: vm-test-run-plv8> server # [ 92.459543] postgres[1510]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 92.459903] postgres[1510]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 92.460169] postgres[1510]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 92.467381] postgres[1510]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 92.473527] postgres[1510]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 92.474795] postgres[1510]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 92.475713] postgres[1510]: vm-test-run-plv8> server # [ 92.476275] postgres[1510]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 92.481294] postgres[1510]: vm-test-run-plv8> server # [ 92.481850] postgres[1510]: END IF; vm-test-run-plv8> server # [ 92.483209] postgres[1510]: vm-test-run-plv8> server # [ 92.483863] postgres[1510]: END; vm-test-run-plv8> server # [ 92.489302] postgres[1510]: $$; vm-test-run-plv8> server # [ 92.490519] postgres[1510]: ::1 2026-10-27 16:00:47.223 UTC [1510] 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 # [ 92.498296] postgres[1510]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 92.505167] postgres[1510]: ::1 2026-10-27 16:00:47.284 UTC [1510] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-plv8> server # [ 92.509104] postgres[1510]: ::1 2026-10-27 16:00:47.300 UTC [1510] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-plv8> server # [ 92.509834] postgres[1510]: RETURNS event_trigger vm-test-run-plv8> server # [ 92.510164] postgres[1510]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 92.510734] postgres[1510]: AS $$ vm-test-run-plv8> server # [ 92.523049] postgres[1510]: BEGIN vm-test-run-plv8> server # [ 92.526352] postgres[1510]: IF EXISTS ( vm-test-run-plv8> server # [ 92.535058] postgres[1510]: SELECT 1 vm-test-run-plv8> server # [ 92.535871] postgres[1510]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 92.544897] postgres[1510]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 92.557318] postgres[1510]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 92.559881] postgres[1510]: WHERE ext.extname = 'pg_net' vm-test-run-plv8> server # [ 92.566852] postgres[1510]: ) vm-test-run-plv8> server # [ 92.571661] postgres[1510]: THEN vm-test-run-plv8> server # [ 92.583333] postgres[1510]: IF NOT EXISTS ( vm-test-run-plv8> server # [ 92.588955] postgres[1510]: SELECT 1 vm-test-run-plv8> server # [ 92.590065] postgres[1510]: FROM pg_roles vm-test-run-plv8> server # [ 92.591587] postgres[1510]: WHERE rolname = 'supabase_functions_admin' vm-test-run-plv8> server # [ 92.592026] postgres[1510]: ) vm-test-run-plv8> server # [ 92.602182] postgres[1510]: THEN vm-test-run-plv8> server # [ 92.602610] postgres[1510]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 92.603440] postgres[1510]: END IF; vm-test-run-plv8> server # [ 92.610330] postgres[1510]: vm-test-run-plv8> server # [ 92.618334] postgres[1510]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 92.619785] postgres[1510]: vm-test-run-plv8> server # [ 92.620337] postgres[1510]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 92.626293] postgres[1510]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 92.641047] postgres[1510]: vm-test-run-plv8> server # [ 92.643595] postgres[1510]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plv8> server # [ 92.659928] postgres[1510]: 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 # [ 92.667339] postgres[1510]: vm-test-run-plv8> server # [ 92.673829] postgres[1510]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plv8> server # [ 92.675506] postgres[1510]: 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 # [ 92.687218] postgres[1510]: vm-test-run-plv8> server # [ 92.689594] postgres[1510]: 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 # [ 92.691080] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: CREATE FUNCTION vm-test-run-plv8> server # [ 92.691531] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 92.691834] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: COMMENT vm-test-run-plv8> server # [ 92.692093] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: CREATE FUNCTION vm-test-run-plv8> server # [ 92.692346] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: COMMENT vm-test-run-plv8> server # [ 92.695245] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: DO vm-test-run-plv8> server # [ 92.695714] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: CREATE ROLE vm-test-run-plv8> server # [ 92.696019] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: GRANT vm-test-run-plv8> server # [ 92.696265] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: GRANT vm-test-run-plv8> server # [ 92.697755] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: GRANT vm-test-run-plv8> server # [ 92.698369] postgres[1510]: 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 # [ 92.699379] postgres[1510]: END IF; vm-test-run-plv8> server # [ 92.700163] postgres[1510]: END; vm-test-run-plv8> server # [ 92.701720] postgres[1510]: $$; vm-test-run-plv8> server # [ 92.702575] postgres[1510]: ::1 2026-10-27 16:00:47.319 UTC [1510] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-plv8> server # [ 92.703151] postgres[1510]: ::1 2026-10-27 16:00:47.403 UTC [1510] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-plv8> server # [ 92.703505] postgres[1510]: ::1 2026-10-27 16:00:47.433 UTC [1510] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-plv8> server # [ 92.706108] postgres[1510]: ::1 2026-10-27 16:00:47.457 UTC [1510] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 92.709693] postgres[1510]: ::1 2026-10-27 16:00:47.487 UTC [1510] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 92.712778] postgres[1510]: ::1 2026-10-27 16:00:47.517 UTC [1510] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 92.719842] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: GRANT vm-test-run-plv8> server # [ 92.729690] postgres[1510]: ::1 2026-10-27 16:00:47.548 UTC [1510] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 92.737334] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: GRANT vm-test-run-plv8> server # [ 92.739338] postgres[1510]: ::1 2026-10-27 16:00:47.561 UTC [1510] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 92.765899] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: GRANT vm-test-run-plv8> server # [ 92.767518] postgres[1510]: ::1 2026-10-27 16:00:47.592 UTC [1510] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 92.781424] postgres[1510]: ::1 2026-10-27 16:00:47.596 UTC [1510] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 92.782669] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: GRANT vm-test-run-plv8> server # [ 92.811404] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: GRANT vm-test-run-plv8> server # [ 92.814284] postgres[1510]: ::1 2026-10-27 16:00:47.637 UTC [1510] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 92.855384] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: GRANT vm-test-run-plv8> server # [ 92.872787] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1506]: DO vm-test-run-plv8> server # [ 92.923293] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running pgbouncer auth schema... vm-test-run-plv8> server # [ 93.321761] postgres[1523]: ::1 2026-10-27 16:00:48.133 UTC [1523] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-plv8> server # [ 93.345895] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1519]: CREATE ROLE vm-test-run-plv8> server # [ 93.348104] postgres[1523]: ::1 2026-10-27 16:00:48.164 UTC [1523] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-plv8> server # [ 93.362906] postgres[1523]: ::1 2026-10-27 16:00:48.183 UTC [1523] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-plv8> server # [ 93.369772] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1519]: REVOKE vm-test-run-plv8> server # [ 93.407810] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1519]: CREATE SCHEMA vm-test-run-plv8> server # [ 93.413460] postgres[1523]: ::1 2026-10-27 16:00:48.236 UTC [1523] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-plv8> server # [ 93.415015] postgres[1523]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-plv8> server # [ 93.416110] postgres[1523]: $$ vm-test-run-plv8> server # [ 93.419155] postgres[1523]: BEGIN vm-test-run-plv8> server # [ 93.419630] postgres[1523]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-plv8> server # [ 93.420171] postgres[1523]: vm-test-run-plv8> server # [ 93.426348] postgres[1523]: RETURN QUERY vm-test-run-plv8> server # [ 93.427649] postgres[1523]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-plv8> server # [ 93.434039] postgres[1523]: WHERE usename = p_usename; vm-test-run-plv8> server # [ 93.442950] postgres[1523]: END; vm-test-run-plv8> server # [ 93.443697] postgres[1523]: $$ LANGUAGE plpgsql vm-test-run-plv8> server # [ 93.444031] postgres[1523]: SET search_path = '' vm-test-run-plv8> server # [ 93.444283] postgres[1523]: SECURITY DEFINER; vm-test-run-plv8> server # [ 93.450825] postgres[1523]: ::1 2026-10-27 16:00:48.269 UTC [1523] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-plv8> server # [ 93.463006] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1519]: CREATE FUNCTION vm-test-run-plv8> server # [ 93.463848] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1519]: REVOKE vm-test-run-plv8> server # [ 93.467801] postgres[1523]: ::1 2026-10-27 16:00:48.286 UTC [1523] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-plv8> server # [ 93.479114] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1519]: GRANT vm-test-run-plv8> server # [ 93.533037] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running stat extension... vm-test-run-plv8> server # [ 93.867303] postgres[1526]: ::1 2026-10-27 16:00:48.675 UTC [1526] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-plv8> server # [ 93.896768] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1525]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-plv8> server # [ 93.914359] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1525]: CREATE SCHEMA vm-test-run-plv8> server # [ 93.917564] postgres[1526]: ::1 2026-10-27 16:00:48.741 UTC [1526] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-plv8> server # [ 95.385754] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1525]: CREATE EXTENSION vm-test-run-plv8> server # [ 95.513628] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-plv8> server # [ 95.927956] postgres[1552]: ::1 2026-10-27 16:00:50.748 UTC [1552] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-plv8> server # [ 95.950030] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1548]: GRANT vm-test-run-plv8> server # [ 95.953450] postgres[1552]: ::1 2026-10-27 16:00:50.767 UTC [1552] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 95.959768] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1548]: GRANT vm-test-run-plv8> server # [ 95.961767] postgres[1552]: ::1 2026-10-27 16:00:50.783 UTC [1552] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 95.969632] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1548]: GRANT vm-test-run-plv8> server # [ 95.977391] postgres[1552]: ::1 2026-10-27 16:00:50.797 UTC [1552] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 95.997130] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1548]: GRANT vm-test-run-plv8> server # [ 96.001425] postgres[1552]: ::1 2026-10-27 16:00:50.824 UTC [1552] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 96.014542] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1548]: GRANT vm-test-run-plv8> server # [ 96.024436] postgres[1552]: ::1 2026-10-27 16:00:50.847 UTC [1552] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 96.038192] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1548]: GRANT vm-test-run-plv8> server # [ 96.040100] postgres[1552]: ::1 2026-10-27 16:00:50.861 UTC [1552] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 96.047447] postgres[1552]: ::1 2026-10-27 16:00:50.867 UTC [1552] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 96.054241] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1548]: GRANT vm-test-run-plv8> server # [ 96.063088] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1548]: GRANT vm-test-run-plv8> server # [ 96.067391] postgres[1552]: ::1 2026-10-27 16:00:50.890 UTC [1552] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 96.097490] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1548]: GRANT vm-test-run-plv8> server # [ 96.130005] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1548]: DO vm-test-run-plv8> server # [ 96.132907] postgres[1552]: ::1 2026-10-27 16:00:50.952 UTC [1552] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-plv8> server # [ 96.138316] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1548]: ALTER ROLE vm-test-run-plv8> server # [ 96.190114] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-plv8> server # [ 96.469454] postgres[1554]: ::1 2026-10-27 16:00:51.285 UTC [1554] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 96.479939] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: GRANT vm-test-run-plv8> server # [ 96.485636] postgres[1554]: ::1 2026-10-27 16:00:51.310 UTC [1554] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 96.500620] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: GRANT vm-test-run-plv8> server # [ 96.512449] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: GRANT vm-test-run-plv8> server # [ 96.515736] postgres[1554]: ::1 2026-10-27 16:00:51.328 UTC [1554] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 96.520540] postgres[1554]: ::1 2026-10-27 16:00:51.337 UTC [1554] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 96.530662] postgres[1554]: ::1 2026-10-27 16:00:51.354 UTC [1554] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 96.532194] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: ALTER TABLE vm-test-run-plv8> server # [ 96.541754] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: ALTER TABLE vm-test-run-plv8> server # [ 96.542673] postgres[1554]: ::1 2026-10-27 16:00:51.364 UTC [1554] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 96.550050] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: ALTER TABLE vm-test-run-plv8> server # [ 96.555501] postgres[1554]: ::1 2026-10-27 16:00:51.377 UTC [1554] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 96.561733] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: ALTER TABLE vm-test-run-plv8> server # [ 96.566156] postgres[1554]: ::1 2026-10-27 16:00:51.389 UTC [1554] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 96.580834] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: ALTER TABLE vm-test-run-plv8> server # [ 96.585976] postgres[1554]: ::1 2026-10-27 16:00:51.408 UTC [1554] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 96.594157] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: GRANT vm-test-run-plv8> server # [ 96.595746] postgres[1554]: ::1 2026-10-27 16:00:51.420 UTC [1554] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 96.613678] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: GRANT vm-test-run-plv8> server # [ 96.620122] postgres[1554]: ::1 2026-10-27 16:00:51.437 UTC [1554] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 96.624835] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: GRANT vm-test-run-plv8> server # [ 96.627581] postgres[1554]: ::1 2026-10-27 16:00:51.453 UTC [1554] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 96.651173] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: GRANT vm-test-run-plv8> server # [ 96.657247] postgres[1554]: ::1 2026-10-27 16:00:51.479 UTC [1554] 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 # [ 96.672714] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 96.674048] postgres[1554]: ::1 2026-10-27 16:00:51.497 UTC [1554] 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 # [ 96.684902] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 96.686028] postgres[1554]: ::1 2026-10-27 16:00:51.511 UTC [1554] 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 # [ 96.691788] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1553]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 96.757217] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-plv8> server # [ 97.135917] postgres[1558]: ::1 2026-10-27 16:00:51.956 UTC [1558] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-plv8> server # [ 97.192033] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1555]: CREATE SCHEMA vm-test-run-plv8> server # [ 97.238100] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-plv8> server # [ 97.768100] postgres[1566]: ::1 2026-10-27 16:00:52.584 UTC [1566] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-plv8> server # [ 97.797404] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1561]: GRANT vm-test-run-plv8> server # [ 97.801162] postgres[1566]: ::1 2026-10-27 16:00:52.624 UTC [1566] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 97.805911] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1561]: GRANT vm-test-run-plv8> server # [ 97.814110] postgres[1566]: ::1 2026-10-27 16:00:52.633 UTC [1566] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 97.815369] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1561]: GRANT vm-test-run-plv8> server # [ 97.820612] postgres[1566]: ::1 2026-10-27 16:00:52.643 UTC [1566] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 97.823292] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1561]: GRANT vm-test-run-plv8> server # [ 97.899733] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-plv8> server # [ 98.462323] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1570]: DO vm-test-run-plv8> server # [ 98.465953] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1570]: DO vm-test-run-plv8> server # [ 98.485269] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1570]: DO vm-test-run-plv8> server # [ 98.524270] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-plv8> server # [ 98.895497] postgres[1586]: ::1 2026-10-27 16:00:53.717 UTC [1586] 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 # [ 98.918055] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1584]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 98.918924] postgres[1586]: ::1 2026-10-27 16:00:53.743 UTC [1586] 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 # [ 98.927159] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1584]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 98.935415] postgres[1586]: ::1 2026-10-27 16:00:53.755 UTC [1586] 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 # [ 98.949777] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1584]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 99.013793] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-plv8> server # [ 99.402324] postgres[1592]: ::1 2026-10-27 16:00:54.215 UTC [1592] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-plv8> server # [ 99.431083] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1589]: ALTER ROLE vm-test-run-plv8> server # [ 99.456134] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-plv8> server # [ 99.827117] postgres[1594]: ::1 2026-10-27 16:00:54.646 UTC [1594] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 99.857921] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: 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 # [ 99.863438] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 99.869272] postgres[1594]: ::1 2026-10-27 16:00:54.685 UTC [1594] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 99.870670] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: 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 # [ 99.875708] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: DROP FUNCTION vm-test-run-plv8> server # [ 99.901070] postgres[1594]: ::1 2026-10-27 16:00:54.711 UTC [1594] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 99.902893] postgres[1594]: DECLARE vm-test-run-plv8> server # [ 99.903430] postgres[1594]: cmd record; vm-test-run-plv8> server # [ 99.904056] postgres[1594]: BEGIN vm-test-run-plv8> server # [ 99.913934] postgres[1594]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 99.915080] postgres[1594]: LOOP vm-test-run-plv8> server # [ 99.915677] postgres[1594]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 99.919439] postgres[1594]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 99.922099] postgres[1594]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 99.928226] postgres[1594]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 99.931330] postgres[1594]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 99.931981] postgres[1594]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 99.932307] postgres[1594]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 99.934219] postgres[1594]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 99.935047] postgres[1594]: , 'CREATE TYPE' vm-test-run-plv8> server # [ 99.935918] postgres[1594]: , 'CREATE RULE' vm-test-run-plv8> server # [ 99.936366] postgres[1594]: , 'COMMENT' vm-test-run-plv8> server # [ 99.938072] postgres[1594]: ) vm-test-run-plv8> server # [ 99.938778] postgres[1594]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 99.939271] postgres[1594]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 99.940236] postgres[1594]: THEN vm-test-run-plv8> server # [ 99.941495] postgres[1594]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 99.942259] postgres[1594]: END IF; vm-test-run-plv8> server # [ 99.942550] postgres[1594]: END LOOP; vm-test-run-plv8> server # [ 99.943047] postgres[1594]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 99.943721] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: CREATE FUNCTION vm-test-run-plv8> server # [ 99.949961] postgres[1594]: ::1 2026-10-27 16:00:54.771 UTC [1594] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 99.953854] postgres[1594]: DECLARE vm-test-run-plv8> server # [ 99.954599] postgres[1594]: obj record; vm-test-run-plv8> server # [ 99.955724] postgres[1594]: BEGIN vm-test-run-plv8> server # [ 99.956186] postgres[1594]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 99.958376] postgres[1594]: LOOP vm-test-run-plv8> server # [ 99.960266] postgres[1594]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 99.967349] postgres[1594]: 'schema' vm-test-run-plv8> server # [ 99.972248] postgres[1594]: , 'table' vm-test-run-plv8> server # [ 99.973692] postgres[1594]: , 'foreign table' vm-test-run-plv8> server # [ 99.974382] postgres[1594]: , 'view' vm-test-run-plv8> server # [ 99.975860] postgres[1594]: , 'materialized view' vm-test-run-plv8> server # [ 99.978464] postgres[1594]: , 'function' vm-test-run-plv8> server # [ 99.979453] postgres[1594]: , 'trigger' vm-test-run-plv8> server # [ 99.979759] postgres[1594]: , 'type' vm-test-run-plv8> server # [ 99.979985] postgres[1594]: , 'rule' vm-test-run-plv8> server # [ 99.980201] postgres[1594]: ) vm-test-run-plv8> server # [ 99.980427] postgres[1594]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 99.983318] postgres[1594]: THEN vm-test-run-plv8> server # [ 99.985987] postgres[1594]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 99.987076] postgres[1594]: END IF; vm-test-run-plv8> server # [ 99.987429] postgres[1594]: END LOOP; vm-test-run-plv8> server # [ 99.987984] postgres[1594]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 99.991107] postgres[1594]: ::1 2026-10-27 16:00:54.781 UTC [1594] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 99.994480] postgres[1594]: ::1 2026-10-27 16:00:54.788 UTC [1594] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 99.996064] postgres[1594]: ON ddl_command_end vm-test-run-plv8> server # [ 99.997971] postgres[1594]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 99.998928] postgres[1594]: ::1 2026-10-27 16:00:54.796 UTC [1594] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 100.001314] postgres[1594]: ::1 2026-10-27 16:00:54.805 UTC [1594] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 100.002029] postgres[1594]: ON sql_drop vm-test-run-plv8> server # [ 100.002898] postgres[1594]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 100.004243] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: CREATE FUNCTION vm-test-run-plv8> server # [ 100.006726] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: 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 # [ 100.009579] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 100.010001] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 100.010672] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: 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 # [ 100.011605] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 100.012037] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1593]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 100.081331] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-plv8> server # [ 101.219320] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1595]: DO vm-test-run-plv8> server # [ 101.271667] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-plv8> server # [ 101.783285] postgres[1614]: ::1 2026-10-27 16:00:56.587 UTC [1614] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-plv8> server # [ 101.857304] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: CREATE SCHEMA vm-test-run-plv8> server # [ 101.867357] postgres[1614]: ::1 2026-10-27 16:00:56.691 UTC [1614] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-plv8> server # [ 101.893534] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: 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 # [ 101.895385] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: DROP FUNCTION vm-test-run-plv8> server # [ 101.896240] postgres[1614]: ::1 2026-10-27 16:00:56.716 UTC [1614] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 101.907083] postgres[1614]: "operationName" text default null, vm-test-run-plv8> server # [ 101.917509] postgres[1614]: query text default null, vm-test-run-plv8> server # [ 101.919093] postgres[1614]: variables jsonb default null, vm-test-run-plv8> server # [ 101.929460] postgres[1614]: extensions jsonb default null vm-test-run-plv8> server # [ 101.930217] postgres[1614]: ) vm-test-run-plv8> server # [ 101.930669] postgres[1614]: returns jsonb vm-test-run-plv8> server # [ 101.930935] postgres[1614]: language plpgsql vm-test-run-plv8> server # [ 101.931305] postgres[1614]: as $$ vm-test-run-plv8> server # [ 101.932263] postgres[1614]: DECLARE vm-test-run-plv8> server # [ 101.936897] postgres[1614]: server_version float; vm-test-run-plv8> server # [ 101.937803] postgres[1614]: BEGIN vm-test-run-plv8> server # [ 101.938487] postgres[1614]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 101.938828] postgres[1614]: vm-test-run-plv8> server # [ 101.951739] postgres[1614]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 101.952165] postgres[1614]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 101.952435] postgres[1614]: 'data', null::jsonb, vm-test-run-plv8> server # [ 101.953940] postgres[1614]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 101.954556] postgres[1614]: ); vm-test-run-plv8> server # [ 101.954939] postgres[1614]: ELSE vm-test-run-plv8> server # [ 101.955191] postgres[1614]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 101.955439] postgres[1614]: 'data', null::jsonb, vm-test-run-plv8> server # [ 101.956215] postgres[1614]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 101.956616] postgres[1614]: ); vm-test-run-plv8> server # [ 101.973116] postgres[1614]: END IF; vm-test-run-plv8> server # [ 101.973948] postgres[1614]: END; vm-test-run-plv8> server # [ 101.978027] postgres[1614]: $$; vm-test-run-plv8> server # [ 101.978906] postgres[1614]: ::1 2026-10-27 16:00:56.765 UTC [1614] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 101.989934] postgres[1614]: ::1 2026-10-27 16:00:56.800 UTC [1614] 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 # [ 102.001560] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: CREATE FUNCTION vm-test-run-plv8> server # [ 102.011522] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: GRANT vm-test-run-plv8> server # [ 102.021507] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 102.033820] postgres[1614]: ::1 2026-10-27 16:00:56.844 UTC [1614] 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 # [ 102.038551] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 102.059544] postgres[1614]: ::1 2026-10-27 16:00:56.867 UTC [1614] 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 # [ 102.091311] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 102.106690] postgres[1614]: ::1 2026-10-27 16:00:56.925 UTC [1614] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 102.114300] postgres[1614]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 102.115434] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 102.116177] postgres[1614]: ::1 2026-10-27 16:00:56.941 UTC [1614] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 102.121840] postgres[1614]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 102.125492] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 102.130475] postgres[1614]: ::1 2026-10-27 16:00:56.955 UTC [1614] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 102.131368] postgres[1614]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 102.141225] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 102.146981] postgres[1614]: ::1 2026-10-27 16:00:56.971 UTC [1614] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 102.154677] postgres[1614]: RETURNS event_trigger vm-test-run-plv8> server # [ 102.164725] postgres[1614]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 102.165433] postgres[1614]: AS $func$ vm-test-run-plv8> server # [ 102.165760] postgres[1614]: DECLARE vm-test-run-plv8> server # [ 102.166347] postgres[1614]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 102.166605] postgres[1614]: BEGIN vm-test-run-plv8> server # [ 102.167288] postgres[1614]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 102.167758] postgres[1614]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 102.173684] postgres[1614]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 102.174235] postgres[1614]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 102.174548] postgres[1614]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 102.175237] postgres[1614]: ); vm-test-run-plv8> server # [ 102.175980] postgres[1614]: vm-test-run-plv8> server # [ 102.181376] postgres[1614]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 102.182079] postgres[1614]: THEN vm-test-run-plv8> server # [ 102.182376] postgres[1614]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 102.182913] postgres[1614]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 102.183230] postgres[1614]: vm-test-run-plv8> server # [ 102.183708] postgres[1614]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 102.193597] postgres[1614]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 102.194264] postgres[1614]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 102.194879] postgres[1614]: vm-test-run-plv8> server # [ 102.195816] postgres[1614]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 102.201360] postgres[1614]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 102.201929] postgres[1614]: "operationName" text default null, vm-test-run-plv8> server # [ 102.202435] postgres[1614]: query text default null, vm-test-run-plv8> server # [ 102.203313] postgres[1614]: variables jsonb default null, vm-test-run-plv8> server # [ 102.203804] postgres[1614]: extensions jsonb default null vm-test-run-plv8> server # [ 102.210972] postgres[1614]: ) vm-test-run-plv8> server # [ 102.217513] postgres[1614]: returns jsonb vm-test-run-plv8> server # [ 102.218392] postgres[1614]: language sql vm-test-run-plv8> server # [ 102.219576] postgres[1614]: as $$ vm-test-run-plv8> server # [ 102.219935] postgres[1614]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-plv8> server # [ 102.221892] postgres[1614]: $$; vm-test-run-plv8> server # [ 102.222755] postgres[1614]: vm-test-run-plv8> server # [ 102.223121] postgres[1614]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 102.223551] postgres[1614]: END IF; vm-test-run-plv8> server # [ 102.223789] postgres[1614]: vm-test-run-plv8> server # [ 102.228858] postgres[1614]: END; vm-test-run-plv8> server # [ 102.230492] postgres[1614]: $func$; vm-test-run-plv8> server # [ 102.237160] postgres[1614]: ::1 2026-10-27 16:00:56.996 UTC [1614] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-plv8> server # [ 102.238374] postgres[1614]: ::1 2026-10-27 16:00:57.008 UTC [1614] 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 # [ 102.239498] postgres[1614]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-plv8> server # [ 102.239911] postgres[1614]: ::1 2026-10-27 16:00:57.020 UTC [1614] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-plv8> server # [ 102.247683] postgres[1614]: ::1 2026-10-27 16:00:57.041 UTC [1614] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 102.253261] postgres[1614]: RETURNS event_trigger vm-test-run-plv8> server # [ 102.254088] postgres[1614]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 102.254413] postgres[1614]: AS $func$ vm-test-run-plv8> server # [ 102.254667] postgres[1614]: DECLARE vm-test-run-plv8> server # [ 102.255083] postgres[1614]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 102.255339] postgres[1614]: BEGIN vm-test-run-plv8> server # [ 102.255564] postgres[1614]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 102.255797] postgres[1614]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 102.256042] postgres[1614]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 102.264495] postgres[1614]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 102.267058] postgres[1614]: ); vm-test-run-plv8> server # [ 102.267880] postgres[1614]: vm-test-run-plv8> server # [ 102.268241] postgres[1614]: IF graphql_is_dropped vm-test-run-plv8> server # [ 102.268503] postgres[1614]: THEN vm-test-run-plv8> server # [ 102.268763] postgres[1614]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 102.274160] postgres[1614]: "operationName" text default null, vm-test-run-plv8> server # [ 102.276032] postgres[1614]: query text default null, vm-test-run-plv8> server # [ 102.283320] postgres[1614]: variables jsonb default null, vm-test-run-plv8> server # [ 102.283845] postgres[1614]: extensions jsonb default null vm-test-run-plv8> server # [ 102.290651] postgres[1614]: ) vm-test-run-plv8> server # [ 102.293119] postgres[1614]: returns jsonb vm-test-run-plv8> server # [ 102.295407] postgres[1614]: language plpgsql vm-test-run-plv8> server # [ 102.301793] postgres[1614]: as $$ vm-test-run-plv8> server # [ 102.302633] postgres[1614]: DECLARE vm-test-run-plv8> server # [ 102.302949] postgres[1614]: server_version float; vm-test-run-plv8> server # [ 102.303217] postgres[1614]: BEGIN vm-test-run-plv8> server # [ 102.303569] postgres[1614]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 102.310299] postgres[1614]: vm-test-run-plv8> server # [ 102.310843] postgres[1614]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 102.311708] postgres[1614]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 102.318748] postgres[1614]: 'data', null::jsonb, vm-test-run-plv8> server # [ 102.327491] postgres[1614]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 102.334254] postgres[1614]: ); vm-test-run-plv8> server # [ 102.335566] postgres[1614]: ELSE vm-test-run-plv8> server # [ 102.343297] postgres[1614]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 102.349530] postgres[1614]: 'data', null::jsonb, vm-test-run-plv8> server # [ 102.351701] postgres[1614]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 102.363529] postgres[1614]: ); vm-test-run-plv8> server # [ 102.378673] postgres[1614]: END IF; vm-test-run-plv8> server # [ 102.380328] postgres[1614]: END; vm-test-run-plv8> server # [ 102.389308] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: CREATE FUNCTION vm-test-run-plv8> server # [ 102.391948] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: 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 # [ 102.397887] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 102.398540] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 102.399453] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: COMMENT vm-test-run-plv8> server # [ 102.400569] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: CREATE FUNCTION vm-test-run-plv8> server # [ 102.406977] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: 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 # [ 102.416012] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 102.418355] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 102.419877] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1610]: COMMENT vm-test-run-plv8> server # [ 102.425937] postgres[1614]: $$; vm-test-run-plv8> server # [ 102.427670] postgres[1614]: END IF; vm-test-run-plv8> server # [ 102.433987] postgres[1614]: vm-test-run-plv8> server # [ 102.434423] postgres[1614]: END; vm-test-run-plv8> server # [ 102.435064] postgres[1614]: $func$; vm-test-run-plv8> server # [ 102.442211] postgres[1614]: ::1 2026-10-27 16:00:57.097 UTC [1614] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-plv8> server # [ 102.449602] postgres[1614]: ::1 2026-10-27 16:00:57.109 UTC [1614] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-plv8> server # [ 102.451221] postgres[1614]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-plv8> server # [ 102.451680] postgres[1614]: ::1 2026-10-27 16:00:57.124 UTC [1614] 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 # [ 102.466759] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-plv8> server # [ 102.729638] postgres[1624]: ::1 2026-10-27 16:00:57.546 UTC [1624] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 102.743461] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1622]: 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 # [ 102.749614] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1622]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 102.750120] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1622]: 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 # [ 102.751409] postgres[1624]: ::1 2026-10-27 16:00:57.561 UTC [1624] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 102.759583] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1622]: DROP FUNCTION vm-test-run-plv8> server # [ 102.771077] postgres[1624]: ::1 2026-10-27 16:00:57.590 UTC [1624] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 102.771796] postgres[1624]: DECLARE vm-test-run-plv8> server # [ 102.772094] postgres[1624]: cmd record; vm-test-run-plv8> server # [ 102.773695] postgres[1624]: BEGIN vm-test-run-plv8> server # [ 102.774736] postgres[1624]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 102.775412] postgres[1624]: LOOP vm-test-run-plv8> server # [ 102.775740] postgres[1624]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 102.776454] postgres[1624]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 102.781843] postgres[1624]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 102.782756] postgres[1624]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 102.783210] postgres[1624]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 102.783503] postgres[1624]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 102.784277] postgres[1624]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 102.784543] postgres[1624]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 102.791686] postgres[1624]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-plv8> server # [ 102.793309] postgres[1624]: , 'CREATE RULE' vm-test-run-plv8> server # [ 102.793937] postgres[1624]: , 'COMMENT' vm-test-run-plv8> server # [ 102.794234] postgres[1624]: ) vm-test-run-plv8> server # [ 102.794471] postgres[1624]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 102.795267] postgres[1624]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 102.796306] postgres[1624]: THEN vm-test-run-plv8> server # [ 102.796607] postgres[1624]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 102.805352] postgres[1624]: END IF; vm-test-run-plv8> server # [ 102.806802] postgres[1624]: END LOOP; vm-test-run-plv8> server # [ 102.807115] postgres[1624]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 102.841184] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1622]: CREATE FUNCTION vm-test-run-plv8> server # [ 102.842125] postgres[1624]: ::1 2026-10-27 16:00:57.663 UTC [1624] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 102.842757] postgres[1624]: DECLARE vm-test-run-plv8> server # [ 102.843728] postgres[1624]: obj record; vm-test-run-plv8> server # [ 102.844241] postgres[1624]: BEGIN vm-test-run-plv8> server # [ 102.844494] postgres[1624]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 102.849939] postgres[1624]: LOOP vm-test-run-plv8> server # [ 102.851140] postgres[1624]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 102.851592] postgres[1624]: 'schema' vm-test-run-plv8> server # [ 102.861428] postgres[1624]: , 'table' vm-test-run-plv8> server # [ 102.862161] postgres[1624]: , 'foreign table' vm-test-run-plv8> server # [ 102.862837] postgres[1624]: , 'view' vm-test-run-plv8> server # [ 102.873792] postgres[1624]: , 'materialized view' vm-test-run-plv8> server # [ 102.874830] postgres[1624]: , 'function' vm-test-run-plv8> server # [ 102.876788] postgres[1624]: , 'trigger' vm-test-run-plv8> server # [ 102.878733] postgres[1624]: , 'type' vm-test-run-plv8> server # [ 102.879160] postgres[1624]: , 'rule' vm-test-run-plv8> server # [ 102.879825] postgres[1624]: ) vm-test-run-plv8> server # [ 102.881554] postgres[1624]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 102.881976] postgres[1624]: THEN vm-test-run-plv8> server # [ 102.882241] postgres[1624]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 102.882619] postgres[1624]: END IF; vm-test-run-plv8> server # [ 102.882861] postgres[1624]: END LOOP; vm-test-run-plv8> server # [ 102.883081] postgres[1624]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 102.884701] postgres[1624]: ::1 2026-10-27 16:00:57.696 UTC [1624] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 102.886662] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1622]: CREATE FUNCTION vm-test-run-plv8> server # [ 102.895172] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1622]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 102.901142] postgres[1624]: ::1 2026-10-27 16:00:57.722 UTC [1624] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 102.903303] postgres[1624]: ON ddl_command_end vm-test-run-plv8> server # [ 102.903995] postgres[1624]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 102.913661] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1622]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 102.915343] postgres[1624]: ::1 2026-10-27 16:00:57.736 UTC [1624] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 102.922973] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1622]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 102.927884] postgres[1624]: ::1 2026-10-27 16:00:57.750 UTC [1624] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 102.930916] postgres[1624]: ON sql_drop vm-test-run-plv8> server # [ 102.932745] postgres[1624]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 102.936025] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1622]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 102.969195] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-plv8> server # [ 103.365572] postgres[1629]: ::1 2026-10-27 16:00:58.185 UTC [1629] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-plv8> server # [ 103.391798] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1625]: ALTER ROLE vm-test-run-plv8> server # [ 103.440033] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-plv8> server # [ 103.818000] postgres[1632]: ::1 2026-10-27 16:00:58.631 UTC [1632] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 103.819291] postgres[1632]: returns event_trigger vm-test-run-plv8> server # [ 103.826515] postgres[1632]: language plpgsql vm-test-run-plv8> server # [ 103.827110] postgres[1632]: AS $func$ vm-test-run-plv8> server # [ 103.830734] postgres[1632]: DECLARE vm-test-run-plv8> server # [ 103.831169] postgres[1632]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 103.831465] postgres[1632]: BEGIN vm-test-run-plv8> server # [ 103.831704] postgres[1632]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 103.831948] postgres[1632]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 103.832190] postgres[1632]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 103.832440] postgres[1632]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 103.838557] postgres[1632]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 103.851401] postgres[1632]: ); vm-test-run-plv8> server # [ 103.855410] postgres[1632]: vm-test-run-plv8> server # [ 103.859768] postgres[1632]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 103.874402] postgres[1632]: THEN vm-test-run-plv8> server # [ 103.883408] postgres[1632]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 103.884122] postgres[1632]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 103.884492] postgres[1632]: vm-test-run-plv8> server # [ 103.890948] postgres[1632]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 103.892354] postgres[1632]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 103.898427] postgres[1632]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 103.899265] postgres[1632]: vm-test-run-plv8> server # [ 103.899559] postgres[1632]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 103.899867] postgres[1632]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 103.905603] postgres[1632]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 103.917143] postgres[1632]: "operationName" text default null, vm-test-run-plv8> server # [ 103.919835] postgres[1632]: query text default null, vm-test-run-plv8> server # [ 103.922318] postgres[1632]: variables jsonb default null, vm-test-run-plv8> server # [ 103.926813] postgres[1632]: extensions jsonb default null vm-test-run-plv8> server # [ 103.941910] postgres[1632]: ) vm-test-run-plv8> server # [ 103.943900] postgres[1632]: returns jsonb vm-test-run-plv8> server # [ 103.947859] postgres[1632]: language sql vm-test-run-plv8> server # [ 103.953420] postgres[1632]: as $$ vm-test-run-plv8> server # [ 103.957863] postgres[1632]: -- This changed vm-test-run-plv8> server # [ 103.958461] postgres[1632]: select graphql.resolve( vm-test-run-plv8> server # [ 103.958949] postgres[1632]: query := query, vm-test-run-plv8> server # [ 103.959605] postgres[1632]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 103.959944] postgres[1632]: "operationName" := "operationName", vm-test-run-plv8> server # [ 103.960223] postgres[1632]: extensions := extensions vm-test-run-plv8> server # [ 103.967137] postgres[1632]: ); vm-test-run-plv8> server # [ 103.975056] postgres[1632]: $$; vm-test-run-plv8> server # [ 103.982067] postgres[1632]: vm-test-run-plv8> server # [ 103.983274] postgres[1632]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 103.983699] postgres[1632]: END IF; vm-test-run-plv8> server # [ 103.983964] postgres[1632]: vm-test-run-plv8> server # [ 103.984207] postgres[1632]: END; vm-test-run-plv8> server # [ 103.984407] postgres[1632]: $func$; vm-test-run-plv8> server # [ 103.985986] postgres[1632]: ::1 2026-10-27 16:00:58.780 UTC [1632] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 103.990108] postgres[1632]: RETURNS event_trigger vm-test-run-plv8> server # [ 103.990532] postgres[1632]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 103.991006] postgres[1632]: AS $func$ vm-test-run-plv8> server # [ 103.991491] postgres[1632]: DECLARE vm-test-run-plv8> server # [ 103.991752] postgres[1632]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 103.992240] postgres[1632]: BEGIN vm-test-run-plv8> server # [ 103.992512] postgres[1632]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 103.998017] postgres[1632]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 104.003708] postgres[1632]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 104.006058] postgres[1632]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 104.006771] postgres[1632]: ); vm-test-run-plv8> server # [ 104.007042] postgres[1632]: vm-test-run-plv8> server # [ 104.008116] postgres[1632]: IF graphql_is_dropped vm-test-run-plv8> server # [ 104.009167] postgres[1632]: THEN vm-test-run-plv8> server # [ 104.009464] postgres[1632]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 104.011208] postgres[1632]: "operationName" text default null, vm-test-run-plv8> server # [ 104.012151] postgres[1632]: query text default null, vm-test-run-plv8> server # [ 104.012463] postgres[1632]: variables jsonb default null, vm-test-run-plv8> server # [ 104.013281] postgres[1632]: extensions jsonb default null vm-test-run-plv8> server # [ 104.014951] postgres[1632]: ) vm-test-run-plv8> server # [ 104.015775] postgres[1632]: returns jsonb vm-test-run-plv8> server # [ 104.017526] postgres[1632]: language plpgsql vm-test-run-plv8> server # [ 104.017860] postgres[1632]: as $$ vm-test-run-plv8> server # [ 104.018527] postgres[1632]: DECLARE vm-test-run-plv8> server # [ 104.018999] postgres[1632]: server_version float; vm-test-run-plv8> server # [ 104.019300] postgres[1632]: BEGIN vm-test-run-plv8> server # [ 104.019529] postgres[1632]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 104.019978] postgres[1632]: vm-test-run-plv8> server # [ 104.022074] postgres[1632]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 104.022810] postgres[1632]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 104.024982] postgres[1632]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 104.025430] postgres[1632]: jsonb_build_object( vm-test-run-plv8> server # [ 104.025743] postgres[1632]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 104.026638] postgres[1632]: ) vm-test-run-plv8> server # [ 104.027124] postgres[1632]: ) vm-test-run-plv8> server # [ 104.027405] postgres[1632]: ); vm-test-run-plv8> server # [ 104.028117] postgres[1632]: ELSE vm-test-run-plv8> server # [ 104.030761] postgres[1632]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 104.033323] postgres[1632]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 104.034009] postgres[1632]: jsonb_build_object( vm-test-run-plv8> server # [ 104.034480] postgres[1632]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 104.037775] postgres[1632]: ) vm-test-run-plv8> server # [ 104.038216] postgres[1632]: ) vm-test-run-plv8> server # [ 104.040051] postgres[1632]: ); vm-test-run-plv8> server # [ 104.040426] postgres[1632]: END IF; vm-test-run-plv8> server # [ 104.041312] postgres[1632]: END; vm-test-run-plv8> server # [ 104.041769] postgres[1632]: $$; vm-test-run-plv8> server # [ 104.042013] postgres[1632]: END IF; vm-test-run-plv8> server # [ 104.042263] postgres[1632]: vm-test-run-plv8> server # [ 104.042489] postgres[1632]: END; vm-test-run-plv8> server # [ 104.043823] postgres[1632]: $func$; vm-test-run-plv8> server # [ 104.044711] postgres[1632]: ::1 2026-10-27 16:00:58.805 UTC [1632] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 104.046552] postgres[1632]: "operationName" text default null, vm-test-run-plv8> server # [ 104.047460] postgres[1632]: query text default null, vm-test-run-plv8> server # [ 104.048457] postgres[1632]: variables jsonb default null, vm-test-run-plv8> server # [ 104.055467] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1631]: CREATE FUNCTION vm-test-run-plv8> server # [ 104.058328] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1631]: CREATE FUNCTION vm-test-run-plv8> server # [ 104.059101] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1631]: CREATE FUNCTION vm-test-run-plv8> server # [ 104.060266] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1631]: 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 # [ 104.062432] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1631]: DROP EXTENSION vm-test-run-plv8> server # [ 104.065209] postgres[1632]: extensions jsonb default null vm-test-run-plv8> server # [ 104.066471] postgres[1632]: ) vm-test-run-plv8> server # [ 104.067276] postgres[1632]: returns jsonb vm-test-run-plv8> server # [ 104.069146] postgres[1632]: language plpgsql vm-test-run-plv8> server # [ 104.069470] postgres[1632]: as $$ vm-test-run-plv8> server # [ 104.071800] postgres[1632]: DECLARE vm-test-run-plv8> server # [ 104.073063] postgres[1632]: server_version float; vm-test-run-plv8> server # [ 104.074159] postgres[1632]: BEGIN vm-test-run-plv8> server # [ 104.074818] postgres[1632]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 104.075327] postgres[1632]: vm-test-run-plv8> server # [ 104.075775] postgres[1632]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 104.076035] postgres[1632]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 104.077837] postgres[1632]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 104.079274] postgres[1632]: jsonb_build_object( vm-test-run-plv8> server # [ 104.081726] postgres[1632]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 104.083796] postgres[1632]: ) vm-test-run-plv8> server # [ 104.085325] postgres[1632]: ) vm-test-run-plv8> server # [ 104.085687] postgres[1632]: ); vm-test-run-plv8> server # [ 104.086687] postgres[1632]: ELSE vm-test-run-plv8> server # [ 104.087368] postgres[1632]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 104.088227] postgres[1632]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 104.089474] postgres[1632]: jsonb_build_object( vm-test-run-plv8> server # [ 104.089774] postgres[1632]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 104.091625] postgres[1632]: ) vm-test-run-plv8> server # [ 104.093461] postgres[1632]: ) vm-test-run-plv8> server # [ 104.093889] postgres[1632]: ); vm-test-run-plv8> server # [ 104.094147] postgres[1632]: END IF; vm-test-run-plv8> server # [ 104.094614] postgres[1632]: END; vm-test-run-plv8> server # [ 104.094897] postgres[1632]: $$; vm-test-run-plv8> server # [ 104.096523] postgres[1632]: ::1 2026-10-27 16:00:58.828 UTC [1632] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 106.054315] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1631]: DO vm-test-run-plv8> server # [ 106.098434] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: 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 # [ 106.419568] postgres[1658]: ::1 2026-10-27 16:01:01.236 UTC [1658] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-plv8> server # [ 106.476159] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1657]: GRANT ROLE vm-test-run-plv8> server # [ 106.487794] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-plv8> server # [ 106.740317] postgres[1660]: ::1 2026-10-27 16:01:01.556 UTC [1660] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 106.745900] postgres[1660]: returns event_trigger vm-test-run-plv8> server # [ 106.746290] postgres[1660]: language plpgsql vm-test-run-plv8> server # [ 106.746610] postgres[1660]: AS $func$ vm-test-run-plv8> server # [ 106.746851] postgres[1660]: DECLARE vm-test-run-plv8> server # [ 106.747068] postgres[1660]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 106.747318] postgres[1660]: BEGIN vm-test-run-plv8> server # [ 106.747536] postgres[1660]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 106.751006] postgres[1660]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 106.751546] postgres[1660]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 106.752188] postgres[1660]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 106.753202] postgres[1660]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 106.753677] postgres[1660]: ); vm-test-run-plv8> server # [ 106.753942] postgres[1660]: vm-test-run-plv8> server # [ 106.754494] postgres[1660]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 106.754854] postgres[1660]: THEN vm-test-run-plv8> server # [ 106.755110] postgres[1660]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 106.755589] postgres[1660]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 106.755923] postgres[1660]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 106.756887] postgres[1660]: "operationName" text default null, vm-test-run-plv8> server # [ 106.758222] postgres[1660]: query text default null, vm-test-run-plv8> server # [ 106.758599] postgres[1660]: variables jsonb default null, vm-test-run-plv8> server # [ 106.758945] postgres[1660]: extensions jsonb default null vm-test-run-plv8> server # [ 106.759208] postgres[1660]: ) vm-test-run-plv8> server # [ 106.759637] postgres[1660]: returns jsonb vm-test-run-plv8> server # [ 106.762415] postgres[1660]: language sql vm-test-run-plv8> server # [ 106.762876] postgres[1660]: as $$ vm-test-run-plv8> server # [ 106.763209] postgres[1660]: select graphql.resolve( vm-test-run-plv8> server # [ 106.763475] postgres[1660]: query := query, vm-test-run-plv8> server # [ 106.763749] postgres[1660]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 106.764049] postgres[1660]: "operationName" := "operationName", vm-test-run-plv8> server # [ 106.764620] postgres[1660]: extensions := extensions vm-test-run-plv8> server # [ 106.765688] postgres[1660]: ); vm-test-run-plv8> server # [ 106.766742] postgres[1660]: $$; vm-test-run-plv8> server # [ 106.767459] postgres[1660]: vm-test-run-plv8> server # [ 106.767861] postgres[1660]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 106.768536] postgres[1660]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 106.769157] postgres[1660]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 106.769682] postgres[1660]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 106.770106] postgres[1660]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 106.770913] postgres[1660]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 106.771418] postgres[1660]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 106.771942] postgres[1660]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 106.773546] postgres[1660]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 106.774371] postgres[1660]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 106.776091] postgres[1660]: END IF; vm-test-run-plv8> server # [ 106.778219] postgres[1660]: vm-test-run-plv8> server # [ 106.779197] postgres[1660]: END; vm-test-run-plv8> server # [ 106.781746] postgres[1660]: $func$; vm-test-run-plv8> server # [ 106.825798] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1659]: CREATE FUNCTION vm-test-run-plv8> server # [ 106.831110] postgres[1660]: ::1 2026-10-27 16:01:01.648 UTC [1660] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 106.870727] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1659]: DROP EXTENSION vm-test-run-plv8> server # [ 108.943614] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1659]: DO vm-test-run-plv8> server # [ 108.978569] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-plv8> server # [ 110.163087] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1685]: DO vm-test-run-plv8> server # [ 110.779621] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1685]: DO vm-test-run-plv8> server # [ 110.845781] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-plv8> server # [ 111.298482] postgres[1699]: ::1 2026-10-27 16:01:06.113 UTC [1699] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-plv8> server # [ 111.327039] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1691]: ALTER ROLE vm-test-run-plv8> server # [ 111.354708] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-plv8> server # [ 111.947824] postgres[1707]: ::1 2026-10-27 16:01:06.757 UTC [1707] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-plv8> server # [ 111.991108] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1704]: REVOKE ROLE vm-test-run-plv8> server # [ 112.011062] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-plv8> server # [ 114.530837] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1712]: DO vm-test-run-plv8> server # [ 114.586645] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-plv8> server # [ 115.066546] postgres[1738]: ::1 2026-10-27 16:01:09.878 UTC [1738] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-plv8> server # [ 115.135557] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1732]: GRANT ROLE vm-test-run-plv8> server # [ 115.198952] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-plv8> server # [ 115.605667] postgres[1750]: ::1 2026-10-27 16:01:10.420 UTC [1750] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 115.677882] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1746]: GRANT vm-test-run-plv8> server # [ 115.684604] postgres[1750]: ::1 2026-10-27 16:01:10.485 UTC [1750] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 115.718466] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1746]: GRANT vm-test-run-plv8> server # [ 115.727732] postgres[1750]: ::1 2026-10-27 16:01:10.550 UTC [1750] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 115.739939] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1746]: GRANT vm-test-run-plv8> server # [ 115.745487] postgres[1750]: ::1 2026-10-27 16:01:10.565 UTC [1750] 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 # [ 115.761771] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1746]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 115.773328] postgres[1750]: ::1 2026-10-27 16:01:10.584 UTC [1750] 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 # [ 115.793017] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1746]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 115.802393] postgres[1750]: ::1 2026-10-27 16:01:10.622 UTC [1750] 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 # [ 115.823047] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1746]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 115.923374] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-plv8> server # [ 116.261842] postgres[1754]: ::1 2026-10-27 16:01:11.072 UTC [1754] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-plv8> server # [ 116.303098] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1753]: GRANT ROLE vm-test-run-plv8> server # [ 116.311005] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 116.583786] postgres[1756]: ::1 2026-10-27 16:01:11.404 UTC [1756] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-plv8> server # [ 116.602119] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1755]: GRANT ROLE vm-test-run-plv8> server # [ 116.633759] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-plv8> server # [ 116.887489] postgres[1758]: ::1 2026-10-27 16:01:11.708 UTC [1758] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-plv8> server # [ 116.903163] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1757]: ALTER ROLE vm-test-run-plv8> server # [ 116.906774] postgres[1758]: ::1 2026-10-27 16:01:11.723 UTC [1758] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-plv8> server # [ 116.911418] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1757]: ALTER ROLE vm-test-run-plv8> server # [ 116.917139] postgres[1758]: ::1 2026-10-27 16:01:11.740 UTC [1758] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-plv8> server # [ 116.921596] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1757]: ALTER ROLE vm-test-run-plv8> server # [ 116.945672] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1757]: DO vm-test-run-plv8> server # [ 116.979742] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 117.394664] postgres[1763]: ::1 2026-10-27 16:01:12.205 UTC [1763] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-plv8> server # [ 117.412981] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1759]: GRANT ROLE vm-test-run-plv8> server # [ 117.414927] postgres[1763]: ::1 2026-10-27 16:01:12.236 UTC [1763] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-plv8> server # [ 117.441106] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1759]: REVOKE ROLE vm-test-run-plv8> server # [ 117.472899] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-plv8> server # [ 118.113749] postgres[1770]: ::1 2026-10-27 16:01:12.899 UTC [1770] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 118.126980] postgres[1770]: returns event_trigger vm-test-run-plv8> server # [ 118.135249] postgres[1770]: language plpgsql vm-test-run-plv8> server # [ 118.157475] postgres[1770]: AS $func$ vm-test-run-plv8> server # [ 118.165675] postgres[1770]: DECLARE vm-test-run-plv8> server # [ 118.167626] postgres[1770]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 118.176778] postgres[1770]: BEGIN vm-test-run-plv8> server # [ 118.180003] postgres[1770]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 118.185279] postgres[1770]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 118.187514] postgres[1770]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 118.194397] postgres[1770]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 118.196308] postgres[1770]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 118.202082] postgres[1770]: ); vm-test-run-plv8> server # [ 118.202871] postgres[1770]: vm-test-run-plv8> server # [ 118.203151] postgres[1770]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 118.204046] postgres[1770]: THEN vm-test-run-plv8> server # [ 118.214243] postgres[1770]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 118.216353] postgres[1770]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 118.230396] postgres[1770]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 118.231837] postgres[1770]: "operationName" text default null, vm-test-run-plv8> server # [ 118.234000] postgres[1770]: query text default null, vm-test-run-plv8> server # [ 118.234401] postgres[1770]: variables jsonb default null, vm-test-run-plv8> server # [ 118.234989] postgres[1770]: extensions jsonb default null vm-test-run-plv8> server # [ 118.235774] postgres[1770]: ) vm-test-run-plv8> server # [ 118.236910] postgres[1770]: returns jsonb vm-test-run-plv8> server # [ 118.238188] postgres[1770]: language sql vm-test-run-plv8> server # [ 118.238758] postgres[1770]: as $$ vm-test-run-plv8> server # [ 118.239098] postgres[1770]: select graphql.resolve( vm-test-run-plv8> server # [ 118.239881] postgres[1770]: query := query, vm-test-run-plv8> server # [ 118.241585] postgres[1770]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 118.247160] postgres[1770]: "operationName" := "operationName", vm-test-run-plv8> server # [ 118.249346] postgres[1770]: extensions := extensions vm-test-run-plv8> server # [ 118.249838] postgres[1770]: ); vm-test-run-plv8> server # [ 118.250130] postgres[1770]: $$; vm-test-run-plv8> server # [ 118.251077] postgres[1770]: vm-test-run-plv8> server # [ 118.251515] postgres[1770]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 118.251828] postgres[1770]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 118.252778] postgres[1770]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 118.253952] postgres[1770]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.254272] postgres[1770]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.254749] postgres[1770]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.255114] postgres[1770]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.255836] postgres[1770]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.257897] postgres[1770]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.258898] postgres[1770]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.259824] postgres[1770]: vm-test-run-plv8> server # [ 118.264677] postgres[1770]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-plv8> server # [ 118.266211] postgres[1770]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-plv8> server # [ 118.266948] postgres[1770]: grant usage on schema graphql to postgres with grant option; vm-test-run-plv8> server # [ 118.269222] postgres[1770]: END IF; vm-test-run-plv8> server # [ 118.269609] postgres[1770]: vm-test-run-plv8> server # [ 118.269973] postgres[1770]: END; vm-test-run-plv8> server # [ 118.270842] postgres[1770]: $func$; vm-test-run-plv8> server # [ 118.271889] postgres[1770]: ::1 2026-10-27 16:01:13.094 UTC [1770] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 118.279605] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1765]: CREATE FUNCTION vm-test-run-plv8> server # [ 118.393788] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1765]: DROP EXTENSION vm-test-run-plv8> server # [ 120.146424] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1765]: DO vm-test-run-plv8> server # [ 120.171918] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-plv8> server # [ 120.440118] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1791]: DO vm-test-run-plv8> server # [ 120.455096] postgres[1792]: ::1 2026-10-27 16:01:15.264 UTC [1792] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-plv8> server # [ 120.457498] postgres[1792]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 120.459040] postgres[1792]: AS $$ vm-test-run-plv8> server # [ 120.460035] postgres[1792]: BEGIN vm-test-run-plv8> server # [ 120.461456] postgres[1792]: IF EXISTS ( vm-test-run-plv8> server # [ 120.463414] postgres[1792]: SELECT vm-test-run-plv8> server # [ 120.466217] postgres[1792]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 120.466824] postgres[1792]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 120.467129] postgres[1792]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 120.469570] postgres[1792]: WHERE ext.extname = 'pg_cron' vm-test-run-plv8> server # [ 120.470389] postgres[1792]: ) vm-test-run-plv8> server # [ 120.471249] postgres[1792]: THEN vm-test-run-plv8> server # [ 120.471743] postgres[1792]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 120.472351] postgres[1792]: vm-test-run-plv8> server # [ 120.474570] postgres[1792]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 120.475751] postgres[1792]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 120.477667] postgres[1792]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 120.478845] postgres[1792]: vm-test-run-plv8> server # [ 120.479745] postgres[1792]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 120.481755] postgres[1792]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 120.482373] postgres[1792]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 120.485747] postgres[1792]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 120.487265] postgres[1792]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 120.490090] postgres[1792]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 120.491637] postgres[1792]: vm-test-run-plv8> server # [ 120.491942] postgres[1792]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 120.493747] postgres[1792]: revoke all on table cron.job from postgres; vm-test-run-plv8> server # [ 120.494703] postgres[1792]: grant select on table cron.job to postgres with grant option; vm-test-run-plv8> server # [ 120.495975] postgres[1792]: END IF; vm-test-run-plv8> server # [ 120.497386] postgres[1792]: END; vm-test-run-plv8> server # [ 120.498035] postgres[1792]: $$; vm-test-run-plv8> server # [ 120.524666] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1791]: CREATE FUNCTION vm-test-run-plv8> server # [ 120.530626] postgres[1792]: ::1 2026-10-27 16:01:15.350 UTC [1792] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-plv8> server # [ 120.537904] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1791]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 120.541368] postgres[1792]: ::1 2026-10-27 16:01:15.365 UTC [1792] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-plv8> server # [ 120.555240] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1791]: ALTER FUNCTION vm-test-run-plv8> server # [ 120.560589] postgres[1792]: ::1 2026-10-27 16:01:15.380 UTC [1792] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-plv8> server # [ 120.562551] postgres[1792]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-plv8> server # [ 120.565922] postgres[1792]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 120.569680] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1791]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 120.625711] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-plv8> server # [ 120.991596] postgres[1795]: ::1 2026-10-27 16:01:15.811 UTC [1795] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-plv8> server # [ 121.033293] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1793]: ALTER ROLE vm-test-run-plv8> server # [ 121.077167] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-plv8> server # [ 121.514430] postgres[1811]: ::1 2026-10-27 16:01:16.320 UTC [1811] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-plv8> server # [ 121.595770] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1804]: ALTER FUNCTION vm-test-run-plv8> server # [ 121.598600] postgres[1811]: ::1 2026-10-27 16:01:16.404 UTC [1811] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-plv8> server # [ 121.610357] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1804]: ALTER FUNCTION vm-test-run-plv8> server # [ 121.620614] postgres[1811]: ::1 2026-10-27 16:01:16.439 UTC [1811] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-plv8> server # [ 121.630086] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1804]: ALTER FUNCTION vm-test-run-plv8> server # [ 121.672388] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-plv8> server # [ 122.187265] postgres[1819]: ::1 2026-10-27 16:01:17.002 UTC [1819] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-plv8> server # [ 122.241281] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1813]: GRANT ROLE vm-test-run-plv8> server # [ 122.274059] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-plv8> server # [ 123.284280] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1822]: DO vm-test-run-plv8> server # [ 123.370725] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-plv8> server # [ 123.796059] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1828]: DO vm-test-run-plv8> server # [ 123.798897] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1828]: DO vm-test-run-plv8> server # [ 123.836629] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-plv8> server # [ 124.258486] postgres[1832]: ::1 2026-10-27 16:01:19.065 UTC [1832] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-plv8> server # [ 124.275852] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1831]: ALTER ROLE vm-test-run-plv8> server # [ 124.282456] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1831]: ALTER ROLE vm-test-run-plv8> server # [ 124.293840] postgres[1832]: ::1 2026-10-27 16:01:19.100 UTC [1832] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-plv8> server # [ 124.295705] postgres[1832]: ::1 2026-10-27 16:01:19.110 UTC [1832] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-plv8> server # [ 124.304083] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1831]: ALTER ROLE vm-test-run-plv8> server # [ 124.366331] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-plv8> server # [ 124.893833] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1837]: DO vm-test-run-plv8> server # [ 124.917222] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-plv8> server # [ 125.525438] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1850]: DO vm-test-run-plv8> server # [ 125.592136] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-plv8> server # [ 126.061875] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1861]: CREATE FUNCTION vm-test-run-plv8> server # [ 126.070771] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1861]: DO vm-test-run-plv8> server # [ 126.118820] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-plv8> server # [ 126.402709] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1863]: ALTER FUNCTION vm-test-run-plv8> server # [ 126.409770] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1863]: GRANT vm-test-run-plv8> server # [ 126.457518] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-plv8> server # [ 126.721284] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1865]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 126.751379] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1865]: ALTER FUNCTION vm-test-run-plv8> server # [ 126.772832] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1865]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 126.836632] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 127.302131] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1867]: DO vm-test-run-plv8> server # [ 127.338005] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-plv8> server # [ 127.958622] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1877]: CREATE FUNCTION vm-test-run-plv8> server # [ 127.984203] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1877]: GRANT vm-test-run-plv8> server # [ 128.019569] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-plv8> server # [ 128.498655] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1885]: REVOKE ROLE vm-test-run-plv8> server # [ 128.557053] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1885]: DO vm-test-run-plv8> server # [ 128.610147] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1885]: DO vm-test-run-plv8> server # [ 128.621939] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1885]: REVOKE ROLE vm-test-run-plv8> server # [ 128.653048] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1885]: REVOKE vm-test-run-plv8> server # [ 128.698257] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1885]: DO vm-test-run-plv8> server # [ 128.750657] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 129.158045] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1897]: DO vm-test-run-plv8> server # [ 129.230526] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 129.635742] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1903]: DO vm-test-run-plv8> server # [ 129.686696] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 130.048774] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1905]: DO vm-test-run-plv8> server # [ 130.082679] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-plv8> server # [ 130.453279] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1907]: ALTER ROLE vm-test-run-plv8> server # [ 130.469537] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-plv8> server # [ 130.953442] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1909]: GRANT ROLE vm-test-run-plv8> server # [ 130.967205] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1909]: DO vm-test-run-plv8> server # [ 131.025512] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-plv8> server # [ 131.695194] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1922]: GRANT vm-test-run-plv8> server # [ 131.763207] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-plv8> server # [ 132.255661] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1933]: CREATE FUNCTION vm-test-run-plv8> server # [ 132.266675] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1933]: REVOKE vm-test-run-plv8> server # [ 132.274934] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1933]: REVOKE vm-test-run-plv8> server # [ 132.287511] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1933]: GRANT vm-test-run-plv8> server # [ 132.330067] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-plv8> server # [ 132.663519] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1939]: DO vm-test-run-plv8> server # [ 132.705533] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-plv8> server # [ 133.123908] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1941]: ALTER ROLE vm-test-run-plv8> server # [ 133.168664] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-plv8> server # [ 133.761969] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1947]: DROP EXTENSION vm-test-run-plv8> server # [ 133.802959] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-plv8> server # [ 134.303335] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1949]: CREATE FUNCTION vm-test-run-plv8> server # [ 134.341847] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1949]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 134.352889] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1949]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 134.425257] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-plv8> server # [ 134.909530] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1961]: DO vm-test-run-plv8> server # [ 134.965815] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1961]: CREATE FUNCTION vm-test-run-plv8> server # [ 135.024834] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-plv8> server # [ 135.599407] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1974]: CREATE FUNCTION vm-test-run-plv8> server # [ 135.620274] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1974]: CREATE FUNCTION vm-test-run-plv8> server # [ 135.703660] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql vm-test-run-plv8> server # [ 136.071937] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1979]: CREATE FUNCTION vm-test-run-plv8> server # [ 136.084153] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1979]: CREATE FUNCTION vm-test-run-plv8> server # [ 136.099342] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1979]: CREATE FUNCTION vm-test-run-plv8> server # [ 136.114815] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1979]: CREATE FUNCTION vm-test-run-plv8> server # [ 136.131939] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1979]: CREATE FUNCTION vm-test-run-plv8> server # [ 136.157381] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1979]: CREATE FUNCTION vm-test-run-plv8> server # [ 136.205291] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Running postgresql schema... vm-test-run-plv8> server # [ 136.481059] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER DATABASE vm-test-run-plv8> server # [ 136.488744] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER DATABASE vm-test-run-plv8> server # [ 136.548343] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER ROLE vm-test-run-plv8> server # [ 136.602291] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER ROLE vm-test-run-plv8> server # [ 136.666411] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER ROLE vm-test-run-plv8> server # [ 136.721956] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER ROLE vm-test-run-plv8> server # [ 136.787832] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER ROLE vm-test-run-plv8> server # [ 136.857275] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER ROLE vm-test-run-plv8> server # [ 136.922441] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER ROLE vm-test-run-plv8> server # [ 137.041843] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER ROLE vm-test-run-plv8> server # [ 137.137282] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER ROLE vm-test-run-plv8> server # [ 137.156111] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1981]: ALTER ROLE vm-test-run-plv8> server # [ 137.235862] vb2bcqn0kw9gdsg31y0clw0z0144kzs4-supabase-db-init[1419]: Database initialization complete vm-test-run-plv8> server # [ 137.276250] systemd[1]: Finished Supabase Database Initialization. vm-test-run-plv8> server # [ 137.291410] systemd[1]: Reached target Multi-User System. vm-test-run-plv8> server # [ 137.318329] systemd[1]: Startup finished in 10.698s (kernel) + 2min 6.600s (userspace) = 2min 17.298s. vm-test-run-plv8> server: (finished: waiting for unit supabase-db-init.service, in 138.83 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.72 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 7.65 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.78 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.22 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.85 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.88 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 # [ 161.941444] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 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 6.46 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.53 seconds) vm-test-run-plv8> (finished: subtest: Check upgrade path with postgresql 15, in 25.91 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.48 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.98 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.42 seconds) vm-test-run-plv8> (finished: subtest: Check the install of the last version of the extension, in 2.88 seconds) vm-test-run-plv8> (finished: run the VM test script, in 167.73 seconds) vm-test-run-plv8> test script finished in 168.11s 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