these 20 derivations will be built: /nix/store/hv0sb2szywffg7qj9v33lryy92s26iz7-postgresql-and-plugins-15.19.drv /nix/store/bk21q56qzj1p3isa55k6d5gmqzq2fvq9-system-path.drv /nix/store/1v4hxagpka8vhr7wiizhgj28k7q39bz4-dbus-1.drv /nix/store/yiczv17ka9y6fkz66q9zj41jyivm2xj6-X-Restart-Triggers-dbus.drv /nix/store/8ncd8wz1vzhzawpzr3fp01z2anbgd46m-unit-dbus.service.drv /nix/store/anwa4103blmkmd2lncq0q1zyb1l8hqmz-user-units.drv /nix/store/k9vvf6wiwcmcly10zrr88y6f7xlnkygl-unit-dbus.service.drv /nix/store/q2gfn9ik82353j8jk0j9rl94n32d8xqy-postgresql-init.drv /nix/store/nk2filaxd24dpf12sv19gl5xglp4l7ya-unit-postgresql.service.drv /nix/store/8r0ndx8dk6sksyrq24kjxqjgdack812m-supabase-db-init.drv /nix/store/ydhjygv47kzcnyc8qym1hjfn47aan21b-unit-supabase-db-init.service.drv /nix/store/kb5imh7mfbkhz7zmhbkf6z82hwz0gi73-system-units.drv /nix/store/nnf7pgkxkpvb3gcs5rg8xs8fb5nixn5q-etc.drv /nix/store/8a2d5flhd29vwjxg802maql295mm0nl9-activate.drv /nix/store/853wmjsz48d7rdr6i57v4634b4b9301d-nixos-system-server-test.drv /nix/store/fgsnmcvab1z1x5y6nx7a1bx68min76vj-closure-info.drv /nix/store/a261d58c8yxvg3q6bhgf77rvaxbax7z8-run-nixos-vm.drv /nix/store/iz65kb4593a9d1xvy32aydhll38x0rf6-nixos-vm.drv /nix/store/sx3vy0072wvl9nxi2v0z498sxbb69273-nixos-test-driver-plv8.drv /nix/store/9j65d6jak4fxsq5q5582gxswdzg96xln-vm-test-run-plv8.drv this path will be fetched (14.8 KiB download, 60.2 KiB unpacked): /nix/store/n5g67yym9axjp2dgz067ipsbbv597cil-processed-postgresql-config-15 building '/nix/store/sx3vy0072wvl9nxi2v0z498sxbb69273-nixos-test-driver-plv8.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/sx3vy0072wvl9nxi2v0z498sxbb69273-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/9j65d6jak4fxsq5q5582gxswdzg96xln-vm-test-run-plv8.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/9j65d6jak4fxsq5q5582gxswdzg96xln-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 # Disk image does not exist, creating the virtualisation disk image... vm-test-run-plv8> server # Formatting '/build/vm-state-server/tmp.WsTQKvgGSG', 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: 6cfd0a68-215b-4410-bd2a-9fc2360498b2 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: QEMU running (pid 9) vm-test-run-plv8> (finished: start all VMs, in 0.12 seconds) vm-test-run-plv8> server: waiting for unit supabase-db-init.service vm-test-run-plv8> server: waiting for the VM to finish booting vm-test-run-plv8> server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510] vm-test-run-plv8> server # [ 0.000000] Linux version 6.12.63 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP Thu Dec 18 12:55:23 UTC 2025 vm-test-run-plv8> server # [ 0.000000] KASLR enabled vm-test-run-plv8> server # [ 0.000000] random: crng init done vm-test-run-plv8> server # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-plv8> server # [ 0.000000] efi: UEFI not found. vm-test-run-plv8> server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-plv8> server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f602200-0x13f60593f] vm-test-run-plv8> server # [ 0.000000] Zone ranges: vm-test-run-plv8> server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] vm-test-run-plv8> server # [ 0.000000] DMA32 empty vm-test-run-plv8> server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] Device empty vm-test-run-plv8> server # [ 0.000000] Movable zone start for each node vm-test-run-plv8> server # [ 0.000000] Early memory node ranges vm-test-run-plv8> server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -1 vm-test-run-plv8> server # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-plv8> server # [ 0.000000] psci: PSCIv1.1 detected in firmware. vm-test-run-plv8> server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-plv8> server # [ 0.000000] psci: Trusted OS migration not required vm-test-run-plv8> server # [ 0.000000] psci: SMC Calling Convention v1.0 vm-test-run-plv8> server # [ 0.000000] percpu: Embedded 88 pages/cpu s180056 r65536 d114856 u360448 vm-test-run-plv8> server # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-plv8> server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm) vm-test-run-plv8> server # [ 0.000000] CPU features: detected: GIC system register CPU interface vm-test-run-plv8> server # [ 0.000000] CPU features: detected: HCRX_EL2 register vm-test-run-plv8> server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2) vm-test-run-plv8> server # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-plv8> server # [ 0.000000] alternatives: applying boot alternatives vm-test-run-plv8> server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/57w96jz7w56x88k89p4mymabz9k16d4s-nixos-system-server-test/init regInfo=/nix/store/1fzx5r0jrn21wkh8a10gds4c0abw1nha-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-plv8> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/1fzx5r0jrn21wkh8a10gds4c0abw1nha-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.000034] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-plv8> server # [ 0.003118] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-plv8> server # [ 0.012620] Console: colour dummy device 80x25 vm-test-run-plv8> server # [ 0.013887] printk: legacy console [tty0] enabled vm-test-run-plv8> server # [ 0.018900] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-plv8> server # [ 0.019258] pid_max: default: 32768 minimum: 301 vm-test-run-plv8> server # [ 0.021344] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-plv8> server # [ 0.022918] landlock: Up and running. vm-test-run-plv8> server # [ 0.022967] Yama: becoming mindful. vm-test-run-plv8> server # [ 0.026288] LSM support for eBPF active vm-test-run-plv8> server # [ 0.029510] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.029647] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.055387] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-plv8> server # [ 0.065944] rcu: Hierarchical SRCU implementation. vm-test-run-plv8> server # [ 0.066114] rcu: Max phase no-delay instances is 1000. vm-test-run-plv8> server # [ 0.067390] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-plv8> server # [ 0.073576] fsl-mc MSI: its@8080000 domain created vm-test-run-plv8> server # [ 0.075250] EFI services will not be available. vm-test-run-plv8> server # [ 0.077606] smp: Bringing up secondary CPUs ... vm-test-run-plv8> server # [ 0.081725] Detected PIPT I-cache on CPU1 vm-test-run-plv8> server # [ 0.082806] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-plv8> server # [ 0.083405] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000 vm-test-run-plv8> server # [ 0.084993] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-plv8> server # [ 0.088158] smp: Brought up 1 node, 2 CPUs vm-test-run-plv8> server # [ 0.088380] SMP: Total of 2 processors activated. vm-test-run-plv8> server # [ 0.088420] CPU: All CPU(s) started at EL1 vm-test-run-plv8> server # [ 0.088581] CPU features: detected: Branch Target Identification vm-test-run-plv8> server # [ 0.088629] CPU features: detected: 32-bit EL0 Support vm-test-run-plv8> server # [ 0.088656] CPU features: detected: 32-bit EL1 Support vm-test-run-plv8> server # [ 0.088678] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-plv8> server # [ 0.088709] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-plv8> server # [ 0.088741] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-plv8> server # [ 0.088796] CPU features: detected: Common not Private translations vm-test-run-plv8> server # [ 0.088816] CPU features: detected: CRC32 instructions vm-test-run-plv8> server # [ 0.088836] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-plv8> server # [ 0.088865] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-plv8> server # [ 0.088890] CPU features: detected: Data independent timing control (DIT) vm-test-run-plv8> server # [ 0.088915] CPU features: detected: E0PD vm-test-run-plv8> server # [ 0.088934] CPU features: detected: Enhanced Counter Virtualization vm-test-run-plv8> server # [ 0.088957] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-plv8> server # [ 0.088981] CPU features: detected: Enhanced Privileged Access Never vm-test-run-plv8> server # [ 0.089065] CPU features: detected: Enhanced Virtualization Traps vm-test-run-plv8> server # [ 0.089175] CPU features: detected: Fine Grained Traps vm-test-run-plv8> server # [ 0.089228] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-plv8> server # [ 0.089316] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-plv8> server # [ 0.089364] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-plv8> server # [ 0.089391] CPU features: detected: LSE atomic instructions vm-test-run-plv8> server # [ 0.089415] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-plv8> server # [ 0.089442] CPU features: detected: Privileged Access Never vm-test-run-plv8> server # [ 0.089465] CPU features: detected: RAS Extension Support vm-test-run-plv8> server # [ 0.089487] CPU features: detected: Random Number Generator vm-test-run-plv8> server # [ 0.089508] CPU features: detected: Speculation barrier (SB) vm-test-run-plv8> server # [ 0.089531] CPU features: detected: Stage-2 Force Write-Back vm-test-run-plv8> server # [ 0.089554] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-plv8> server # [ 0.089583] CPU features: detected: TLB range maintenance instructions vm-test-run-plv8> server # [ 0.089603] CPU features: detected: WFx with timeout vm-test-run-plv8> server # [ 0.089643] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-plv8> server # [ 0.089668] CPU features: detected: Scalable Vector Extension vm-test-run-plv8> server # [ 0.093448] alternatives: applying system-wide alternatives vm-test-run-plv8> server # [ 0.110570] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-plv8> server # [ 0.111152] SVE: maximum available vector length 256 bytes per vector vm-test-run-plv8> server # [ 0.111223] SVE: default vector length 64 bytes per vector vm-test-run-plv8> server # [ 0.122766] Memory: 3922848K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-plv8> server # [ 0.142691] devtmpfs: initialized vm-test-run-plv8> server # [ 0.165908] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-plv8> server # [ 0.166349] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.168339] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-plv8> server # [ 0.168868] 0 pages in range for non-PLT usage vm-test-run-plv8> server # [ 0.168909] 509248 pages in range for PLT usage vm-test-run-plv8> server # [ 0.171078] pinctrl core: initialized pinctrl subsystem vm-test-run-plv8> server # [ 0.180372] DMI not present or invalid. vm-test-run-plv8> server # [ 0.197029] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-plv8> server # [ 0.207379] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-plv8> server # [ 0.208399] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-plv8> server # [ 0.209439] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-plv8> server # [ 0.209677] audit: initializing netlink subsys (disabled) vm-test-run-plv8> server # [ 0.211591] audit: type=2000 audit(0.164:1): state=initialized audit_enabled=0 res=1 vm-test-run-plv8> server # [ 0.216597] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-plv8> server # [ 0.216641] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-plv8> server # [ 0.216687] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-plv8> server # [ 0.216714] thermal_sys: Registered thermal governor 'user_space' vm-test-run-plv8> server # [ 0.216738] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-plv8> server # [ 0.217556] cpuidle: using governor ladder vm-test-run-plv8> server # [ 0.218286] cpuidle: using governor menu vm-test-run-plv8> server # [ 0.220073] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-plv8> server # [ 0.220879] ASID allocator initialised with 65536 entries vm-test-run-plv8> server # [ 0.227922] Serial: AMBA PL011 UART driver vm-test-run-plv8> server # [ 0.273380] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-plv8> server # [ 0.274231] printk: legacy console [ttyAMA0] enabled vm-test-run-plv8> server # [ 0.305570] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.305772] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-plv8> server # [ 0.305862] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.305957] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-plv8> server # [ 0.306048] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.306158] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-plv8> server # [ 0.306411] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.306574] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-plv8> server # [ 0.316465] fbcon: Taking over console vm-test-run-plv8> server # [ 0.317371] ACPI: Interpreter disabled. vm-test-run-plv8> server # [ 0.323376] iommu: Default domain type: Translated vm-test-run-plv8> server # [ 0.323503] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-plv8> server # [ 0.330534] SCSI subsystem initialized vm-test-run-plv8> server # [ 0.333513] usbcore: registered new interface driver usbfs vm-test-run-plv8> server # [ 0.333793] usbcore: registered new interface driver hub vm-test-run-plv8> server # [ 0.334003] usbcore: registered new device driver usb vm-test-run-plv8> server # [ 0.336126] pps_core: LinuxPPS API ver. 1 registered vm-test-run-plv8> server # [ 0.336231] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-plv8> server # [ 0.336690] PTP clock support registered vm-test-run-plv8> server # [ 0.337022] EDAC MC: Ver: 3.0.0 vm-test-run-plv8> server # [ 0.338446] scmi_core: SCMI protocol bus registered vm-test-run-plv8> server # [ 0.341773] FPGA manager framework vm-test-run-plv8> server # [ 0.344354] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-plv8> server # [ 0.354135] vgaarb: loaded vm-test-run-plv8> server # [ 0.358068] clocksource: Switched to clocksource arch_sys_counter vm-test-run-plv8> server # [ 0.361763] VFS: Disk quotas dquot_6.6.0 vm-test-run-plv8> server # [ 0.361999] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-plv8> server # [ 0.366474] netfs: FS-Cache loaded vm-test-run-plv8> server # [ 0.367803] pnp: PnP ACPI: disabled vm-test-run-plv8> server # [ 0.387728] NET: Registered PF_INET protocol family vm-test-run-plv8> server # [ 0.388917] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-plv8> server # [ 0.484538] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.484867] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.485153] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.486624] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-plv8> server # [ 0.487797] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-plv8> server # [ 0.489297] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-plv8> server # [ 0.489663] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.489958] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.492243] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-plv8> server # [ 0.492707] NET: Registered PF_XDP protocol family vm-test-run-plv8> server # [ 0.492890] PCI: CLS 0 bytes, default 64 vm-test-run-plv8> server # [ 0.494870] kvm [1]: HYP mode not available vm-test-run-plv8> server # [ 0.496446] Trying to unpack rootfs image as initramfs... vm-test-run-plv8> server # [ 0.585975] Initialise system trusted keyrings vm-test-run-plv8> server # [ 0.588387] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-plv8> server # [ 0.592425] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-plv8> server # [ 0.593092] 9p: Installing v9fs 9p2000 file system support vm-test-run-plv8> server # [ 0.648084] Key type asymmetric registered vm-test-run-plv8> server # [ 0.648508] Asymmetric key parser 'x509' registered vm-test-run-plv8> server # [ 0.649287] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-plv8> server # [ 0.651584] io scheduler mq-deadline registered vm-test-run-plv8> server # [ 0.651950] io scheduler kyber registered vm-test-run-plv8> server # [ 0.679736] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-plv8> server # [ 0.684076] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-plv8> server # [ 0.687933] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-plv8> server # [ 0.688599] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-plv8> server # [ 0.689042] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-plv8> server # [ 0.689194] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-plv8> server # [ 0.689597] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-plv8> server # [ 0.690001] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-plv8> server # [ 0.692244] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-plv8> server # [ 0.692591] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-plv8> server # [ 0.692713] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.692813] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.692902] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.693846] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.697442] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.697737] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.697850] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.697975] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.699481] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.700838] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.701020] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.701401] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.701504] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.701978] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.702560] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.703198] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.704624] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.705748] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.706814] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.706924] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.707035] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.707956] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.708111] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.708204] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.708718] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.709170] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.709300] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-plv8> server # [ 0.709381] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.709470] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.709898] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.711085] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.711653] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.711756] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.711863] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.713571] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.713748] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.714631] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.716424] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.716586] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.716696] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.717755] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-plv8> server # [ 0.718498] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.719618] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.719815] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.720553] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.720932] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.722002] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.722355] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.723284] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.723391] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.725060] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-plv8> server # [ 0.725299] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-plv8> server # [ 0.725447] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.726558] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.726833] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.726967] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.727100] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.727225] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.727691] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.727979] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.728113] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.728876] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.729029] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.729340] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-plv8> server # [ 0.729905] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-plv8> server # [ 0.730012] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-plv8> server # [ 0.730106] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-plv8> server # [ 0.730198] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-plv8> server # [ 0.730918] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-plv8> server # [ 0.731113] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-plv8> server # [ 0.731398] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-plv8> server # [ 0.731495] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-plv8> server # [ 0.731592] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-plv8> server # [ 0.731941] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-plv8> server # [ 0.732037] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-plv8> server # [ 0.732138] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-plv8> server # [ 0.732245] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-plv8> server # [ 0.732387] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-plv8> server # [ 0.732482] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-plv8> server # [ 0.732571] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-plv8> server # [ 0.732658] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-plv8> server # [ 0.732741] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-plv8> server # [ 0.732823] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-plv8> server # [ 0.732903] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-plv8> server # [ 0.733135] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.733222] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.733304] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.734305] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.791252] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.794800] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.796750] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.798892] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.800792] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.804330] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.806403] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.807850] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.809649] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.812395] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.815596] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.831535] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-plv8> server # [ 0.840218] msm_serial: driver initialized vm-test-run-plv8> server # [ 0.841173] SuperH (H)SCI(F) driver initialized vm-test-run-plv8> server # [ 0.841527] STM32 USART driver initialized vm-test-run-plv8> server # [ 0.881415] loop: module loaded vm-test-run-plv8> server # [ 0.881971] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-plv8> server # [ 0.885891] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-plv8> server # [ 0.898115] megasas: 07.727.03.00-rc1 vm-test-run-plv8> server # [ 0.902830] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-plv8> server # [ 0.905252] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 0.906025] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 0.908956] Using buffer write method vm-test-run-plv8> server # [ 0.909739] Freeing initrd memory: 10684K vm-test-run-plv8> server # [ 0.909914] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-plv8> server # [ 0.911953] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 0.912299] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 0.913259] Using buffer write method vm-test-run-plv8> server # [ 0.913444] Concatenating MTD devices: vm-test-run-plv8> server # [ 0.913520] (0): "0.flash" vm-test-run-plv8> server # [ 0.913672] (1): "0.flash" vm-test-run-plv8> server # [ 0.915122] into device "0.flash" vm-test-run-plv8> server # [ 0.938826] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-plv8> server # [ 0.949173] thunder_xcv, ver 1.0 vm-test-run-plv8> server # [ 0.949377] thunder_bgx, ver 1.0 vm-test-run-plv8> server # [ 0.949533] nicpf, ver 1.0 vm-test-run-plv8> server # [ 0.952223] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-plv8> server # [ 0.952468] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-plv8> server # [ 0.952792] hclge is initializing vm-test-run-plv8> server # [ 0.952987] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 0.953057] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-plv8> server # [ 0.953255] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 0.953334] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-plv8> server # [ 0.953500] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-plv8> server # [ 0.953572] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-plv8> server # [ 0.953726] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-plv8> server # [ 0.953815] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-plv8> server # [ 0.955368] sky2: driver version 1.30 vm-test-run-plv8> server # [ 0.961621] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-plv8> server # [ 0.963171] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-plv8> server # [ 0.963984] usbcore: registered new interface driver usb-storage vm-test-run-plv8> server # [ 0.964674] usbcore: registered new interface driver usbserial_generic vm-test-run-plv8> server # [ 0.964902] usbserial: USB Serial support registered for generic vm-test-run-plv8> server # [ 0.965153] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-plv8> server # [ 0.974731] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-plv8> server # [ 0.975277] rtc-pl031 9010000.pl031: setting system clock to 2026-10-21T00:59:45 UTC (1792544385) vm-test-run-plv8> server # [ 0.977293] i2c_dev: i2c /dev entries driver vm-test-run-plv8> server # [ 0.978907] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-plv8> server # [ 0.985133] hub 1-0:1.0: USB hub found vm-test-run-plv8> server # [ 0.985718] hub 1-0:1.0: 6 ports detected vm-test-run-plv8> server # [ 0.990877] sdhci: Secure Digital Host Controller Interface driver vm-test-run-plv8> server # [ 0.991191] sdhci: Copyright(c) Pierre Ossman vm-test-run-plv8> server # [ 0.992726] Synopsys Designware Multimedia Card Interface Driver vm-test-run-plv8> server # [ 0.994397] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-plv8> server # [ 0.999944] hid: raw HID events driver (C) Jiri Kosina vm-test-run-plv8> server # [ 1.001508] usbcore: registered new interface driver usbhid vm-test-run-plv8> server # [ 1.001623] usbhid: USB HID core driver vm-test-run-plv8> server # [ 1.008864] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-plv8> server # [ 1.019711] drop_monitor: Initializing network drop monitor service vm-test-run-plv8> server # [ 1.020865] NET: Registered PF_INET6 protocol family vm-test-run-plv8> server # [ 1.033747] Segment Routing with IPv6 vm-test-run-plv8> server # [ 1.034026] In-situ OAM (IOAM) with IPv6 vm-test-run-plv8> server # [ 1.035164] NET: Registered PF_PACKET protocol family vm-test-run-plv8> server # [ 1.036858] 9pnet: Installing 9P2000 support vm-test-run-plv8> server # [ 1.040198] Key type dns_resolver registered vm-test-run-plv8> server # [ 1.070166] registered taskstats version 1 vm-test-run-plv8> server # [ 1.072391] Loading compiled-in X.509 certificates vm-test-run-plv8> server # [ 1.119045] Demotion targets for Node 0: null vm-test-run-plv8> server # [ 1.120747] Key type .fscrypt registered vm-test-run-plv8> server # [ 1.120866] Key type fscrypt-provisioning registered vm-test-run-plv8> server # [ 1.130823] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-plv8> server # [ 1.167456] clk: Disabling unused clocks vm-test-run-plv8> server # [ 1.168121] PM: genpd: Disabling unused power domains vm-test-run-plv8> server # [ 1.168785] ALSA device list: vm-test-run-plv8> server # [ 1.168916] No soundcards found. vm-test-run-plv8> server # [ 1.237686] Freeing unused kernel memory: 4416K vm-test-run-plv8> server # [ 1.239026] Run /init as init process vm-test-run-plv8> server # [ 1.246617] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-plv8> server # [ 1.427489] 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.541397] 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.666520] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-plv8> server # [ 1.733112] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-plv8> server # [ 1.837442] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-plv8> server # [ 1.838558] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-plv8> server # [ 1.838582] [drm] features: -context_init vm-test-run-plv8> server # [ 1.841199] [drm] number of scanouts: 1 vm-test-run-plv8> server # [ 1.841445] [drm] number of cap sets: 0 vm-test-run-plv8> server # [ 1.844501] 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.846548] 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 # [ 1.852194] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-plv8> server # [ 1.880469] Console: switching to colour frame buffer device 160x50 vm-test-run-plv8> server # [ 1.890890] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-plv8> server # [ 4.297394] EXT4-fs (vda): mounted filesystem 6cfd0a68-215b-4410-bd2a-9fc2360498b2 r/w with ordered data mode. Quota mode: none. vm-test-run-plv8> server # [ 6.266721] EXT4-fs (vda): re-mounted 6cfd0a68-215b-4410-bd2a-9fc2360498b2. vm-test-run-plv8> server # [ 6.281641] booting system configuration /nix/store/57w96jz7w56x88k89p4mymabz9k16d4s-nixos-system-server-test vm-test-run-plv8> server # [ 15.907502] systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN -IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) vm-test-run-plv8> server # [ 15.916648] systemd[1]: Detected virtualization qemu. vm-test-run-plv8> server # [ 15.921431] systemd[1]: Detected architecture arm64. vm-test-run-plv8> server # [ 15.926198] systemd[1]: Detected first boot. vm-test-run-plv8> server # [ 15.949663] systemd[1]: Initializing machine ID from random generator. vm-test-run-plv8> server # [ 15.977781] systemd[1]: Hostname set to . vm-test-run-plv8> server # [ 17.034320] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-plv8> server # [ 18.240647] systemd[1]: Applying preset policy. vm-test-run-plv8> server # [ 21.096256] systemd[1]: Populated /etc with preset unit settings. vm-test-run-plv8> server # [ 23.871655] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-plv8> server # [ 24.061022] systemd[1]: Created slice Slice /system/getty. vm-test-run-plv8> server # [ 24.074688] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-plv8> server # [ 24.085924] systemd[1]: Created slice User and Session Slice. vm-test-run-plv8> server # [ 24.093782] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-plv8> server # [ 24.099692] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-plv8> server # [ 24.104943] systemd[1]: Expecting device /dev/hvc0... vm-test-run-plv8> server # [ 24.109540] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-plv8> server # [ 24.112965] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-plv8> server # [ 24.115587] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-plv8> server # [ 24.121214] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-plv8> server # [ 24.126133] systemd[1]: Reached target Path Units. vm-test-run-plv8> server # [ 24.130699] systemd[1]: Reached target Remote File Systems. vm-test-run-plv8> server # [ 24.133126] systemd[1]: Reached target Slice Units. vm-test-run-plv8> server # [ 24.137835] systemd[1]: Reached target Swaps. vm-test-run-plv8> server # [ 24.169952] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-plv8> server # [ 24.191104] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-plv8> server # [ 24.200481] systemd[1]: Listening on Journal Audit Socket. vm-test-run-plv8> server # [ 24.206931] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-plv8> server # [ 24.212386] systemd[1]: Listening on Journal Sockets. vm-test-run-plv8> server # [ 24.221036] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-plv8> server # [ 24.226942] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 24.232183] systemd[1]: Listening on udev Control Socket. vm-test-run-plv8> server # [ 24.237278] systemd[1]: Listening on udev Kernel Socket. vm-test-run-plv8> server # [ 24.285299] systemd[1]: Mounting Huge Pages File System... vm-test-run-plv8> server # [ 24.321829] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-plv8> server # [ 24.367453] systemd[1]: Mounting Kernel Debug File System... vm-test-run-plv8> server # [ 24.411078] systemd[1]: Mounting Kernel Trace File System... vm-test-run-plv8> server # [ 24.485735] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-plv8> server # [ 24.612677] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-plv8> server # [ 24.632944] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-plv8> server # [ 24.753629] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-plv8> server # [ 24.788367] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-plv8> server # [ 24.807521] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-plv8> server # [ 24.983137] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-plv8> server # [ 24.993232] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-plv8> server # [ 25.011955] 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 # [ 25.111829] systemd[1]: Starting Journal Service... vm-test-run-plv8> server # [ 25.181972] systemd[1]: Starting Load Kernel Modules... vm-test-run-plv8> server # [ 25.253600] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-plv8> server # [ 25.305454] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-plv8> server # [ 25.315239] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 25.363953] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-plv8> server # [ 25.444385] systemd[1]: Mounted Huge Pages File System. vm-test-run-plv8> server # [ 25.455464] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-plv8> server # [ 25.468118] systemd[1]: Mounted Kernel Debug File System. vm-test-run-plv8> server # [ 25.477236] systemd[1]: Mounted Kernel Trace File System. vm-test-run-plv8> server # [ 25.508737] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-plv8> server # [ 25.525389] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-plv8> server # [ 25.590243] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-plv8> server # [ 25.880952] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-plv8> server # [ 25.901550] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-plv8> server # [ 26.427607] fuse: init (API version 7.41) vm-test-run-plv8> server # [ 26.462852] systemd[1]: Finished Load Kernel Modules. vm-test-run-plv8> server # [ 26.485551] EXT4-fs (vda): re-mounted 6cfd0a68-215b-4410-bd2a-9fc2360498b2. vm-test-run-plv8> server # [ 26.528340] systemd[1]: Starting Firewall... vm-test-run-plv8> server # [ 26.593811] systemd[1]: Starting Apply Kernel Variables... vm-test-run-plv8> server # [ 26.641661] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-plv8> server # [ 26.659529] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-plv8> server # [ 26.676507] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-plv8> server # [ 26.724748] systemd[1]: Mounting FUSE Control File System... vm-test-run-plv8> server # [ 26.745698] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-plv8> server # [ 26.836343] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-plv8> server # [ 26.839793] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 27.015503] systemd[1]: Mounted FUSE Control File System. vm-test-run-plv8> server # [ 27.195768] systemd-journald[395]: Collecting audit messages is enabled. vm-test-run-plv8> server # [ 27.795955] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-plv8> server # [ 27.915868] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-plv8> server # [ 27.949983] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-plv8> server # [ 27.972970] systemd[1]: Reached target First Boot Complete. vm-test-run-plv8> server # [ 28.052550] systemd[1]: Finished Apply Kernel Variables. vm-test-run-plv8> server # [ 28.281306] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-plv8> server # [ 29.043117] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-plv8> server # [ 29.061712] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-plv8> server # [ 29.114540] systemd[1]: Mounting /run/wrappers... vm-test-run-plv8> server # [ 29.162697] systemd[1]: Starting Rule-based Manager for Device Events and Files... 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.532777] systemd[1]: Mounted /run/wrappers. vm-test-run-plv8> server # [ 29.546660] systemd[1]: Reached target Local File Systems. vm-test-run-plv8> server # [ 29.581853] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-plv8> server # [ 29.632473] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-plv8> server # [ 29.638734] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-plv8> server # [ 29.608185] systemd-modules-load[396]: Module 'atkbd' is built in vm-test-run-plv8> server # [ 29.613723] systemd-modules-load[396]: Module 'loop' is built in vm-test-run-plv8> server # [ 29.693708] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-plv8> server # [ 29.708587] systemd[1]: Started Journal Service. vm-test-run-plv8> server # [ 29.663602] systemd-oomd[397]: No swap; memory pressure usage will be degraded vm-test-run-plv8> server # [ 29.766862] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-plv8> server # [ 30.537351] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-plv8> server # [ 30.631708] systemd-journald[395]: Received client request to flush runtime journal. vm-test-run-plv8> server # [ 30.999461] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-plv8> server # [ 31.055310] systemd-udevd[426]: Using default interface naming scheme 'v258'. vm-test-run-plv8> server # [ 31.085303] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-plv8> server # [ 31.135243] systemd[1]: Starting Create System Files and Directories... vm-test-run-plv8> server # [ 32.999638] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-plv8> server # [ 33.221410] systemd[1]: Finished Create System Files and Directories. vm-test-run-plv8> server # [ 33.313060] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-plv8> server # [ 33.363804] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-plv8> server # [ 34.378997] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-plv8> server # [ 35.140581] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-plv8> server # [ 35.206330] systemd[1]: Starting Update is Completed... vm-test-run-plv8> server # [ 35.937748] systemd[1]: Finished Update is Completed. vm-test-run-plv8> server # [ 38.981830] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-plv8> server # [ 38.994078] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-plv8> server # [ 39.007319] systemd[1]: suid-sgid-wrappers.service: Consumed 2.586s CPU time, 5.6M memory peak. vm-test-run-plv8> server # [ 41.299621] systemd[1]: Finished Firewall. vm-test-run-plv8> server # [ 42.743862] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-plv8> server # [ 42.759356] systemd[1]: Reached target System Initialization. vm-test-run-plv8> server # [ 42.766162] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-plv8> server # [ 42.773517] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-plv8> server # [ 42.777651] systemd[1]: Reached target Timer Units. vm-test-run-plv8> server # [ 42.789667] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-plv8> server # [ 42.792019] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-plv8> server # [ 42.802352] systemd[1]: Listening on Hostname Service Socket. vm-test-run-plv8> server # [ 42.805985] systemd[1]: Reached target Socket Units. vm-test-run-plv8> server # [ 42.807878] systemd[1]: Reached target Basic System. vm-test-run-plv8> server # [ 42.821387] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-plv8> server # [ 42.848735] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 42.893158] systemd[1]: Started Reset console on configuration changes. vm-test-run-plv8> server # [ 42.945987] systemd[1]: Starting resolvconf update... vm-test-run-plv8> server # [ 43.004639] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-plv8> server # [ 43.955363] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-plv8> server # [ 44.116452] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 44.117615] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 44.150251] nsncd[631]: Oct 21 01:00:28.673 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 44.171290] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 44.230881] systemd[1]: Starting User Login Management... vm-test-run-plv8> server # [ 44.468761] dbus-daemon[634]: dbus[634]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-plv8> server # [ 44.838103] systemd[1]: Started D-Bus System Message Bus. vm-test-run-plv8> server # [ 45.843614] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-plv8> server # [ 45.854217] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-plv8> server # [ 45.872838] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-plv8> server # [ 45.877608] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-plv8> server # [ 45.882589] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 45.945785] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-plv8> server # [ 46.005646] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 46.015256] systemd-logind[647]: New seat seat0. vm-test-run-plv8> server # [ 46.105490] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 46.114898] systemd[1]: Started User Login Management. vm-test-run-plv8> server # [ 46.149027] systemd[1]: Starting linger-users.service... vm-test-run-plv8> server # [ 46.729147] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-plv8> server # [ 46.742687] systemd[1]: Finished linger-users.service. vm-test-run-plv8> server # [ 46.900213] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 46.905434] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 46.915298] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 46.922009] nsncd[693]: Oct 21 01:00:31.474 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 47.309568] systemd[1]: Finished resolvconf update. vm-test-run-plv8> server # [ 47.357722] systemd[1]: Reached target Preparation for Network. vm-test-run-plv8> server # [ 47.407804] systemd[1]: Starting DHCP Client... vm-test-run-plv8> server # [ 48.771161] dhcpcd[742]: dhcpcd-10.2.4 starting vm-test-run-plv8> server # [ 48.897282] dhcpcd[760]: dev: loaded udev vm-test-run-plv8> server # [ 49.305901] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-plv8> server # [ 49.743132] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-plv8> server # [ 49.993429] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-plv8> server # [ 50.003189] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-plv8> server # [ 50.026253] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-plv8> server # [ 50.037097] cfg80211: failed to load regulatory.db vm-test-run-plv8> server # [ 50.181318] systemd[1]: Found device /dev/hvc0. vm-test-run-plv8> server # [ 50.799559] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-plv8> server # [ 50.756099] dhcpcd[760]: eth0: waiting for carrier vm-test-run-plv8> server # [ 50.790382] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-plv8> server # [ 50.793080] dhcpcd[760]: eth0: carrier acquired vm-test-run-plv8> server # [ 50.818204] systemd[1]: Started backdoor.service. vm-test-run-plv8> server # [ 50.923277] dhcpcd[760]: DUID 00:01:00:01:32:6a:cb:33:52:54:00:12:34:56 vm-test-run-plv8> server # [ 50.929593] dhcpcd[760]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 50.931938] dhcpcd[760]: eth0: adding address fe80::5054:ff:fe12:3456 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 52.33 seconds) vm-test-run-plv8> server: (finished: waiting for the VM to finish booting, in 52.33 seconds) vm-test-run-plv8> server # [ 51.650813] dhcpcd[760]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 51.701046] dhcpcd[760]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 51.721770] dhcpcd[760]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 53.302782] dhcpcd[760]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 53.313547] dhcpcd[760]: eth0: Router Advertisement from fe80::2 vm-test-run-plv8> server # [ 53.335418] (udev-worker)[797]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 53.341281] dhcpcd[760]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-plv8> server # [ 53.343473] dhcpcd[760]: eth0: adding route to fec0::/64 vm-test-run-plv8> server # [ 53.378500] (udev-worker)[800]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-plv8> server # [ 53.385395] dhcpcd[760]: eth0: adding default route via fe80::2 vm-test-run-plv8> server # [ 53.386688] (udev-worker)[800]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 54.034860] dhcpcd[760]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 54.119183] dhcpcd[760]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 54.181499] systemd[1]: Found device Virtio network device. vm-test-run-plv8> server # [ 54.211973] systemd[1]: Starting Address configuration of eth1... vm-test-run-plv8> server # [ 54.595175] dhcpcd[760]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 54.599834] dhcpcd[760]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 54.605539] dhcpcd[760]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 55.061324] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-plv8> server # [ 55.243371] network-addresses-eth1-start[822]: adding address 192.168.1.1/24... done vm-test-run-plv8> server # [ 55.477696] network-addresses-eth1-start[822]: adding address 2001:db8:1::1/64... done vm-test-run-plv8> server # [ 55.669015] systemd[1]: Finished Address configuration of eth1. vm-test-run-plv8> server # [ 55.785924] systemd[1]: Starting Networking Setup... vm-test-run-plv8> server # [ 56.391662] systemd-logind[647]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-plv8> server # [ 57.599268] systemd[1]: Finished Networking Setup. vm-test-run-plv8> server # [ 57.636070] systemd[1]: Reached target Network. vm-test-run-plv8> server # [ 57.683570] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-plv8> server # [ 57.746524] systemd[1]: Starting Permit User Sessions... vm-test-run-plv8> server # [ 58.275337] systemd[1]: Finished Permit User Sessions. vm-test-run-plv8> server # [ 58.349331] systemd[1]: Started Getty on tty1. vm-test-run-plv8> server # [ 58.350370] systemd[1]: Reached target Login Prompts. vm-test-run-plv8> server # [ 58.943127] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[920]: Initializing database at /var/lib/postgresql/data vm-test-run-plv8> server # [ 59.298900] dhcpcd[760]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-plv8> server # [ 59.313228] dhcpcd[760]: eth0: adding route to 10.0.2.0/24 vm-test-run-plv8> server # [ 59.315234] dhcpcd[760]: eth0: adding default route via 10.0.2.2 vm-test-run-plv8> server # [ 60.839029] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: The files belonging to this database system will be owned by user "postgres". vm-test-run-plv8> server # [ 60.843882] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: This user must also own the server process. vm-test-run-plv8> server # [ 60.927735] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-plv8> server # [ 60.934860] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: The default database encoding has accordingly been set to "UTF8". vm-test-run-plv8> server # [ 60.935475] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: The default text search configuration will be set to "english". vm-test-run-plv8> server # [ 60.947020] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: Data page checksums are enabled. vm-test-run-plv8> server # [ 60.947998] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-plv8> server # [ 60.959428] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: creating subdirectories ... ok vm-test-run-plv8> server # [ 60.973665] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: selecting dynamic shared memory implementation ... posix vm-test-run-plv8> server # [ 62.310698] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: selecting default max_connections ... 100 vm-test-run-plv8> server # [ 63.033541] systemd[1]: Started DHCP Client. vm-test-run-plv8> server # [ 63.333574] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: selecting default shared_buffers ... 128MB vm-test-run-plv8> server # [ 68.138843] mousedev: PS/2 mouse device common for all mice vm-test-run-plv8> server # [ 68.763879] systemd-logind[647]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-plv8> server # [ 73.193600] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: selecting default time zone ... UTC vm-test-run-plv8> server # [ 73.223388] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: creating configuration files ... ok vm-test-run-plv8> server # [ 77.695716] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: running bootstrap script ... ok vm-test-run-plv8> server # [ 90.082490] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: performing post-bootstrap initialization ... ok vm-test-run-plv8> server # [ 92.665852] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: syncing data to disk ... ok vm-test-run-plv8> server # [ 92.677266] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-plv8> server # [ 92.680253] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: 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 # [ 92.690908] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: Success. You can now start the database server using: vm-test-run-plv8> server # [ 92.694542] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[927]: /nix/store/mnyn96lbakqpsxdrc4h8vk4a3xvfnk4q-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-plv8> server # [ 93.907839] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[920]: Validating PostgreSQL configuration... vm-test-run-plv8> server # [ 94.413937] lzzn9yvwrmmll2xx68309ariaqgc77a5-postgresql-init[1330]: 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 # [ 95.584100] postgres[1342]: 2026-10-21 01:01:20.170 UTC [1342] LOG: pgaudit extension initialized vm-test-run-plv8> server # [ 96.231400] postgres[1342]: 2026-10-21 01:01:20.820 UTC [1342] LOG: pgsodium primary server secret key loaded vm-test-run-plv8> server # [ 96.794207] postgres[1342]: 2026-10-21 01:01:21.365 UTC [1342] LOG: vault primary server secret key loaded vm-test-run-plv8> server # [ 97.288912] postgres[1342]: 2026-10-21 01:01:21.879 UTC [1342] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-plv8> server # [ 97.311787] postgres[1342]: 2026-10-21 01:01:21.902 UTC [1342] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-plv8> server # [ 97.317422] postgres[1342]: 2026-10-21 01:01:21.904 UTC [1342] LOG: listening on IPv6 address "::", port 5432 vm-test-run-plv8> server # [ 97.336924] postgres[1342]: 2026-10-21 01:01:21.926 UTC [1342] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-plv8> server # [ 97.470877] postgres[1375]: 2026-10-21 01:01:22.041 UTC [1375] LOG: database system was shut down at 2026-10-21 01:01:14 UTC vm-test-run-plv8> server # [ 97.835956] postgres[1381]: 2026-10-21 01:01:22.413 UTC [1381] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 97.850957] postgres[1342]: 2026-10-21 01:01:22.421 UTC [1342] LOG: database system is ready to accept connections vm-test-run-plv8> server # [ 97.893488] postgres[1380]: 2026-10-21 01:01:22.452 UTC [1380] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-plv8> server # [ 97.913347] systemd[1]: Started PostgreSQL Database Server. vm-test-run-plv8> server # [ 97.928829] systemd[1]: Starting Supabase Database Initialization... vm-test-run-plv8> server # [ 98.118405] postgres[1342]: 2026-10-21 01:01:22.705 UTC [1342] LOG: background worker "pg_net 0.20.4 worker" (PID 1381) exited with exit code 1 vm-test-run-plv8> server # [ 98.210199] postgres[1383]: 2026-10-21 01:01:22.789 UTC [1383] LOG: pg_cron scheduler started vm-test-run-plv8> server # [ 98.258577] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Waiting for PostgreSQL to be ready... vm-test-run-plv8> server # [ 98.931471] postgres[1402]: ::1 2026-10-21 01:01:23.510 UTC [1402] root@root FATAL: role "root" does not exist vm-test-run-plv8> server # [ 98.972850] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: PostgreSQL is ready vm-test-run-plv8> server # [ 98.975488] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Creating postgres role... vm-test-run-plv8> server # [ 99.208831] postgres[1408]: 2026-10-21 01:01:23.778 UTC [1408] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 99.337729] postgres[1342]: 2026-10-21 01:01:23.903 UTC [1342] LOG: background worker "pg_net 0.20.4 worker" (PID 1408) exited with exit code 1 vm-test-run-plv8> server # [ 99.487256] postgres[1409]: ::1 2026-10-21 01:01:24.074 UTC [1409] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-plv8> server # [ 99.538720] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1406]: CREATE ROLE vm-test-run-plv8> server # [ 99.800125] postgres[1411]: ::1 2026-10-21 01:01:24.386 UTC [1411] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-plv8> server # [ 99.829132] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1410]: ALTER DATABASE vm-test-run-plv8> server # [ 99.883663] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-plv8> server # [ 100.121866] postgres[1413]: ::1 2026-10-21 01:01:24.704 UTC [1413] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-plv8> server # [ 100.135764] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: CREATE PUBLICATION vm-test-run-plv8> server # [ 100.137847] postgres[1413]: ::1 2026-10-21 01:01:24.724 UTC [1413] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-plv8> server # [ 100.145105] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: ALTER ROLE vm-test-run-plv8> server # [ 100.146152] postgres[1413]: ::1 2026-10-21 01:01:24.736 UTC [1413] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-plv8> server # [ 100.168811] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: CREATE ROLE vm-test-run-plv8> server # [ 100.169986] postgres[1413]: ::1 2026-10-21 01:01:24.760 UTC [1413] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-plv8> server # [ 100.178721] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: CREATE ROLE vm-test-run-plv8> server # [ 100.180981] postgres[1413]: ::1 2026-10-21 01:01:24.770 UTC [1413] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-plv8> server # [ 100.193682] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: GRANT ROLE vm-test-run-plv8> server # [ 100.195619] postgres[1413]: ::1 2026-10-21 01:01:24.785 UTC [1413] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-plv8> server # [ 100.204148] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: GRANT vm-test-run-plv8> server # [ 100.206035] postgres[1413]: ::1 2026-10-21 01:01:24.796 UTC [1413] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-plv8> server # [ 100.214883] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: CREATE ROLE vm-test-run-plv8> server # [ 100.221388] postgres[1413]: ::1 2026-10-21 01:01:24.808 UTC [1413] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-plv8> server # [ 100.229193] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: GRANT ROLE vm-test-run-plv8> server # [ 100.232009] postgres[1413]: ::1 2026-10-21 01:01:24.821 UTC [1413] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-plv8> server # [ 100.247535] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: CREATE SCHEMA vm-test-run-plv8> server # [ 100.249467] postgres[1413]: ::1 2026-10-21 01:01:24.838 UTC [1413] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-plv8> server # [ 102.582087] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: CREATE EXTENSION vm-test-run-plv8> server # [ 102.589761] postgres[1413]: ::1 2026-10-21 01:01:27.169 UTC [1413] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-plv8> server # [ 103.487864] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: CREATE EXTENSION vm-test-run-plv8> server # [ 103.495976] postgres[1413]: ::1 2026-10-21 01:01:28.079 UTC [1413] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-plv8> server # [ 103.501427] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: CREATE ROLE vm-test-run-plv8> server # [ 103.503897] postgres[1413]: ::1 2026-10-21 01:01:28.093 UTC [1413] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-plv8> server # [ 103.512121] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: CREATE ROLE vm-test-run-plv8> server # [ 103.515423] postgres[1413]: ::1 2026-10-21 01:01:28.102 UTC [1413] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-plv8> server # [ 103.521493] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: CREATE ROLE vm-test-run-plv8> server # [ 103.522292] postgres[1413]: ::1 2026-10-21 01:01:28.112 UTC [1413] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-plv8> server # [ 103.528366] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: CREATE ROLE vm-test-run-plv8> server # [ 103.533405] postgres[1413]: ::1 2026-10-21 01:01:28.120 UTC [1413] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-plv8> server # [ 103.538839] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: GRANT ROLE vm-test-run-plv8> server # [ 103.545547] postgres[1413]: ::1 2026-10-21 01:01:28.130 UTC [1413] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-plv8> server # [ 103.554365] postgres[1413]: ::1 2026-10-21 01:01:28.138 UTC [1413] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-plv8> server # [ 103.560907] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: GRANT ROLE vm-test-run-plv8> server # [ 103.563585] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: GRANT ROLE vm-test-run-plv8> server # [ 103.564768] postgres[1413]: ::1 2026-10-21 01:01:28.148 UTC [1413] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-plv8> server # [ 103.567366] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: GRANT ROLE vm-test-run-plv8> server # [ 103.570827] postgres[1413]: ::1 2026-10-21 01:01:28.161 UTC [1413] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 103.594307] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: GRANT vm-test-run-plv8> server # [ 103.601395] postgres[1413]: ::1 2026-10-21 01:01:28.168 UTC [1413] 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 # [ 103.605057] postgres[1413]: ::1 2026-10-21 01:01:28.187 UTC [1413] 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 # [ 103.607080] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 103.615502] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 103.618940] postgres[1413]: ::1 2026-10-21 01:01:28.205 UTC [1413] 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 # [ 103.624317] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 103.627622] postgres[1413]: ::1 2026-10-21 01:01:28.214 UTC [1413] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 103.631634] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: GRANT vm-test-run-plv8> server # [ 103.632961] postgres[1413]: ::1 2026-10-21 01:01:28.222 UTC [1413] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-plv8> server # [ 103.647272] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: ALTER ROLE vm-test-run-plv8> server # [ 103.651113] postgres[1413]: ::1 2026-10-21 01:01:28.240 UTC [1413] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 103.652980] postgres[1413]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 103.658563] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 103.661146] postgres[1413]: ::1 2026-10-21 01:01:28.250 UTC [1413] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 103.662026] postgres[1413]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 103.667426] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 103.670339] postgres[1413]: ::1 2026-10-21 01:01:28.260 UTC [1413] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 103.671606] postgres[1413]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 103.689393] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 103.693336] postgres[1413]: ::1 2026-10-21 01:01:28.273 UTC [1413] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-plv8> server # [ 103.698774] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: ALTER ROLE vm-test-run-plv8> server # [ 103.700160] postgres[1413]: ::1 2026-10-21 01:01:28.286 UTC [1413] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-plv8> server # [ 103.711235] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1412]: ALTER ROLE vm-test-run-plv8> server # [ 103.787325] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-plv8> server # [ 104.135741] postgres[1452]: ::1 2026-10-21 01:01:28.717 UTC [1452] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 104.165840] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE SCHEMA vm-test-run-plv8> server # [ 104.166939] postgres[1452]: ::1 2026-10-21 01:01:28.754 UTC [1452] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-plv8> server # [ 104.173073] postgres[1452]: instance_id uuid NULL, vm-test-run-plv8> server # [ 104.174076] postgres[1452]: id uuid NOT NULL UNIQUE, vm-test-run-plv8> server # [ 104.175444] postgres[1452]: aud varchar(255) NULL, vm-test-run-plv8> server # [ 104.181023] postgres[1452]: "role" varchar(255) NULL, vm-test-run-plv8> server # [ 104.189128] postgres[1452]: email varchar(255) NULL UNIQUE, vm-test-run-plv8> server # [ 104.190098] postgres[1452]: encrypted_password varchar(255) NULL, vm-test-run-plv8> server # [ 104.190576] postgres[1452]: confirmed_at timestamptz NULL, vm-test-run-plv8> server # [ 104.190962] postgres[1452]: invited_at timestamptz NULL, vm-test-run-plv8> server # [ 104.200862] postgres[1452]: confirmation_token varchar(255) NULL, vm-test-run-plv8> server # [ 104.202855] postgres[1452]: confirmation_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 104.203660] postgres[1452]: recovery_token varchar(255) NULL, vm-test-run-plv8> server # [ 104.210739] postgres[1452]: recovery_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 104.211870] postgres[1452]: email_change_token varchar(255) NULL, vm-test-run-plv8> server # [ 104.212542] postgres[1452]: email_change varchar(255) NULL, vm-test-run-plv8> server # [ 104.223024] postgres[1452]: email_change_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 104.232113] postgres[1452]: last_sign_in_at timestamptz NULL, vm-test-run-plv8> server # [ 104.233634] postgres[1452]: raw_app_meta_data jsonb NULL, vm-test-run-plv8> server # [ 104.234375] postgres[1452]: raw_user_meta_data jsonb NULL, vm-test-run-plv8> server # [ 104.235317] postgres[1452]: is_super_admin bool NULL, vm-test-run-plv8> server # [ 104.236084] postgres[1452]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 104.244770] postgres[1452]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 104.245358] postgres[1452]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 104.245721] postgres[1452]: ); vm-test-run-plv8> server # [ 104.343511] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE TABLE vm-test-run-plv8> server # [ 104.353700] postgres[1452]: ::1 2026-10-21 01:01:28.937 UTC [1452] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-plv8> server # [ 104.405393] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE INDEX vm-test-run-plv8> server # [ 104.417265] postgres[1452]: ::1 2026-10-21 01:01:28.994 UTC [1452] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-plv8> server # [ 104.462466] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE INDEX vm-test-run-plv8> server # [ 104.470135] postgres[1452]: ::1 2026-10-21 01:01:29.050 UTC [1452] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-plv8> server # [ 104.493266] postgres[1452]: ::1 2026-10-21 01:01:29.069 UTC [1452] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-plv8> server # [ 104.495540] postgres[1452]: instance_id uuid NULL, vm-test-run-plv8> server # [ 104.505737] postgres[1452]: id bigserial NOT NULL, vm-test-run-plv8> server # [ 104.506583] postgres[1452]: "token" varchar(255) NULL, vm-test-run-plv8> server # [ 104.507518] postgres[1452]: user_id varchar(255) NULL, vm-test-run-plv8> server # [ 104.522208] postgres[1452]: revoked bool NULL, vm-test-run-plv8> server # [ 104.532829] postgres[1452]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 104.535091] postgres[1452]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 104.541445] postgres[1452]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 104.542949] postgres[1452]: ); vm-test-run-plv8> server # [ 104.543605] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: COMMENT vm-test-run-plv8> server # [ 104.681427] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE TABLE vm-test-run-plv8> server # [ 104.693035] postgres[1452]: ::1 2026-10-21 01:01:29.268 UTC [1452] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-plv8> server # [ 104.735953] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE INDEX vm-test-run-plv8> server # [ 104.745159] postgres[1452]: ::1 2026-10-21 01:01:29.330 UTC [1452] 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 # [ 104.793113] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE INDEX vm-test-run-plv8> server # [ 104.793963] postgres[1452]: ::1 2026-10-21 01:01:29.381 UTC [1452] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-plv8> server # [ 104.835677] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE INDEX vm-test-run-plv8> server # [ 104.842243] postgres[1452]: ::1 2026-10-21 01:01:29.428 UTC [1452] 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 # [ 104.850081] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: COMMENT vm-test-run-plv8> server # [ 104.858909] postgres[1452]: ::1 2026-10-21 01:01:29.443 UTC [1452] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-plv8> server # [ 104.861727] postgres[1452]: id uuid NOT NULL, vm-test-run-plv8> server # [ 104.871651] postgres[1452]: uuid uuid NULL, vm-test-run-plv8> server # [ 104.881420] postgres[1452]: raw_base_config text NULL, vm-test-run-plv8> server # [ 104.882900] postgres[1452]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 104.883478] postgres[1452]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 104.894683] postgres[1452]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 104.903020] postgres[1452]: ); vm-test-run-plv8> server # [ 104.970038] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE TABLE vm-test-run-plv8> server # [ 104.977873] postgres[1452]: ::1 2026-10-21 01:01:29.565 UTC [1452] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-plv8> server # [ 105.001688] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: COMMENT vm-test-run-plv8> server # [ 105.002968] postgres[1452]: ::1 2026-10-21 01:01:29.589 UTC [1452] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-plv8> server # [ 105.003646] postgres[1452]: instance_id uuid NULL, vm-test-run-plv8> server # [ 105.003974] postgres[1452]: id uuid NOT NULL, vm-test-run-plv8> server # [ 105.011685] postgres[1452]: payload json NULL, vm-test-run-plv8> server # [ 105.019005] postgres[1452]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 105.019850] postgres[1452]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 105.020623] postgres[1452]: ); vm-test-run-plv8> server # [ 105.105937] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE TABLE vm-test-run-plv8> server # [ 105.107583] postgres[1452]: ::1 2026-10-21 01:01:29.694 UTC [1452] 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 # [ 105.149651] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE INDEX vm-test-run-plv8> server # [ 105.169708] postgres[1452]: ::1 2026-10-21 01:01:29.737 UTC [1452] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-plv8> server # [ 105.177126] postgres[1452]: ::1 2026-10-21 01:01:29.756 UTC [1452] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-plv8> server # [ 105.178941] postgres[1452]: "version" varchar(255) NOT NULL, vm-test-run-plv8> server # [ 105.179396] postgres[1452]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-plv8> server # [ 105.190058] postgres[1452]: ); vm-test-run-plv8> server # [ 105.199156] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: COMMENT vm-test-run-plv8> server # [ 105.215438] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE TABLE vm-test-run-plv8> server # [ 105.226060] postgres[1452]: ::1 2026-10-21 01:01:29.813 UTC [1452] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-plv8> server # [ 105.231107] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: COMMENT vm-test-run-plv8> server # [ 105.263015] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: INSERT 0 7 vm-test-run-plv8> server # [ 105.270266] postgres[1452]: ::1 2026-10-21 01:01:29.856 UTC [1452] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-plv8> server # [ 105.271111] postgres[1452]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-plv8> server # [ 105.282532] postgres[1452]: $$ language sql stable; vm-test-run-plv8> server # [ 105.304951] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE FUNCTION vm-test-run-plv8> server # [ 105.307661] postgres[1452]: ::1 2026-10-21 01:01:29.890 UTC [1452] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-plv8> server # [ 105.310340] postgres[1452]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-plv8> server # [ 105.318548] postgres[1452]: $$ language sql stable; vm-test-run-plv8> server # [ 105.319201] postgres[1452]: ::1 2026-10-21 01:01:29.905 UTC [1452] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-plv8> server # [ 105.330362] postgres[1452]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-plv8> server # [ 105.331258] postgres[1452]: $$ language sql stable; vm-test-run-plv8> server # [ 105.337902] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE FUNCTION vm-test-run-plv8> server # [ 105.344951] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE FUNCTION vm-test-run-plv8> server # [ 105.345780] postgres[1452]: ::1 2026-10-21 01:01:29.924 UTC [1452] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-plv8> server # [ 105.347465] postgres[1452]: ::1 2026-10-21 01:01:29.933 UTC [1452] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 105.351495] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: GRANT vm-test-run-plv8> server # [ 105.359673] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: CREATE ROLE vm-test-run-plv8> server # [ 105.361628] postgres[1452]: ::1 2026-10-21 01:01:29.946 UTC [1452] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 105.369118] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: GRANT vm-test-run-plv8> server # [ 105.371619] postgres[1452]: ::1 2026-10-21 01:01:29.958 UTC [1452] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 105.383405] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: GRANT vm-test-run-plv8> server # [ 105.384762] postgres[1452]: ::1 2026-10-21 01:01:29.974 UTC [1452] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 105.398096] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: GRANT vm-test-run-plv8> server # [ 105.399379] postgres[1452]: ::1 2026-10-21 01:01:29.985 UTC [1452] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-plv8> server # [ 105.405108] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: ALTER ROLE vm-test-run-plv8> server # [ 105.409222] postgres[1452]: ::1 2026-10-21 01:01:29.997 UTC [1452] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 105.422161] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: ALTER TABLE vm-test-run-plv8> server # [ 105.426138] postgres[1452]: ::1 2026-10-21 01:01:30.014 UTC [1452] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 105.438650] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: ALTER TABLE vm-test-run-plv8> server # [ 105.441864] postgres[1452]: ::1 2026-10-21 01:01:30.032 UTC [1452] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 105.453454] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: ALTER TABLE vm-test-run-plv8> server # [ 105.461633] postgres[1452]: ::1 2026-10-21 01:01:30.047 UTC [1452] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 105.468987] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: ALTER TABLE vm-test-run-plv8> server # [ 105.473323] postgres[1452]: ::1 2026-10-21 01:01:30.061 UTC [1452] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 105.486071] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1445]: ALTER TABLE vm-test-run-plv8> server # [ 105.524123] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-plv8> server # [ 105.777813] postgres[1470]: ::1 2026-10-21 01:01:30.360 UTC [1470] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 105.792432] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1469]: CREATE SCHEMA vm-test-run-plv8> server # [ 105.805544] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1469]: CREATE ROLE vm-test-run-plv8> server # [ 105.807130] postgres[1470]: ::1 2026-10-21 01:01:30.385 UTC [1470] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 105.807612] postgres[1470]: ::1 2026-10-21 01:01:30.392 UTC [1470] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-plv8> server # [ 105.813669] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1469]: ALTER ROLE vm-test-run-plv8> server # [ 105.817227] postgres[1470]: ::1 2026-10-21 01:01:30.405 UTC [1470] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-plv8> server # [ 105.826324] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1469]: GRANT vm-test-run-plv8> server # [ 105.851180] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1469]: DO vm-test-run-plv8> server # [ 105.885002] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-plv8> server # [ 106.129392] postgres[1472]: ::1 2026-10-21 01:01:30.711 UTC [1472] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-plv8> server # [ 106.147828] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: ALTER ROLE vm-test-run-plv8> server # [ 106.150696] postgres[1472]: ::1 2026-10-21 01:01:30.733 UTC [1472] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-plv8> server # [ 106.157558] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: ALTER ROLE vm-test-run-plv8> server # [ 106.166158] postgres[1472]: ::1 2026-10-21 01:01:30.751 UTC [1472] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-plv8> server # [ 106.167545] postgres[1472]: RETURNS event_trigger vm-test-run-plv8> server # [ 106.169519] postgres[1472]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 106.173300] postgres[1472]: AS $$ vm-test-run-plv8> server # [ 106.174284] postgres[1472]: DECLARE vm-test-run-plv8> server # [ 106.175216] postgres[1472]: schema_is_cron bool; vm-test-run-plv8> server # [ 106.175541] postgres[1472]: BEGIN vm-test-run-plv8> server # [ 106.175792] postgres[1472]: schema_is_cron = ( vm-test-run-plv8> server # [ 106.176036] postgres[1472]: SELECT n.nspname = 'cron' vm-test-run-plv8> server # [ 106.179351] postgres[1472]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 106.180693] postgres[1472]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-plv8> server # [ 106.181977] postgres[1472]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 106.183111] postgres[1472]: ); vm-test-run-plv8> server # [ 106.183570] postgres[1472]: vm-test-run-plv8> server # [ 106.183931] postgres[1472]: IF schema_is_cron vm-test-run-plv8> server # [ 106.186157] postgres[1472]: THEN vm-test-run-plv8> server # [ 106.187015] postgres[1472]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 106.187668] postgres[1472]: vm-test-run-plv8> server # [ 106.189486] postgres[1472]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 106.191569] postgres[1472]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 106.192076] postgres[1472]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 106.194538] postgres[1472]: vm-test-run-plv8> server # [ 106.197040] postgres[1472]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 106.198680] postgres[1472]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 106.199708] postgres[1472]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 106.202268] postgres[1472]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 106.203265] postgres[1472]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 106.203886] postgres[1472]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 106.204316] postgres[1472]: vm-test-run-plv8> server # [ 106.205941] postgres[1472]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 106.206660] postgres[1472]: vm-test-run-plv8> server # [ 106.207687] postgres[1472]: END IF; vm-test-run-plv8> server # [ 106.207983] postgres[1472]: vm-test-run-plv8> server # [ 106.208987] postgres[1472]: END; vm-test-run-plv8> server # [ 106.210093] postgres[1472]: $$; vm-test-run-plv8> server # [ 106.213768] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: CREATE FUNCTION vm-test-run-plv8> server # [ 106.217667] postgres[1472]: ::1 2026-10-21 01:01:30.805 UTC [1472] 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 # [ 106.219610] postgres[1472]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 106.230567] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 106.232974] postgres[1472]: ::1 2026-10-21 01:01:30.823 UTC [1472] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-plv8> server # [ 106.243920] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: COMMENT vm-test-run-plv8> server # [ 106.250039] postgres[1472]: ::1 2026-10-21 01:01:30.837 UTC [1472] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-plv8> server # [ 106.250919] postgres[1472]: RETURNS event_trigger vm-test-run-plv8> server # [ 106.251222] postgres[1472]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 106.251461] postgres[1472]: AS $$ vm-test-run-plv8> server # [ 106.251782] postgres[1472]: BEGIN vm-test-run-plv8> server # [ 106.253436] postgres[1472]: IF EXISTS ( vm-test-run-plv8> server # [ 106.255025] postgres[1472]: SELECT 1 vm-test-run-plv8> server # [ 106.256507] postgres[1472]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 106.257198] postgres[1472]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 106.257494] postgres[1472]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 106.258778] postgres[1472]: WHERE ext.extname = 'pg_net' vm-test-run-plv8> server # [ 106.259626] postgres[1472]: ) vm-test-run-plv8> server # [ 106.261944] postgres[1472]: THEN vm-test-run-plv8> server # [ 106.263072] postgres[1472]: IF NOT EXISTS ( vm-test-run-plv8> server # [ 106.263738] postgres[1472]: SELECT 1 vm-test-run-plv8> server # [ 106.265935] postgres[1472]: FROM pg_roles vm-test-run-plv8> server # [ 106.267189] postgres[1472]: WHERE rolname = 'supabase_functions_admin' vm-test-run-plv8> server # [ 106.271333] postgres[1472]: ) vm-test-run-plv8> server # [ 106.271946] postgres[1472]: THEN vm-test-run-plv8> server # [ 106.273499] postgres[1472]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 106.278977] postgres[1472]: END IF; vm-test-run-plv8> server # [ 106.281176] postgres[1472]: vm-test-run-plv8> server # [ 106.281858] postgres[1472]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 106.285570] postgres[1472]: vm-test-run-plv8> server # [ 106.286613] postgres[1472]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 106.287444] postgres[1472]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 106.297914] postgres[1472]: vm-test-run-plv8> server # [ 106.302307] postgres[1472]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plv8> server # [ 106.314756] postgres[1472]: 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 # [ 106.317183] postgres[1472]: vm-test-run-plv8> server # [ 106.317568] postgres[1472]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plv8> server # [ 106.317939] postgres[1472]: 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 # [ 106.318852] postgres[1472]: vm-test-run-plv8> server # [ 106.319149] postgres[1472]: 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 # [ 106.319754] postgres[1472]: 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 # [ 106.323815] postgres[1472]: END IF; vm-test-run-plv8> server # [ 106.333085] postgres[1472]: END; vm-test-run-plv8> server # [ 106.335617] postgres[1472]: $$; vm-test-run-plv8> server # [ 106.338053] postgres[1472]: ::1 2026-10-21 01:01:30.862 UTC [1472] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-plv8> server # [ 106.342257] postgres[1472]: ::1 2026-10-21 01:01:30.900 UTC [1472] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-plv8> server # [ 106.351621] postgres[1472]: ::1 2026-10-21 01:01:30.919 UTC [1472] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-plv8> server # [ 106.357793] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: CREATE FUNCTION vm-test-run-plv8> server # [ 106.359193] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: COMMENT vm-test-run-plv8> server # [ 106.366074] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: DO vm-test-run-plv8> server # [ 106.366908] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: CREATE ROLE vm-test-run-plv8> server # [ 106.367238] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: GRANT vm-test-run-plv8> server # [ 106.367517] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: GRANT vm-test-run-plv8> server # [ 106.367978] postgres[1472]: ::1 2026-10-21 01:01:30.936 UTC [1472] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 106.379626] postgres[1472]: ::1 2026-10-21 01:01:30.944 UTC [1472] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 106.381287] postgres[1472]: ::1 2026-10-21 01:01:30.956 UTC [1472] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 106.383227] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: GRANT vm-test-run-plv8> server # [ 106.387329] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: GRANT vm-test-run-plv8> server # [ 106.395348] postgres[1472]: ::1 2026-10-21 01:01:30.977 UTC [1472] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 106.405968] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: GRANT vm-test-run-plv8> server # [ 106.417152] postgres[1472]: ::1 2026-10-21 01:01:31.000 UTC [1472] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 106.444792] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: GRANT vm-test-run-plv8> server # [ 106.446334] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: GRANT vm-test-run-plv8> server # [ 106.451582] postgres[1472]: ::1 2026-10-21 01:01:31.028 UTC [1472] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 106.453311] postgres[1472]: ::1 2026-10-21 01:01:31.031 UTC [1472] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 106.470296] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: GRANT vm-test-run-plv8> server # [ 106.477491] postgres[1472]: ::1 2026-10-21 01:01:31.057 UTC [1472] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 106.533994] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: GRANT vm-test-run-plv8> server # [ 106.558264] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1471]: DO vm-test-run-plv8> server # [ 106.628740] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running pgbouncer auth schema... vm-test-run-plv8> server # [ 107.105615] postgres[1483]: ::1 2026-10-21 01:01:31.683 UTC [1483] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-plv8> server # [ 107.133755] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1477]: CREATE ROLE vm-test-run-plv8> server # [ 107.134996] postgres[1483]: ::1 2026-10-21 01:01:31.710 UTC [1483] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-plv8> server # [ 107.144970] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1477]: REVOKE vm-test-run-plv8> server # [ 107.146971] postgres[1483]: ::1 2026-10-21 01:01:31.733 UTC [1483] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-plv8> server # [ 107.198155] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1477]: CREATE SCHEMA vm-test-run-plv8> server # [ 107.210264] postgres[1483]: ::1 2026-10-21 01:01:31.794 UTC [1483] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-plv8> server # [ 107.226692] postgres[1483]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-plv8> server # [ 107.239780] postgres[1483]: $$ vm-test-run-plv8> server # [ 107.241294] postgres[1483]: BEGIN vm-test-run-plv8> server # [ 107.241767] postgres[1483]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-plv8> server # [ 107.242288] postgres[1483]: vm-test-run-plv8> server # [ 107.242803] postgres[1483]: RETURN QUERY vm-test-run-plv8> server # [ 107.243110] postgres[1483]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-plv8> server # [ 107.253440] postgres[1483]: WHERE usename = p_usename; vm-test-run-plv8> server # [ 107.263502] postgres[1483]: END; vm-test-run-plv8> server # [ 107.264904] postgres[1483]: $$ LANGUAGE plpgsql vm-test-run-plv8> server # [ 107.265903] postgres[1483]: SET search_path = '' vm-test-run-plv8> server # [ 107.272888] postgres[1483]: SECURITY DEFINER; vm-test-run-plv8> server # [ 107.293281] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1477]: CREATE FUNCTION vm-test-run-plv8> server # [ 107.294750] postgres[1483]: ::1 2026-10-21 01:01:31.884 UTC [1483] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-plv8> server # [ 107.303583] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1477]: REVOKE vm-test-run-plv8> server # [ 107.310917] postgres[1483]: ::1 2026-10-21 01:01:31.894 UTC [1483] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-plv8> server # [ 107.314278] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1477]: GRANT vm-test-run-plv8> server # [ 107.354049] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running stat extension... vm-test-run-plv8> server # [ 107.795816] postgres[1496]: ::1 2026-10-21 01:01:32.379 UTC [1496] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-plv8> server # [ 107.807476] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1490]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-plv8> server # [ 107.840249] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1490]: CREATE SCHEMA vm-test-run-plv8> server # [ 107.841827] postgres[1496]: ::1 2026-10-21 01:01:32.432 UTC [1496] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-plv8> server # [ 108.902264] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1490]: CREATE EXTENSION vm-test-run-plv8> server # [ 108.947253] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-plv8> server # [ 109.208051] postgres[1506]: ::1 2026-10-21 01:01:33.791 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-plv8> server # [ 109.227723] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 109.233256] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 109.234668] postgres[1506]: ::1 2026-10-21 01:01:33.808 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 109.237217] postgres[1506]: ::1 2026-10-21 01:01:33.820 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 109.246088] postgres[1506]: ::1 2026-10-21 01:01:33.832 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 109.246853] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 109.254013] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 109.257202] postgres[1506]: ::1 2026-10-21 01:01:33.847 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 109.272759] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 109.277386] postgres[1506]: ::1 2026-10-21 01:01:33.860 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 109.283089] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 109.289923] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 109.290896] postgres[1506]: ::1 2026-10-21 01:01:33.870 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 109.291540] postgres[1506]: ::1 2026-10-21 01:01:33.876 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 109.301206] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 109.304941] postgres[1506]: ::1 2026-10-21 01:01:33.893 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 109.333843] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 109.353507] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1505]: DO vm-test-run-plv8> server # [ 109.356724] postgres[1506]: ::1 2026-10-21 01:01:33.945 UTC [1506] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-plv8> server # [ 109.369058] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1505]: ALTER ROLE vm-test-run-plv8> server # [ 109.401060] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-plv8> server # [ 109.660049] postgres[1508]: ::1 2026-10-21 01:01:34.233 UTC [1508] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.670185] postgres[1508]: ::1 2026-10-21 01:01:34.247 UTC [1508] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.682280] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: GRANT vm-test-run-plv8> server # [ 109.683175] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: GRANT vm-test-run-plv8> server # [ 109.685111] postgres[1508]: ::1 2026-10-21 01:01:34.263 UTC [1508] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.693482] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: GRANT vm-test-run-plv8> server # [ 109.696054] postgres[1508]: ::1 2026-10-21 01:01:34.286 UTC [1508] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.709207] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: ALTER TABLE vm-test-run-plv8> server # [ 109.710135] postgres[1508]: ::1 2026-10-21 01:01:34.298 UTC [1508] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.718842] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: ALTER TABLE vm-test-run-plv8> server # [ 109.719738] postgres[1508]: ::1 2026-10-21 01:01:34.309 UTC [1508] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.729939] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: ALTER TABLE vm-test-run-plv8> server # [ 109.731586] postgres[1508]: ::1 2026-10-21 01:01:34.320 UTC [1508] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.742370] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: ALTER TABLE vm-test-run-plv8> server # [ 109.747183] postgres[1508]: ::1 2026-10-21 01:01:34.332 UTC [1508] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.755027] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: ALTER TABLE vm-test-run-plv8> server # [ 109.756608] postgres[1508]: ::1 2026-10-21 01:01:34.342 UTC [1508] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 109.766296] postgres[1508]: ::1 2026-10-21 01:01:34.352 UTC [1508] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 109.767023] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: GRANT vm-test-run-plv8> server # [ 109.774381] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: GRANT vm-test-run-plv8> server # [ 109.776950] postgres[1508]: ::1 2026-10-21 01:01:34.366 UTC [1508] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 109.799981] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: GRANT vm-test-run-plv8> server # [ 109.806210] postgres[1508]: ::1 2026-10-21 01:01:34.392 UTC [1508] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 109.831017] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: GRANT vm-test-run-plv8> server # [ 109.837271] postgres[1508]: ::1 2026-10-21 01:01:34.422 UTC [1508] 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 # [ 109.859032] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 109.866810] postgres[1508]: ::1 2026-10-21 01:01:34.456 UTC [1508] 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 # [ 109.886768] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 109.897618] postgres[1508]: ::1 2026-10-21 01:01:34.481 UTC [1508] 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 # [ 109.917101] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1507]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 109.978235] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-plv8> server # [ 110.464025] postgres[1521]: ::1 2026-10-21 01:01:35.050 UTC [1521] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-plv8> server # [ 110.535583] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1516]: CREATE SCHEMA vm-test-run-plv8> server # [ 110.569907] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-plv8> server # [ 111.022073] postgres[1531]: ::1 2026-10-21 01:01:35.590 UTC [1531] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-plv8> server # [ 111.031658] postgres[1531]: ::1 2026-10-21 01:01:35.616 UTC [1531] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 111.047538] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1527]: GRANT vm-test-run-plv8> server # [ 111.054082] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1527]: GRANT vm-test-run-plv8> server # [ 111.066099] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1527]: GRANT vm-test-run-plv8> server # [ 111.067264] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1527]: GRANT vm-test-run-plv8> server # [ 111.067980] postgres[1531]: ::1 2026-10-21 01:01:35.631 UTC [1531] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 111.073847] postgres[1531]: ::1 2026-10-21 01:01:35.634 UTC [1531] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 111.142874] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-plv8> server # [ 111.548592] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1534]: DO vm-test-run-plv8> server # [ 111.553116] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1534]: DO vm-test-run-plv8> server # [ 111.562084] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1534]: DO vm-test-run-plv8> server # [ 111.604077] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-plv8> server # [ 111.849107] postgres[1540]: ::1 2026-10-21 01:01:36.428 UTC [1540] 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 # [ 111.864712] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1539]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 111.867867] postgres[1540]: ::1 2026-10-21 01:01:36.450 UTC [1540] 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 # [ 111.871991] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1539]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 111.873838] postgres[1540]: ::1 2026-10-21 01:01:36.464 UTC [1540] 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 # [ 111.883539] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1539]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 111.927126] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-plv8> server # [ 112.183806] postgres[1542]: ::1 2026-10-21 01:01:36.765 UTC [1542] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-plv8> server # [ 112.216498] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1541]: ALTER ROLE vm-test-run-plv8> server # [ 112.265671] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-plv8> server # [ 112.631752] postgres[1548]: ::1 2026-10-21 01:01:37.203 UTC [1548] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 112.639119] postgres[1548]: ::1 2026-10-21 01:01:37.218 UTC [1548] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 112.665025] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: 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 # [ 112.666160] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 112.667120] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: 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 # [ 112.668899] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: DROP FUNCTION vm-test-run-plv8> server # [ 112.669795] postgres[1548]: ::1 2026-10-21 01:01:37.231 UTC [1548] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 112.671129] postgres[1548]: DECLARE vm-test-run-plv8> server # [ 112.671432] postgres[1548]: cmd record; vm-test-run-plv8> server # [ 112.672309] postgres[1548]: BEGIN vm-test-run-plv8> server # [ 112.673699] postgres[1548]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 112.675243] postgres[1548]: LOOP vm-test-run-plv8> server # [ 112.677224] postgres[1548]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 112.677796] postgres[1548]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 112.678799] postgres[1548]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 112.679680] postgres[1548]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 112.680218] postgres[1548]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 112.681851] postgres[1548]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 112.688039] postgres[1548]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 112.690279] postgres[1548]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 112.691236] postgres[1548]: , 'CREATE TYPE' vm-test-run-plv8> server # [ 112.691588] postgres[1548]: , 'CREATE RULE' vm-test-run-plv8> server # [ 112.694878] postgres[1548]: , 'COMMENT' vm-test-run-plv8> server # [ 112.695334] postgres[1548]: ) vm-test-run-plv8> server # [ 112.698870] postgres[1548]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 112.700356] postgres[1548]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 112.702356] postgres[1548]: THEN vm-test-run-plv8> server # [ 112.705587] postgres[1548]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 112.709715] postgres[1548]: END IF; vm-test-run-plv8> server # [ 112.711114] postgres[1548]: END LOOP; vm-test-run-plv8> server # [ 112.711676] postgres[1548]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 112.714662] postgres[1548]: ::1 2026-10-21 01:01:37.260 UTC [1548] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 112.738951] postgres[1548]: DECLARE vm-test-run-plv8> server # [ 112.746336] postgres[1548]: obj record; vm-test-run-plv8> server # [ 112.747691] postgres[1548]: BEGIN vm-test-run-plv8> server # [ 112.748238] postgres[1548]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 112.755139] postgres[1548]: LOOP vm-test-run-plv8> server # [ 112.757060] postgres[1548]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 112.758740] postgres[1548]: 'schema' vm-test-run-plv8> server # [ 112.759136] postgres[1548]: , 'table' vm-test-run-plv8> server # [ 112.759507] postgres[1548]: , 'foreign table' vm-test-run-plv8> server # [ 112.761044] postgres[1548]: , 'view' vm-test-run-plv8> server # [ 112.761683] postgres[1548]: , 'materialized view' vm-test-run-plv8> server # [ 112.762306] postgres[1548]: , 'function' vm-test-run-plv8> server # [ 112.762793] postgres[1548]: , 'trigger' vm-test-run-plv8> server # [ 112.763502] postgres[1548]: , 'type' vm-test-run-plv8> server # [ 112.763941] postgres[1548]: , 'rule' vm-test-run-plv8> server # [ 112.764271] postgres[1548]: ) vm-test-run-plv8> server # [ 112.764501] postgres[1548]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 112.767182] postgres[1548]: THEN vm-test-run-plv8> server # [ 112.768407] postgres[1548]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 112.769650] postgres[1548]: END IF; vm-test-run-plv8> server # [ 112.770584] postgres[1548]: END LOOP; vm-test-run-plv8> server # [ 112.771012] postgres[1548]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 112.772862] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: CREATE FUNCTION vm-test-run-plv8> server # [ 112.774143] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: CREATE FUNCTION vm-test-run-plv8> server # [ 112.774654] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: 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 # [ 112.775265] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 112.775546] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 112.775948] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: 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 # [ 112.777333] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 112.779388] postgres[1548]: ::1 2026-10-21 01:01:37.297 UTC [1548] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 112.781567] postgres[1548]: ::1 2026-10-21 01:01:37.308 UTC [1548] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 112.782532] postgres[1548]: ON ddl_command_end vm-test-run-plv8> server # [ 112.783118] postgres[1548]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 112.783882] postgres[1548]: ::1 2026-10-21 01:01:37.328 UTC [1548] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 112.784684] postgres[1548]: ::1 2026-10-21 01:01:37.341 UTC [1548] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 112.785783] postgres[1548]: ON sql_drop vm-test-run-plv8> server # [ 112.786647] postgres[1548]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 112.787556] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1546]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 112.833574] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-plv8> server # [ 114.148727] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1549]: DO vm-test-run-plv8> server # [ 114.215397] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-plv8> server # [ 114.674075] postgres[1576]: ::1 2026-10-21 01:01:39.248 UTC [1576] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-plv8> server # [ 114.716258] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: CREATE SCHEMA vm-test-run-plv8> server # [ 114.728135] postgres[1576]: ::1 2026-10-21 01:01:39.310 UTC [1576] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-plv8> server # [ 114.733868] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: 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 # [ 114.734976] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: DROP FUNCTION vm-test-run-plv8> server # [ 114.746403] postgres[1576]: ::1 2026-10-21 01:01:39.331 UTC [1576] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 114.747942] postgres[1576]: "operationName" text default null, vm-test-run-plv8> server # [ 114.749208] postgres[1576]: query text default null, vm-test-run-plv8> server # [ 114.750099] postgres[1576]: variables jsonb default null, vm-test-run-plv8> server # [ 114.750651] postgres[1576]: extensions jsonb default null vm-test-run-plv8> server # [ 114.751000] postgres[1576]: ) vm-test-run-plv8> server # [ 114.751598] postgres[1576]: returns jsonb vm-test-run-plv8> server # [ 114.751876] postgres[1576]: language plpgsql vm-test-run-plv8> server # [ 114.752541] postgres[1576]: as $$ vm-test-run-plv8> server # [ 114.762079] postgres[1576]: DECLARE vm-test-run-plv8> server # [ 114.762659] postgres[1576]: server_version float; vm-test-run-plv8> server # [ 114.763336] postgres[1576]: BEGIN vm-test-run-plv8> server # [ 114.764232] postgres[1576]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 114.773220] postgres[1576]: vm-test-run-plv8> server # [ 114.773818] postgres[1576]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 114.774622] postgres[1576]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 114.775022] postgres[1576]: 'data', null::jsonb, vm-test-run-plv8> server # [ 114.775464] postgres[1576]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 114.775748] postgres[1576]: ); vm-test-run-plv8> server # [ 114.790764] postgres[1576]: ELSE vm-test-run-plv8> server # [ 114.791913] postgres[1576]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 114.814597] postgres[1576]: 'data', null::jsonb, vm-test-run-plv8> server # [ 114.815117] postgres[1576]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 114.829621] postgres[1576]: ); vm-test-run-plv8> server # [ 114.830257] postgres[1576]: END IF; vm-test-run-plv8> server # [ 114.830912] postgres[1576]: END; vm-test-run-plv8> server # [ 114.831181] postgres[1576]: $$; vm-test-run-plv8> server # [ 114.831642] postgres[1576]: ::1 2026-10-21 01:01:39.388 UTC [1576] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 114.832020] postgres[1576]: ::1 2026-10-21 01:01:39.404 UTC [1576] 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 # [ 114.832366] postgres[1576]: ::1 2026-10-21 01:01:39.421 UTC [1576] 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 # [ 114.858899] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: CREATE FUNCTION vm-test-run-plv8> server # [ 114.859448] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: GRANT vm-test-run-plv8> server # [ 114.872892] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 114.873723] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 114.875226] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 114.876046] postgres[1576]: ::1 2026-10-21 01:01:39.433 UTC [1576] 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 # [ 114.882978] postgres[1576]: ::1 2026-10-21 01:01:39.445 UTC [1576] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 114.883734] postgres[1576]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 114.884600] postgres[1576]: ::1 2026-10-21 01:01:39.455 UTC [1576] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 114.885054] postgres[1576]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 114.892673] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 114.895293] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 114.895919] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 114.901368] postgres[1576]: ::1 2026-10-21 01:01:39.468 UTC [1576] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 114.906053] postgres[1576]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 114.906923] postgres[1576]: ::1 2026-10-21 01:01:39.482 UTC [1576] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 114.909351] postgres[1576]: RETURNS event_trigger vm-test-run-plv8> server # [ 114.910150] postgres[1576]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 114.910778] postgres[1576]: AS $func$ vm-test-run-plv8> server # [ 114.911088] postgres[1576]: DECLARE vm-test-run-plv8> server # [ 114.911338] postgres[1576]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 114.911594] postgres[1576]: BEGIN vm-test-run-plv8> server # [ 114.911818] postgres[1576]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 114.912248] postgres[1576]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 114.914046] postgres[1576]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 114.914674] postgres[1576]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 114.915307] postgres[1576]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 114.915965] postgres[1576]: ); vm-test-run-plv8> server # [ 114.916215] postgres[1576]: vm-test-run-plv8> server # [ 114.920036] postgres[1576]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 114.921309] postgres[1576]: THEN vm-test-run-plv8> server # [ 114.921759] postgres[1576]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 114.922123] postgres[1576]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 114.922668] postgres[1576]: vm-test-run-plv8> server # [ 114.923318] postgres[1576]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 114.923680] postgres[1576]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 114.925137] postgres[1576]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 114.926087] postgres[1576]: vm-test-run-plv8> server # [ 114.926352] postgres[1576]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 114.926650] postgres[1576]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 114.926965] postgres[1576]: "operationName" text default null, vm-test-run-plv8> server # [ 114.928075] postgres[1576]: query text default null, vm-test-run-plv8> server # [ 114.929769] postgres[1576]: variables jsonb default null, vm-test-run-plv8> server # [ 114.931455] postgres[1576]: extensions jsonb default null vm-test-run-plv8> server # [ 114.932009] postgres[1576]: ) vm-test-run-plv8> server # [ 114.932312] postgres[1576]: returns jsonb vm-test-run-plv8> server # [ 114.932829] postgres[1576]: language sql vm-test-run-plv8> server # [ 114.933364] postgres[1576]: as $$ vm-test-run-plv8> server # [ 114.934042] postgres[1576]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-plv8> server # [ 114.939226] postgres[1576]: $$; vm-test-run-plv8> server # [ 114.946039] postgres[1576]: vm-test-run-plv8> server # [ 114.947004] postgres[1576]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 114.954790] postgres[1576]: END IF; vm-test-run-plv8> server # [ 114.955997] postgres[1576]: vm-test-run-plv8> server # [ 114.960813] postgres[1576]: END; vm-test-run-plv8> server # [ 114.961397] postgres[1576]: $func$; vm-test-run-plv8> server # [ 114.974009] postgres[1576]: ::1 2026-10-21 01:01:39.526 UTC [1576] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-plv8> server # [ 114.975635] postgres[1576]: ::1 2026-10-21 01:01:39.542 UTC [1576] 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 # [ 114.982985] postgres[1576]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-plv8> server # [ 114.995139] postgres[1576]: ::1 2026-10-21 01:01:39.560 UTC [1576] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-plv8> server # [ 114.999568] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: CREATE FUNCTION vm-test-run-plv8> server # [ 115.000074] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: 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 # [ 115.005865] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 115.007263] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 115.007960] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: COMMENT vm-test-run-plv8> server # [ 115.028591] postgres[1576]: ::1 2026-10-21 01:01:39.588 UTC [1576] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 115.030811] postgres[1576]: RETURNS event_trigger vm-test-run-plv8> server # [ 115.031535] postgres[1576]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 115.032028] postgres[1576]: AS $func$ vm-test-run-plv8> server # [ 115.033688] postgres[1576]: DECLARE vm-test-run-plv8> server # [ 115.034383] postgres[1576]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 115.034967] postgres[1576]: BEGIN vm-test-run-plv8> server # [ 115.035211] postgres[1576]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 115.035461] postgres[1576]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 115.035718] postgres[1576]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 115.035958] postgres[1576]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 115.036184] postgres[1576]: ); vm-test-run-plv8> server # [ 115.039311] postgres[1576]: vm-test-run-plv8> server # [ 115.042382] postgres[1576]: IF graphql_is_dropped vm-test-run-plv8> server # [ 115.047913] postgres[1576]: THEN vm-test-run-plv8> server # [ 115.050144] postgres[1576]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 115.050836] postgres[1576]: "operationName" text default null, vm-test-run-plv8> server # [ 115.051131] postgres[1576]: query text default null, vm-test-run-plv8> server # [ 115.051547] postgres[1576]: variables jsonb default null, vm-test-run-plv8> server # [ 115.051811] postgres[1576]: extensions jsonb default null vm-test-run-plv8> server # [ 115.052046] postgres[1576]: ) vm-test-run-plv8> server # [ 115.052254] postgres[1576]: returns jsonb vm-test-run-plv8> server # [ 115.052463] postgres[1576]: language plpgsql vm-test-run-plv8> server # [ 115.052680] postgres[1576]: as $$ vm-test-run-plv8> server # [ 115.052879] postgres[1576]: DECLARE vm-test-run-plv8> server # [ 115.053082] postgres[1576]: server_version float; vm-test-run-plv8> server # [ 115.053292] postgres[1576]: BEGIN vm-test-run-plv8> server # [ 115.053490] postgres[1576]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 115.053735] postgres[1576]: vm-test-run-plv8> server # [ 115.053918] postgres[1576]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 115.054151] postgres[1576]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 115.054394] postgres[1576]: 'data', null::jsonb, vm-test-run-plv8> server # [ 115.055885] postgres[1576]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 115.057175] postgres[1576]: ); vm-test-run-plv8> server # [ 115.057641] postgres[1576]: ELSE vm-test-run-plv8> server # [ 115.057900] postgres[1576]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 115.058138] postgres[1576]: 'data', null::jsonb, vm-test-run-plv8> server # [ 115.058390] postgres[1576]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 115.059078] postgres[1576]: ); vm-test-run-plv8> server # [ 115.059372] postgres[1576]: END IF; vm-test-run-plv8> server # [ 115.059629] postgres[1576]: END; vm-test-run-plv8> server # [ 115.060290] postgres[1576]: $$; vm-test-run-plv8> server # [ 115.061491] postgres[1576]: END IF; vm-test-run-plv8> server # [ 115.062174] postgres[1576]: vm-test-run-plv8> server # [ 115.062681] postgres[1576]: END; vm-test-run-plv8> server # [ 115.063106] postgres[1576]: $func$; vm-test-run-plv8> server # [ 115.063920] postgres[1576]: ::1 2026-10-21 01:01:39.636 UTC [1576] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-plv8> server # [ 115.064731] postgres[1576]: ::1 2026-10-21 01:01:39.649 UTC [1576] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-plv8> server # [ 115.066696] postgres[1576]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-plv8> server # [ 115.067220] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: CREATE FUNCTION vm-test-run-plv8> server # [ 115.068906] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: 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 # [ 115.069875] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 115.077003] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 115.081081] postgres[1576]: ::1 2026-10-21 01:01:39.668 UTC [1576] 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 # [ 115.097078] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1573]: COMMENT vm-test-run-plv8> server # [ 115.129795] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-plv8> server # [ 115.409441] postgres[1578]: ::1 2026-10-21 01:01:39.975 UTC [1578] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 115.411676] postgres[1578]: ::1 2026-10-21 01:01:39.992 UTC [1578] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 115.422245] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1577]: 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 # [ 115.423736] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1577]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 115.425008] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1577]: 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 # [ 115.426312] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1577]: DROP FUNCTION vm-test-run-plv8> server # [ 115.428542] postgres[1578]: ::1 2026-10-21 01:01:40.018 UTC [1578] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 115.431567] postgres[1578]: DECLARE vm-test-run-plv8> server # [ 115.432014] postgres[1578]: cmd record; vm-test-run-plv8> server # [ 115.432517] postgres[1578]: BEGIN vm-test-run-plv8> server # [ 115.437986] postgres[1578]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 115.438723] postgres[1578]: LOOP vm-test-run-plv8> server # [ 115.443190] postgres[1578]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 115.444039] postgres[1578]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 115.447335] postgres[1578]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 115.448012] postgres[1578]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 115.449673] postgres[1578]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 115.450251] postgres[1578]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 115.451608] postgres[1578]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 115.453483] postgres[1578]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 115.453929] postgres[1578]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-plv8> server # [ 115.454598] postgres[1578]: , 'CREATE RULE' vm-test-run-plv8> server # [ 115.455685] postgres[1578]: , 'COMMENT' vm-test-run-plv8> server # [ 115.457621] postgres[1578]: ) vm-test-run-plv8> server # [ 115.459093] postgres[1578]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 115.459860] postgres[1578]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 115.461278] postgres[1578]: THEN vm-test-run-plv8> server # [ 115.462531] postgres[1578]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 115.462897] postgres[1578]: END IF; vm-test-run-plv8> server # [ 115.463140] postgres[1578]: END LOOP; vm-test-run-plv8> server # [ 115.463572] postgres[1578]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 115.491818] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1577]: CREATE FUNCTION vm-test-run-plv8> server # [ 115.495966] postgres[1578]: ::1 2026-10-21 01:01:40.085 UTC [1578] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 115.498343] postgres[1578]: DECLARE vm-test-run-plv8> server # [ 115.499100] postgres[1578]: obj record; vm-test-run-plv8> server # [ 115.499399] postgres[1578]: BEGIN vm-test-run-plv8> server # [ 115.499618] postgres[1578]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 115.500039] postgres[1578]: LOOP vm-test-run-plv8> server # [ 115.501718] postgres[1578]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 115.502227] postgres[1578]: 'schema' vm-test-run-plv8> server # [ 115.504138] postgres[1578]: , 'table' vm-test-run-plv8> server # [ 115.506068] postgres[1578]: , 'foreign table' vm-test-run-plv8> server # [ 115.506758] postgres[1578]: , 'view' vm-test-run-plv8> server # [ 115.507059] postgres[1578]: , 'materialized view' vm-test-run-plv8> server # [ 115.508197] postgres[1578]: , 'function' vm-test-run-plv8> server # [ 115.509829] postgres[1578]: , 'trigger' vm-test-run-plv8> server # [ 115.510277] postgres[1578]: , 'type' vm-test-run-plv8> server # [ 115.510693] postgres[1578]: , 'rule' vm-test-run-plv8> server # [ 115.511409] postgres[1578]: ) vm-test-run-plv8> server # [ 115.511837] postgres[1578]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 115.512125] postgres[1578]: THEN vm-test-run-plv8> server # [ 115.513090] postgres[1578]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 115.513545] postgres[1578]: END IF; vm-test-run-plv8> server # [ 115.513872] postgres[1578]: END LOOP; vm-test-run-plv8> server # [ 115.514100] postgres[1578]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 115.529085] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1577]: CREATE FUNCTION vm-test-run-plv8> server # [ 115.530879] postgres[1578]: ::1 2026-10-21 01:01:40.121 UTC [1578] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 115.541367] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1577]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 115.543914] postgres[1578]: ::1 2026-10-21 01:01:40.134 UTC [1578] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 115.549882] postgres[1578]: ON ddl_command_end vm-test-run-plv8> server # [ 115.550765] postgres[1578]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 115.555742] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1577]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 115.557593] postgres[1578]: ::1 2026-10-21 01:01:40.148 UTC [1578] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 115.567516] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1577]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 115.569297] postgres[1578]: ::1 2026-10-21 01:01:40.158 UTC [1578] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 115.570748] postgres[1578]: ON sql_drop vm-test-run-plv8> server # [ 115.571698] postgres[1578]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 115.579958] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1577]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 115.645079] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-plv8> server # [ 115.889056] postgres[1580]: ::1 2026-10-21 01:01:40.466 UTC [1580] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-plv8> server # [ 115.914305] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1579]: ALTER ROLE vm-test-run-plv8> server # [ 115.964359] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-plv8> server # [ 116.445635] postgres[1587]: ::1 2026-10-21 01:01:41.017 UTC [1587] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 116.454260] postgres[1587]: returns event_trigger vm-test-run-plv8> server # [ 116.465299] postgres[1587]: language plpgsql vm-test-run-plv8> server # [ 116.466665] postgres[1587]: AS $func$ vm-test-run-plv8> server # [ 116.467191] postgres[1587]: DECLARE vm-test-run-plv8> server # [ 116.467453] postgres[1587]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 116.467931] postgres[1587]: BEGIN vm-test-run-plv8> server # [ 116.481631] postgres[1587]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 116.482102] postgres[1587]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 116.482373] postgres[1587]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 116.483202] postgres[1587]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 116.483506] postgres[1587]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 116.483756] postgres[1587]: ); vm-test-run-plv8> server # [ 116.483975] postgres[1587]: vm-test-run-plv8> server # [ 116.489189] postgres[1587]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 116.489899] postgres[1587]: THEN vm-test-run-plv8> server # [ 116.490197] postgres[1587]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.490838] postgres[1587]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.491978] postgres[1587]: vm-test-run-plv8> server # [ 116.497995] postgres[1587]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.500138] postgres[1587]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.506593] postgres[1587]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.507784] postgres[1587]: vm-test-run-plv8> server # [ 116.508157] postgres[1587]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 116.516047] postgres[1587]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 116.531637] postgres[1587]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 116.539423] postgres[1587]: "operationName" text default null, vm-test-run-plv8> server # [ 116.546967] postgres[1587]: query text default null, vm-test-run-plv8> server # [ 116.547715] postgres[1587]: variables jsonb default null, vm-test-run-plv8> server # [ 116.557460] postgres[1587]: extensions jsonb default null vm-test-run-plv8> server # [ 116.558101] postgres[1587]: ) vm-test-run-plv8> server # [ 116.558810] postgres[1587]: returns jsonb vm-test-run-plv8> server # [ 116.565134] postgres[1587]: language sql vm-test-run-plv8> server # [ 116.567433] postgres[1587]: as $$ vm-test-run-plv8> server # [ 116.573786] postgres[1587]: -- This changed vm-test-run-plv8> server # [ 116.582165] postgres[1587]: select graphql.resolve( vm-test-run-plv8> server # [ 116.589613] postgres[1587]: query := query, vm-test-run-plv8> server # [ 116.593170] postgres[1587]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 116.595949] postgres[1587]: "operationName" := "operationName", vm-test-run-plv8> server # [ 116.601968] postgres[1587]: extensions := extensions vm-test-run-plv8> server # [ 116.603077] postgres[1587]: ); vm-test-run-plv8> server # [ 116.603770] postgres[1587]: $$; vm-test-run-plv8> server # [ 116.612679] postgres[1587]: vm-test-run-plv8> server # [ 116.613620] postgres[1587]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 116.615312] postgres[1587]: END IF; vm-test-run-plv8> server # [ 116.622056] postgres[1587]: vm-test-run-plv8> server # [ 116.623769] postgres[1587]: END; vm-test-run-plv8> server # [ 116.630691] postgres[1587]: $func$; vm-test-run-plv8> server # [ 116.667161] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1581]: CREATE FUNCTION vm-test-run-plv8> server # [ 116.668689] postgres[1587]: ::1 2026-10-21 01:01:41.246 UTC [1587] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 116.684051] postgres[1587]: RETURNS event_trigger vm-test-run-plv8> server # [ 116.694796] postgres[1587]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 116.696005] postgres[1587]: AS $func$ vm-test-run-plv8> server # [ 116.698826] postgres[1587]: DECLARE vm-test-run-plv8> server # [ 116.699907] postgres[1587]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 116.701209] postgres[1587]: BEGIN vm-test-run-plv8> server # [ 116.716778] postgres[1587]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 116.718551] postgres[1587]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 116.719751] postgres[1587]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 116.720654] postgres[1587]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 116.731319] postgres[1587]: ); vm-test-run-plv8> server # [ 116.732070] postgres[1587]: vm-test-run-plv8> server # [ 116.732352] postgres[1587]: IF graphql_is_dropped vm-test-run-plv8> server # [ 116.740859] postgres[1587]: THEN vm-test-run-plv8> server # [ 116.743265] postgres[1587]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 116.751127] postgres[1587]: "operationName" text default null, vm-test-run-plv8> server # [ 116.753012] postgres[1587]: query text default null, vm-test-run-plv8> server # [ 116.756258] postgres[1587]: variables jsonb default null, vm-test-run-plv8> server # [ 116.763555] postgres[1587]: extensions jsonb default null vm-test-run-plv8> server # [ 116.765180] postgres[1587]: ) vm-test-run-plv8> server # [ 116.767690] postgres[1587]: returns jsonb vm-test-run-plv8> server # [ 116.769019] postgres[1587]: language plpgsql vm-test-run-plv8> server # [ 116.769748] postgres[1587]: as $$ vm-test-run-plv8> server # [ 116.770782] postgres[1587]: DECLARE vm-test-run-plv8> server # [ 116.772902] postgres[1587]: server_version float; vm-test-run-plv8> server # [ 116.773822] postgres[1587]: BEGIN vm-test-run-plv8> server # [ 116.775123] postgres[1587]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 116.776535] postgres[1587]: vm-test-run-plv8> server # [ 116.778025] postgres[1587]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 116.781676] postgres[1587]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 116.782185] postgres[1587]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 116.783350] postgres[1587]: jsonb_build_object( vm-test-run-plv8> server # [ 116.783762] postgres[1587]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 116.784246] postgres[1587]: ) vm-test-run-plv8> server # [ 116.784829] postgres[1587]: ) vm-test-run-plv8> server # [ 116.788541] postgres[1587]: ); vm-test-run-plv8> server # [ 116.793699] postgres[1587]: ELSE vm-test-run-plv8> server # [ 116.795063] postgres[1587]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 116.796223] postgres[1587]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 116.799386] postgres[1587]: jsonb_build_object( vm-test-run-plv8> server # [ 116.805107] postgres[1587]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 116.823111] postgres[1587]: ) vm-test-run-plv8> server # [ 116.825231] postgres[1587]: ) vm-test-run-plv8> server # [ 116.826008] postgres[1587]: ); vm-test-run-plv8> server # [ 116.826337] postgres[1587]: END IF; vm-test-run-plv8> server # [ 116.827249] postgres[1587]: END; vm-test-run-plv8> server # [ 116.827559] postgres[1587]: $$; vm-test-run-plv8> server # [ 116.827818] postgres[1587]: END IF; vm-test-run-plv8> server # [ 116.828052] postgres[1587]: vm-test-run-plv8> server # [ 116.837263] postgres[1587]: END; vm-test-run-plv8> server # [ 116.839713] postgres[1587]: $func$; vm-test-run-plv8> server # [ 116.843020] postgres[1587]: ::1 2026-10-21 01:01:41.313 UTC [1587] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 116.843957] postgres[1587]: "operationName" text default null, vm-test-run-plv8> server # [ 116.853475] postgres[1587]: query text default null, vm-test-run-plv8> server # [ 116.861269] postgres[1587]: variables jsonb default null, vm-test-run-plv8> server # [ 116.862040] postgres[1587]: extensions jsonb default null vm-test-run-plv8> server # [ 116.863124] postgres[1587]: ) vm-test-run-plv8> server # [ 116.863480] postgres[1587]: returns jsonb vm-test-run-plv8> server # [ 116.863921] postgres[1587]: language plpgsql vm-test-run-plv8> server # [ 116.889261] postgres[1587]: as $$ vm-test-run-plv8> server # [ 116.909341] postgres[1587]: DECLARE vm-test-run-plv8> server # [ 116.910117] postgres[1587]: server_version float; vm-test-run-plv8> server # [ 116.910448] postgres[1587]: BEGIN vm-test-run-plv8> server # [ 116.910995] postgres[1587]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 116.911778] postgres[1587]: vm-test-run-plv8> server # [ 116.912057] postgres[1587]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 116.916805] postgres[1587]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 116.918040] postgres[1587]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 116.933558] postgres[1587]: jsonb_build_object( vm-test-run-plv8> server # [ 116.937181] postgres[1587]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 116.941669] postgres[1587]: ) vm-test-run-plv8> server # [ 116.943722] postgres[1587]: ) vm-test-run-plv8> server # [ 116.965519] postgres[1587]: ); vm-test-run-plv8> server # [ 116.967224] postgres[1587]: ELSE vm-test-run-plv8> server # [ 116.981667] postgres[1587]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 116.984661] postgres[1587]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 117.005641] postgres[1587]: jsonb_build_object( vm-test-run-plv8> server # [ 117.015151] postgres[1587]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 117.028961] postgres[1587]: ) vm-test-run-plv8> server # [ 117.029620] postgres[1587]: ) vm-test-run-plv8> server # [ 117.035130] postgres[1587]: ); vm-test-run-plv8> server # [ 117.035615] postgres[1587]: END IF; vm-test-run-plv8> server # [ 117.035867] postgres[1587]: END; vm-test-run-plv8> server # [ 117.036089] postgres[1587]: $$; vm-test-run-plv8> server # [ 117.036303] postgres[1587]: ::1 2026-10-21 01:01:41.382 UTC [1587] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 117.050217] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1581]: CREATE FUNCTION vm-test-run-plv8> server # [ 117.051249] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1581]: CREATE FUNCTION vm-test-run-plv8> server # [ 117.051599] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1581]: 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 # [ 117.059526] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1581]: DROP EXTENSION vm-test-run-plv8> server # [ 118.989757] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1581]: DO vm-test-run-plv8> server # [ 119.038158] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: 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 # [ 119.321896] postgres[1612]: ::1 2026-10-21 01:01:43.909 UTC [1612] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-plv8> server # [ 119.361599] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1611]: GRANT ROLE vm-test-run-plv8> server # [ 119.387239] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-plv8> server # [ 119.646799] postgres[1614]: ::1 2026-10-21 01:01:44.232 UTC [1614] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 119.649460] postgres[1614]: returns event_trigger vm-test-run-plv8> server # [ 119.650364] postgres[1614]: language plpgsql vm-test-run-plv8> server # [ 119.651586] postgres[1614]: AS $func$ vm-test-run-plv8> server # [ 119.652315] postgres[1614]: DECLARE vm-test-run-plv8> server # [ 119.653641] postgres[1614]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 119.654199] postgres[1614]: BEGIN vm-test-run-plv8> server # [ 119.654958] postgres[1614]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 119.655591] postgres[1614]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 119.656130] postgres[1614]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 119.657389] postgres[1614]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 119.658182] postgres[1614]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 119.658625] postgres[1614]: ); vm-test-run-plv8> server # [ 119.658897] postgres[1614]: vm-test-run-plv8> server # [ 119.659310] postgres[1614]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 119.659579] postgres[1614]: THEN vm-test-run-plv8> server # [ 119.659833] postgres[1614]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 119.660167] postgres[1614]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 119.660405] postgres[1614]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 119.660646] postgres[1614]: "operationName" text default null, vm-test-run-plv8> server # [ 119.662049] postgres[1614]: query text default null, vm-test-run-plv8> server # [ 119.662992] postgres[1614]: variables jsonb default null, vm-test-run-plv8> server # [ 119.664145] postgres[1614]: extensions jsonb default null vm-test-run-plv8> server # [ 119.665980] postgres[1614]: ) vm-test-run-plv8> server # [ 119.666694] postgres[1614]: returns jsonb vm-test-run-plv8> server # [ 119.667156] postgres[1614]: language sql vm-test-run-plv8> server # [ 119.667418] postgres[1614]: as $$ vm-test-run-plv8> server # [ 119.667676] postgres[1614]: select graphql.resolve( vm-test-run-plv8> server # [ 119.667930] postgres[1614]: query := query, vm-test-run-plv8> server # [ 119.668159] postgres[1614]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 119.669494] postgres[1614]: "operationName" := "operationName", vm-test-run-plv8> server # [ 119.669899] postgres[1614]: extensions := extensions vm-test-run-plv8> server # [ 119.670303] postgres[1614]: ); vm-test-run-plv8> server # [ 119.670731] postgres[1614]: $$; vm-test-run-plv8> server # [ 119.671094] postgres[1614]: vm-test-run-plv8> server # [ 119.671450] postgres[1614]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 119.673035] postgres[1614]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 119.673700] postgres[1614]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 119.674235] postgres[1614]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.674635] postgres[1614]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.675665] postgres[1614]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.677917] postgres[1614]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.678331] postgres[1614]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.679014] postgres[1614]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.679658] postgres[1614]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.681440] postgres[1614]: END IF; vm-test-run-plv8> server # [ 119.681957] postgres[1614]: vm-test-run-plv8> server # [ 119.682214] postgres[1614]: END; vm-test-run-plv8> server # [ 119.683670] postgres[1614]: $func$; vm-test-run-plv8> server # [ 119.768957] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1613]: CREATE FUNCTION vm-test-run-plv8> server # [ 119.785356] postgres[1614]: ::1 2026-10-21 01:01:44.350 UTC [1614] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 119.881414] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1613]: DROP EXTENSION vm-test-run-plv8> server # [ 121.706584] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1613]: DO vm-test-run-plv8> server # [ 121.752632] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-plv8> server # [ 122.811183] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1639]: DO vm-test-run-plv8> server # [ 123.845168] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1639]: DO vm-test-run-plv8> server # [ 123.897755] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-plv8> server # [ 124.334452] postgres[1666]: ::1 2026-10-21 01:01:48.910 UTC [1666] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-plv8> server # [ 124.364079] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1661]: ALTER ROLE vm-test-run-plv8> server # [ 124.419489] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-plv8> server # [ 124.801011] postgres[1672]: ::1 2026-10-21 01:01:49.380 UTC [1672] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-plv8> server # [ 124.826026] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1670]: REVOKE ROLE vm-test-run-plv8> server # [ 124.858677] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-plv8> server # [ 127.383625] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1673]: DO vm-test-run-plv8> server # [ 127.422398] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-plv8> server # [ 127.747764] postgres[1700]: ::1 2026-10-21 01:01:52.334 UTC [1700] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-plv8> server # [ 127.783471] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1698]: GRANT ROLE vm-test-run-plv8> server # [ 127.819853] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-plv8> server # [ 128.089170] postgres[1702]: ::1 2026-10-21 01:01:52.662 UTC [1702] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 128.120888] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1701]: GRANT vm-test-run-plv8> server # [ 128.125397] postgres[1702]: ::1 2026-10-21 01:01:52.713 UTC [1702] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 128.176969] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1701]: GRANT vm-test-run-plv8> server # [ 128.178562] postgres[1702]: ::1 2026-10-21 01:01:52.767 UTC [1702] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 128.192006] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1701]: GRANT vm-test-run-plv8> server # [ 128.199653] postgres[1702]: ::1 2026-10-21 01:01:52.785 UTC [1702] 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 # [ 128.229307] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1701]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 128.236980] postgres[1702]: ::1 2026-10-21 01:01:52.822 UTC [1702] 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 # [ 128.247319] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1701]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 128.256946] postgres[1702]: ::1 2026-10-21 01:01:52.840 UTC [1702] 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 # [ 128.266523] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1701]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 128.326485] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-plv8> server # [ 128.699749] postgres[1708]: ::1 2026-10-21 01:01:53.277 UTC [1708] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-plv8> server # [ 128.729808] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1706]: GRANT ROLE vm-test-run-plv8> server # [ 128.785094] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 129.166358] postgres[1710]: ::1 2026-10-21 01:01:53.753 UTC [1710] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-plv8> server # [ 129.213488] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1709]: GRANT ROLE vm-test-run-plv8> server # [ 129.257060] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-plv8> server # [ 129.656881] postgres[1719]: ::1 2026-10-21 01:01:54.240 UTC [1719] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-plv8> server # [ 129.678478] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1713]: ALTER ROLE vm-test-run-plv8> server # [ 129.679398] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1713]: ALTER ROLE vm-test-run-plv8> server # [ 129.685515] postgres[1719]: ::1 2026-10-21 01:01:54.259 UTC [1719] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-plv8> server # [ 129.686891] postgres[1719]: ::1 2026-10-21 01:01:54.269 UTC [1719] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-plv8> server # [ 129.687601] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1713]: ALTER ROLE vm-test-run-plv8> server # [ 129.733958] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1713]: DO vm-test-run-plv8> server # [ 129.792173] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 130.259790] postgres[1728]: ::1 2026-10-21 01:01:54.818 UTC [1728] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-plv8> server # [ 130.292307] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1723]: GRANT ROLE vm-test-run-plv8> server # [ 130.295035] postgres[1728]: ::1 2026-10-21 01:01:54.873 UTC [1728] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-plv8> server # [ 130.313215] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1723]: REVOKE ROLE vm-test-run-plv8> server # [ 130.366180] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-plv8> server # [ 130.800896] postgres[1740]: ::1 2026-10-21 01:01:55.377 UTC [1740] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 130.807900] postgres[1740]: returns event_trigger vm-test-run-plv8> server # [ 130.817951] postgres[1740]: language plpgsql vm-test-run-plv8> server # [ 130.819115] postgres[1740]: AS $func$ vm-test-run-plv8> server # [ 130.819927] postgres[1740]: DECLARE vm-test-run-plv8> server # [ 130.827570] postgres[1740]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 130.835241] postgres[1740]: BEGIN vm-test-run-plv8> server # [ 130.837472] postgres[1740]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 130.838821] postgres[1740]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 130.842894] postgres[1740]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 130.850687] postgres[1740]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 130.851285] postgres[1740]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 130.851866] postgres[1740]: ); vm-test-run-plv8> server # [ 130.852184] postgres[1740]: vm-test-run-plv8> server # [ 130.865192] postgres[1740]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 130.869625] postgres[1740]: THEN vm-test-run-plv8> server # [ 130.870154] postgres[1740]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 130.870997] postgres[1740]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 130.871518] postgres[1740]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 130.871824] postgres[1740]: "operationName" text default null, vm-test-run-plv8> server # [ 130.872094] postgres[1740]: query text default null, vm-test-run-plv8> server # [ 130.881510] postgres[1740]: variables jsonb default null, vm-test-run-plv8> server # [ 130.882144] postgres[1740]: extensions jsonb default null vm-test-run-plv8> server # [ 130.882521] postgres[1740]: ) vm-test-run-plv8> server # [ 130.882789] postgres[1740]: returns jsonb vm-test-run-plv8> server # [ 130.883057] postgres[1740]: language sql vm-test-run-plv8> server # [ 130.883312] postgres[1740]: as $$ vm-test-run-plv8> server # [ 130.883543] postgres[1740]: select graphql.resolve( vm-test-run-plv8> server # [ 130.883785] postgres[1740]: query := query, vm-test-run-plv8> server # [ 130.884012] postgres[1740]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 130.898735] postgres[1740]: "operationName" := "operationName", vm-test-run-plv8> server # [ 130.899531] postgres[1740]: extensions := extensions vm-test-run-plv8> server # [ 130.901095] postgres[1740]: ); vm-test-run-plv8> server # [ 130.904987] postgres[1740]: $$; vm-test-run-plv8> server # [ 130.908709] postgres[1740]: vm-test-run-plv8> server # [ 130.922779] postgres[1740]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 130.927504] postgres[1740]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 130.933383] postgres[1740]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 130.934797] postgres[1740]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 130.936127] postgres[1740]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 130.944067] postgres[1740]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 130.944756] postgres[1740]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 130.945114] postgres[1740]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 130.951866] postgres[1740]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 130.963802] postgres[1740]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 130.967421] postgres[1740]: vm-test-run-plv8> server # [ 130.968147] postgres[1740]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-plv8> server # [ 130.974741] postgres[1740]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-plv8> server # [ 130.975737] postgres[1740]: grant usage on schema graphql to postgres with grant option; vm-test-run-plv8> server # [ 130.977227] postgres[1740]: END IF; vm-test-run-plv8> server # [ 130.986394] postgres[1740]: vm-test-run-plv8> server # [ 130.987190] postgres[1740]: END; vm-test-run-plv8> server # [ 130.987762] postgres[1740]: $func$; vm-test-run-plv8> server # [ 130.997315] postgres[1740]: ::1 2026-10-21 01:01:55.518 UTC [1740] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 131.007022] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1736]: CREATE FUNCTION vm-test-run-plv8> server # [ 131.029816] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1736]: DROP EXTENSION vm-test-run-plv8> server # [ 132.727778] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1736]: DO vm-test-run-plv8> server # [ 132.839810] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-plv8> server # [ 133.477856] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1748]: DO vm-test-run-plv8> server # [ 133.493634] postgres[1754]: ::1 2026-10-21 01:01:58.066 UTC [1754] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-plv8> server # [ 133.495617] postgres[1754]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 133.503031] postgres[1754]: AS $$ vm-test-run-plv8> server # [ 133.513959] postgres[1754]: BEGIN vm-test-run-plv8> server # [ 133.516751] postgres[1754]: IF EXISTS ( vm-test-run-plv8> server # [ 133.518923] postgres[1754]: SELECT vm-test-run-plv8> server # [ 133.529304] postgres[1754]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 133.530995] postgres[1754]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 133.536806] postgres[1754]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 133.538825] postgres[1754]: WHERE ext.extname = 'pg_cron' vm-test-run-plv8> server # [ 133.540062] postgres[1754]: ) vm-test-run-plv8> server # [ 133.550155] postgres[1754]: THEN vm-test-run-plv8> server # [ 133.551070] postgres[1754]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 133.551427] postgres[1754]: vm-test-run-plv8> server # [ 133.551657] postgres[1754]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 133.556980] postgres[1754]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 133.568502] postgres[1754]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 133.570710] postgres[1754]: vm-test-run-plv8> server # [ 133.571600] postgres[1754]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 133.580911] postgres[1754]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 133.584320] postgres[1754]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 133.597584] postgres[1754]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 133.599576] postgres[1754]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 133.629497] postgres[1754]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 133.631072] postgres[1754]: vm-test-run-plv8> server # [ 133.633333] postgres[1754]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 133.633934] postgres[1754]: revoke all on table cron.job from postgres; vm-test-run-plv8> server # [ 133.636320] postgres[1754]: grant select on table cron.job to postgres with grant option; vm-test-run-plv8> server # [ 133.638189] postgres[1754]: END IF; vm-test-run-plv8> server # [ 133.638854] postgres[1754]: END; vm-test-run-plv8> server # [ 133.639183] postgres[1754]: $$; vm-test-run-plv8> server # [ 133.695856] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1748]: CREATE FUNCTION vm-test-run-plv8> server # [ 133.705096] postgres[1754]: ::1 2026-10-21 01:01:58.285 UTC [1754] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-plv8> server # [ 133.720924] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1748]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 133.722707] postgres[1754]: ::1 2026-10-21 01:01:58.312 UTC [1754] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-plv8> server # [ 133.745628] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1748]: ALTER FUNCTION vm-test-run-plv8> server # [ 133.746629] postgres[1754]: ::1 2026-10-21 01:01:58.337 UTC [1754] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-plv8> server # [ 133.747844] postgres[1754]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-plv8> server # [ 133.756613] postgres[1754]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 133.765929] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1748]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 133.851015] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-plv8> server # [ 134.220954] postgres[1768]: ::1 2026-10-21 01:01:58.800 UTC [1768] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-plv8> server # [ 134.239577] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1764]: ALTER ROLE vm-test-run-plv8> server # [ 134.281035] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-plv8> server # [ 134.706495] postgres[1773]: ::1 2026-10-21 01:01:59.286 UTC [1773] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-plv8> server # [ 134.754330] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1769]: ALTER FUNCTION vm-test-run-plv8> server # [ 134.766109] postgres[1773]: ::1 2026-10-21 01:01:59.347 UTC [1773] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-plv8> server # [ 134.777127] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1769]: ALTER FUNCTION vm-test-run-plv8> server # [ 134.779906] postgres[1773]: ::1 2026-10-21 01:01:59.370 UTC [1773] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-plv8> server # [ 134.789409] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1769]: ALTER FUNCTION vm-test-run-plv8> server # [ 134.857708] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-plv8> server # [ 135.211170] postgres[1776]: ::1 2026-10-21 01:01:59.785 UTC [1776] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-plv8> server # [ 135.253561] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1775]: GRANT ROLE vm-test-run-plv8> server # [ 135.285032] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-plv8> server # [ 136.336341] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1777]: DO vm-test-run-plv8> server # [ 136.391786] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-plv8> server # [ 136.943195] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1790]: DO vm-test-run-plv8> server # [ 136.961827] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1790]: DO vm-test-run-plv8> server # [ 137.022203] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-plv8> server # [ 137.599603] postgres[1805]: ::1 2026-10-21 01:02:02.160 UTC [1805] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-plv8> server # [ 137.636687] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1799]: ALTER ROLE vm-test-run-plv8> server # [ 137.640353] postgres[1805]: ::1 2026-10-21 01:02:02.226 UTC [1805] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-plv8> server # [ 137.645559] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1799]: ALTER ROLE vm-test-run-plv8> server # [ 137.647194] postgres[1805]: ::1 2026-10-21 01:02:02.236 UTC [1805] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-plv8> server # [ 137.656025] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1799]: ALTER ROLE vm-test-run-plv8> server # [ 137.707549] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-plv8> server # [ 138.044401] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1807]: DO vm-test-run-plv8> server # [ 138.089627] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-plv8> server # [ 138.395292] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1809]: DO vm-test-run-plv8> server # [ 138.427526] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-plv8> server # [ 138.944232] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1811]: CREATE FUNCTION vm-test-run-plv8> server # [ 138.958101] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1811]: DO vm-test-run-plv8> server # [ 139.029817] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-plv8> server # [ 139.521790] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1817]: ALTER FUNCTION vm-test-run-plv8> server # [ 139.532035] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1817]: GRANT vm-test-run-plv8> server # [ 139.587531] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-plv8> server # [ 140.061033] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1825]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 140.127260] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1825]: ALTER FUNCTION vm-test-run-plv8> server # [ 140.151495] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1825]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 140.222040] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 140.766845] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1836]: DO vm-test-run-plv8> server # [ 140.807477] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-plv8> server # [ 141.356228] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1847]: CREATE FUNCTION vm-test-run-plv8> server # [ 141.364244] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1847]: GRANT vm-test-run-plv8> server # [ 141.409745] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-plv8> server # [ 141.677990] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1849]: REVOKE ROLE vm-test-run-plv8> server # [ 141.714854] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1849]: DO vm-test-run-plv8> server # [ 141.726404] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1849]: DO vm-test-run-plv8> server # [ 141.741280] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1849]: REVOKE ROLE vm-test-run-plv8> server # [ 141.747030] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1849]: REVOKE vm-test-run-plv8> server # [ 141.769050] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1849]: DO vm-test-run-plv8> server # [ 141.807117] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 142.108774] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1851]: DO vm-test-run-plv8> server # [ 142.153502] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 142.726311] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1853]: DO vm-test-run-plv8> server # [ 142.765868] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 143.437410] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1864]: DO vm-test-run-plv8> server # [ 143.485215] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-plv8> server # [ 143.958089] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1874]: ALTER ROLE vm-test-run-plv8> server # [ 143.983756] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-plv8> server # [ 144.330300] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1883]: GRANT ROLE vm-test-run-plv8> server # [ 144.347735] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1883]: DO vm-test-run-plv8> server # [ 144.379814] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-plv8> server # [ 144.891653] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1885]: GRANT vm-test-run-plv8> server # [ 144.930595] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-plv8> server # [ 145.318652] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1891]: CREATE FUNCTION vm-test-run-plv8> server # [ 145.329272] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1891]: REVOKE vm-test-run-plv8> server # [ 145.340082] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1891]: REVOKE vm-test-run-plv8> server # [ 145.353135] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1891]: GRANT vm-test-run-plv8> server # [ 145.403654] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-plv8> server # [ 145.743965] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1893]: DO vm-test-run-plv8> server # [ 145.758780] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-plv8> server # [ 146.177244] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1895]: ALTER ROLE vm-test-run-plv8> server # [ 146.229785] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-plv8> server # [ 146.913153] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1904]: DROP EXTENSION vm-test-run-plv8> server # [ 146.981567] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-plv8> server # [ 147.468545] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1917]: CREATE FUNCTION vm-test-run-plv8> server # [ 147.497098] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1917]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 147.515721] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1917]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 147.567738] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-plv8> server # [ 147.900438] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1925]: DO vm-test-run-plv8> server # [ 147.923622] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1925]: CREATE FUNCTION vm-test-run-plv8> server # [ 147.986762] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-plv8> server # [ 148.268711] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1927]: CREATE FUNCTION vm-test-run-plv8> server # [ 148.280995] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1927]: CREATE FUNCTION vm-test-run-plv8> server # [ 148.321286] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql vm-test-run-plv8> server # [ 148.765966] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1931]: CREATE FUNCTION vm-test-run-plv8> server # [ 148.782296] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1931]: CREATE FUNCTION vm-test-run-plv8> server # [ 148.806763] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1931]: CREATE FUNCTION vm-test-run-plv8> server # [ 148.833857] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1931]: CREATE FUNCTION vm-test-run-plv8> server # [ 148.858369] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1931]: CREATE FUNCTION vm-test-run-plv8> server # [ 148.884957] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1931]: CREATE FUNCTION vm-test-run-plv8> server # [ 148.930009] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Running postgresql schema... vm-test-run-plv8> server # [ 149.413788] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER DATABASE vm-test-run-plv8> server # [ 149.424990] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER DATABASE vm-test-run-plv8> server # [ 149.570122] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER ROLE vm-test-run-plv8> server # [ 149.677783] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER ROLE vm-test-run-plv8> server # [ 149.805108] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER ROLE vm-test-run-plv8> server # [ 149.931104] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER ROLE vm-test-run-plv8> server # [ 150.061056] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER ROLE vm-test-run-plv8> server # [ 150.197015] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER ROLE vm-test-run-plv8> server # [ 150.335797] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER ROLE vm-test-run-plv8> server # [ 150.473389] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER ROLE vm-test-run-plv8> server # [ 150.602106] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER ROLE vm-test-run-plv8> server # [ 150.615717] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1935]: ALTER ROLE vm-test-run-plv8> server # [ 150.675214] imhhg68k30m4bb6sfq9042j60dca9kbb-supabase-db-init[1387]: Database initialization complete vm-test-run-plv8> server # [ 150.740548] systemd[1]: Finished Supabase Database Initialization. vm-test-run-plv8> server # [ 150.757323] systemd[1]: Reached target Multi-User System. vm-test-run-plv8> server # [ 150.758880] systemd[1]: Startup finished in 15.329s (kernel) + 2min 15.421s (userspace) = 2min 30.751s. vm-test-run-plv8> server: (finished: waiting for unit supabase-db-init.service, in 151.98 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.56 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.73 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.66 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.58 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.73 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.78 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.57 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" vm-test-run-plv8> server # [ 171.118545] 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 5.78 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.43 seconds) vm-test-run-plv8> (finished: subtest: Check upgrade path with postgresql 15, in 24.81 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.47 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 2.00 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.52 seconds) vm-test-run-plv8> (finished: subtest: Check the install of the last version of the extension, in 2.99 seconds) vm-test-run-plv8> (finished: run the VM test script, in 179.90 seconds) vm-test-run-plv8> test script finished in 180.30s 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