these 17 derivations will be built: /nix/store/7xyc2r13af6svncbf7rp80ipgli8fcbq-system-path.drv /nix/store/fvcgpqil5sxm6lq5h0dnwmlgp1glnw5y-dbus-1.drv /nix/store/5q4cgb8dfw2fv0g960wvxblscrp48la2-unit-supabase-db-init.service.drv /nix/store/vfaf906ip221ywibyi608va6ayvab5nc-X-Restart-Triggers-dbus.drv /nix/store/kykv8rsikp4mmfy713mmhlv513wsc1w1-unit-dbus.service.drv /nix/store/xak5b1pn8w488nxiwpfk472k66afx1jw-unit-postgresql.service.drv /nix/store/pgmgpxr9g5hcckg5qgsy17084krqlmcq-system-units.drv /nix/store/s5vrpkl1qwj63l4a0z155lhqm0hwqj3c-unit-dbus.service.drv /nix/store/q33j6snm34ch8jf2n3ildylbfjvnm932-user-units.drv /nix/store/pvkd9ywh1xnnjpa7jfy5yh3j2mv8j71c-etc.drv /nix/store/6361yp5rb451bc72d8a809caagpag8k0-activate.drv /nix/store/44zq9m3ldrwh8n8lj0g6ai1n3m26lcnm-nixos-system-server-test.drv /nix/store/6lslx5q74mm442va2xhlk8j1j27mldjg-closure-info.drv /nix/store/ymy2hqvkv41s7zr7w90p3zwzw5fx03a0-run-nixos-vm.drv /nix/store/92l8dljajk7h8hvrvp0hq07kpypdpvlg-nixos-vm.drv /nix/store/rwramrxa1bv79xrcnvwhmy51i8db64aw-nixos-test-driver-plv8.drv /nix/store/phbfd9z6ph0y5a06ljgchk1fw10bqkgx-vm-test-run-plv8.drv building '/nix/store/5q4cgb8dfw2fv0g960wvxblscrp48la2-unit-supabase-db-init.service.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/5q4cgb8dfw2fv0g960wvxblscrp48la2-unit-supabase-db-init.service.drv' building '/nix/store/rwramrxa1bv79xrcnvwhmy51i8db64aw-nixos-test-driver-plv8.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/rwramrxa1bv79xrcnvwhmy51i8db64aw-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/phbfd9z6ph0y5a06ljgchk1fw10bqkgx-vm-test-run-plv8.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/phbfd9z6ph0y5a06ljgchk1fw10bqkgx-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.2uk8Iogkqp', 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: ef6aaa76-5de8-40fd-916b-df40355f937a vm-test-run-plv8> server: QEMU running (pid 9) vm-test-run-plv8> server # Superblock backups stored on blocks: vm-test-run-plv8> server # 32768, 98304, 163840, 229376 vm-test-run-plv8> server # vm-test-run-plv8> server # Allocating group tables: 0/8 done vm-test-run-plv8> server # Writing inode tables: 0/8 done vm-test-run-plv8> server # Creating journal (8192 blocks): done vm-test-run-plv8> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-plv8> server # vm-test-run-plv8> server # Virtualisation disk image created. vm-test-run-plv8> (finished: start all VMs, in 0.13 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/s41kpn48nabqakbhdcc2vfvxgy459mim-nixos-system-server-test/init regInfo=/nix/store/5ifmqprj5p4j60wz1dxf8qya3b23fksk-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-plv8> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/5ifmqprj5p4j60wz1dxf8qya3b23fksk-closure-info/registration", will be passed to user space. vm-test-run-plv8> server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-plv8> server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-plv8> server # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-plv8> server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 vm-test-run-plv8> server # [ 0.000000] Policy zone: Normal vm-test-run-plv8> server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-plv8> server # [ 0.000000] software IO TLB: area num 2. vm-test-run-plv8> server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) vm-test-run-plv8> server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm-test-run-plv8> server # [ 0.000000] allocated 8388608 bytes of page_ext vm-test-run-plv8> server # [ 0.000000] ftrace: allocating 72257 entries in 283 pages vm-test-run-plv8> server # [ 0.000000] ftrace: allocated 283 pages with 5 groups vm-test-run-plv8> server # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-plv8> server # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-plv8> server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. vm-test-run-plv8> server # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-plv8> server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm-test-run-plv8> server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-plv8> server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-plv8> server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-plv8> server # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-plv8> server # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-plv8> server # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-plv8> server # [ 0.000000] GICv3: GICv3 features: 16 PPIs vm-test-run-plv8> server # [ 0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 vm-test-run-plv8> server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-plv8> server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-plv8> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100ad0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-plv8> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100ae0000 (flat, esz 8, psz 64K, shr 1) vm-test-run-plv8> server # [ 0.000000] GICv3: using LPI property table @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.000035] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-plv8> server # [ 0.003080] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-plv8> server # [ 0.013690] Console: colour dummy device 80x25 vm-test-run-plv8> server # [ 0.015012] printk: legacy console [tty0] enabled vm-test-run-plv8> server # [ 0.021219] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-plv8> server # [ 0.021699] pid_max: default: 32768 minimum: 301 vm-test-run-plv8> server # [ 0.023841] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-plv8> server # [ 0.025833] landlock: Up and running. vm-test-run-plv8> server # [ 0.025889] Yama: becoming mindful. vm-test-run-plv8> server # [ 0.030070] LSM support for eBPF active vm-test-run-plv8> server # [ 0.032985] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.033658] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.064583] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-plv8> server # [ 0.078603] rcu: Hierarchical SRCU implementation. vm-test-run-plv8> server # [ 0.078705] rcu: Max phase no-delay instances is 1000. vm-test-run-plv8> server # [ 0.080188] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-plv8> server # [ 0.086834] fsl-mc MSI: its@8080000 domain created vm-test-run-plv8> server # [ 0.088999] EFI services will not be available. vm-test-run-plv8> server # [ 0.091292] smp: Bringing up secondary CPUs ... vm-test-run-plv8> server # [ 0.096167] Detected PIPT I-cache on CPU1 vm-test-run-plv8> server # [ 0.097689] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-plv8> server # [ 0.098442] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000 vm-test-run-plv8> server # [ 0.099984] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-plv8> server # [ 0.104255] smp: Brought up 1 node, 2 CPUs vm-test-run-plv8> server # [ 0.104417] SMP: Total of 2 processors activated. vm-test-run-plv8> server # [ 0.104463] CPU: All CPU(s) started at EL1 vm-test-run-plv8> server # [ 0.104633] CPU features: detected: Branch Target Identification vm-test-run-plv8> server # [ 0.104690] CPU features: detected: 32-bit EL0 Support vm-test-run-plv8> server # [ 0.104723] CPU features: detected: 32-bit EL1 Support vm-test-run-plv8> server # [ 0.104944] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-plv8> server # [ 0.105000] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-plv8> server # [ 0.105200] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-plv8> server # [ 0.105268] CPU features: detected: Common not Private translations vm-test-run-plv8> server # [ 0.105292] CPU features: detected: CRC32 instructions vm-test-run-plv8> server # [ 0.105313] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-plv8> server # [ 0.105617] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-plv8> server # [ 0.105649] CPU features: detected: Data independent timing control (DIT) vm-test-run-plv8> server # [ 0.105677] CPU features: detected: E0PD vm-test-run-plv8> server # [ 0.105699] CPU features: detected: Enhanced Counter Virtualization vm-test-run-plv8> server # [ 0.105726] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-plv8> server # [ 0.105749] CPU features: detected: Enhanced Privileged Access Never vm-test-run-plv8> server # [ 0.105773] CPU features: detected: Enhanced Virtualization Traps vm-test-run-plv8> server # [ 0.105799] CPU features: detected: Fine Grained Traps vm-test-run-plv8> server # [ 0.105860] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-plv8> server # [ 0.105952] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-plv8> server # [ 0.106000] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-plv8> server # [ 0.106025] CPU features: detected: LSE atomic instructions vm-test-run-plv8> server # [ 0.106049] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-plv8> server # [ 0.106072] CPU features: detected: Privileged Access Never vm-test-run-plv8> server # [ 0.106096] CPU features: detected: RAS Extension Support vm-test-run-plv8> server # [ 0.106118] CPU features: detected: Random Number Generator vm-test-run-plv8> server # [ 0.106144] CPU features: detected: Speculation barrier (SB) vm-test-run-plv8> server # [ 0.106170] CPU features: detected: Stage-2 Force Write-Back vm-test-run-plv8> server # [ 0.106193] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-plv8> server # [ 0.106225] CPU features: detected: TLB range maintenance instructions vm-test-run-plv8> server # [ 0.106248] CPU features: detected: WFx with timeout vm-test-run-plv8> server # [ 0.106286] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-plv8> server # [ 0.106310] CPU features: detected: Scalable Vector Extension vm-test-run-plv8> server # [ 0.112620] alternatives: applying system-wide alternatives vm-test-run-plv8> server # [ 0.129386] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-plv8> server # [ 0.130043] SVE: maximum available vector length 256 bytes per vector vm-test-run-plv8> server # [ 0.130138] SVE: default vector length 64 bytes per vector vm-test-run-plv8> server # [ 0.144147] Memory: 3922856K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-plv8> server # [ 0.166848] devtmpfs: initialized vm-test-run-plv8> server # [ 0.195757] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-plv8> server # [ 0.196250] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.198577] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-plv8> server # [ 0.198650] 0 pages in range for non-PLT usage vm-test-run-plv8> server # [ 0.198694] 509248 pages in range for PLT usage vm-test-run-plv8> server # [ 0.202059] pinctrl core: initialized pinctrl subsystem vm-test-run-plv8> server # [ 0.213572] DMI not present or invalid. vm-test-run-plv8> server # [ 0.234155] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-plv8> server # [ 0.246487] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-plv8> server # [ 0.247524] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-plv8> server # [ 0.248534] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-plv8> server # [ 0.248813] audit: initializing netlink subsys (disabled) vm-test-run-plv8> server # [ 0.251092] audit: type=2000 audit(0.204:1): state=initialized audit_enabled=0 res=1 vm-test-run-plv8> server # [ 0.257583] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-plv8> server # [ 0.257637] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-plv8> server # [ 0.257690] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-plv8> server # [ 0.257721] thermal_sys: Registered thermal governor 'user_space' vm-test-run-plv8> server # [ 0.257744] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-plv8> server # [ 0.258570] cpuidle: using governor ladder vm-test-run-plv8> server # [ 0.259200] cpuidle: using governor menu vm-test-run-plv8> server # [ 0.261586] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-plv8> server # [ 0.262776] ASID allocator initialised with 65536 entries vm-test-run-plv8> server # [ 0.270530] Serial: AMBA PL011 UART driver vm-test-run-plv8> server # [ 0.320018] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-plv8> server # [ 0.321553] printk: legacy console [ttyAMA0] enabled vm-test-run-plv8> server # [ 0.362293] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.362474] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-plv8> server # [ 0.362578] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.362691] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-plv8> server # [ 0.362785] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.362876] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-plv8> server # [ 0.362969] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.363063] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-plv8> server # [ 0.375084] fbcon: Taking over console vm-test-run-plv8> server # [ 0.375711] ACPI: Interpreter disabled. vm-test-run-plv8> server # [ 0.384640] iommu: Default domain type: Translated vm-test-run-plv8> server # [ 0.384838] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-plv8> server # [ 0.388200] SCSI subsystem initialized vm-test-run-plv8> server # [ 0.391014] usbcore: registered new interface driver usbfs vm-test-run-plv8> server # [ 0.391477] usbcore: registered new interface driver hub vm-test-run-plv8> server # [ 0.392689] usbcore: registered new device driver usb vm-test-run-plv8> server # [ 0.395847] pps_core: LinuxPPS API ver. 1 registered vm-test-run-plv8> server # [ 0.395979] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-plv8> server # [ 0.396160] PTP clock support registered vm-test-run-plv8> server # [ 0.396841] EDAC MC: Ver: 3.0.0 vm-test-run-plv8> server # [ 0.399397] scmi_core: SCMI protocol bus registered vm-test-run-plv8> server # [ 0.402939] FPGA manager framework vm-test-run-plv8> server # [ 0.404343] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-plv8> server # [ 0.413259] vgaarb: loaded vm-test-run-plv8> server # [ 0.417865] clocksource: Switched to clocksource arch_sys_counter vm-test-run-plv8> server # [ 0.422558] VFS: Disk quotas dquot_6.6.0 vm-test-run-plv8> server # [ 0.422773] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-plv8> server # [ 0.425165] netfs: FS-Cache loaded vm-test-run-plv8> server # [ 0.426901] pnp: PnP ACPI: disabled vm-test-run-plv8> server # [ 0.451301] NET: Registered PF_INET protocol family vm-test-run-plv8> server # [ 0.452401] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-plv8> server # [ 0.563868] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.564222] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.564587] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.565793] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-plv8> server # [ 0.566626] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-plv8> server # [ 0.567984] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-plv8> server # [ 0.568442] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.569068] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.570825] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-plv8> server # [ 0.571352] NET: Registered PF_XDP protocol family vm-test-run-plv8> server # [ 0.571765] PCI: CLS 0 bytes, default 64 vm-test-run-plv8> server # [ 0.574003] kvm [1]: HYP mode not available vm-test-run-plv8> server # [ 0.576196] Trying to unpack rootfs image as initramfs... vm-test-run-plv8> server # [ 0.682990] Initialise system trusted keyrings vm-test-run-plv8> server # [ 0.684485] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-plv8> server # [ 0.688567] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-plv8> server # [ 0.689374] 9p: Installing v9fs 9p2000 file system support vm-test-run-plv8> server # [ 0.751743] Key type asymmetric registered vm-test-run-plv8> server # [ 0.751965] Asymmetric key parser 'x509' registered vm-test-run-plv8> server # [ 0.752373] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-plv8> server # [ 0.753383] io scheduler mq-deadline registered vm-test-run-plv8> server # [ 0.753530] io scheduler kyber registered vm-test-run-plv8> server # [ 0.782463] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-plv8> server # [ 0.788528] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-plv8> server # [ 0.791734] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-plv8> server # [ 0.793684] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-plv8> server # [ 0.794571] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-plv8> server # [ 0.795181] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-plv8> server # [ 0.795792] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-plv8> server # [ 0.796681] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-plv8> server # [ 0.799408] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-plv8> server # [ 0.799828] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-plv8> server # [ 0.800142] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.800283] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.800397] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.801729] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.805291] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.805795] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.806758] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.807026] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.807193] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.807832] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.808310] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.808502] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.808876] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.809431] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.809650] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.809767] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.810861] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.811657] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.812241] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.812463] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.812587] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.813109] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.813879] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.814510] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.814632] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.815824] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.816243] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-plv8> server # [ 0.816507] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.816876] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.817511] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.817940] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.818403] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.818854] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.819197] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.819743] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.820110] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.820273] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.821000] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.821456] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.821914] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.824614] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-plv8> server # [ 0.825168] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.826479] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.827255] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.827740] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.827999] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.828611] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.829019] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.829289] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.829628] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.832554] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-plv8> server # [ 0.833046] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-plv8> server # [ 0.833418] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.833642] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.833826] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.833965] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.834688] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.835334] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.835472] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.835607] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.835738] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.835871] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.836192] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.837086] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-plv8> server # [ 0.837328] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-plv8> server # [ 0.837444] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-plv8> server # [ 0.837557] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-plv8> server # [ 0.837671] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-plv8> server # [ 0.838367] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-plv8> server # [ 0.839160] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-plv8> server # [ 0.839449] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-plv8> server # [ 0.839683] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-plv8> server # [ 0.840077] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-plv8> server # [ 0.840200] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-plv8> server # [ 0.840309] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-plv8> server # [ 0.840429] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-plv8> server # [ 0.840546] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-plv8> server # [ 0.840643] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-plv8> server # [ 0.841116] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-plv8> server # [ 0.841386] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-plv8> server # [ 0.841500] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-plv8> server # [ 0.841601] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-plv8> server # [ 0.841707] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-plv8> server # [ 0.841822] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-plv8> server # [ 0.842117] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.842242] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.842379] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.844690] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.909391] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.913221] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.916248] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.918762] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.921193] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.923799] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.925669] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.928200] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.929785] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.933111] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.935722] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.954318] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-plv8> server # [ 0.965485] msm_serial: driver initialized vm-test-run-plv8> server # [ 0.967619] SuperH (H)SCI(F) driver initialized vm-test-run-plv8> server # [ 0.968061] STM32 USART driver initialized vm-test-run-plv8> server # [ 1.024936] Freeing initrd memory: 10684K vm-test-run-plv8> server # [ 1.025176] loop: module loaded vm-test-run-plv8> server # [ 1.026283] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-plv8> server # [ 1.030736] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-plv8> server # [ 1.044964] megasas: 07.727.03.00-rc1 vm-test-run-plv8> server # [ 1.051051] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-plv8> server # [ 1.053492] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 1.054841] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 1.056222] Using buffer write method vm-test-run-plv8> server # [ 1.057255] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-plv8> server # [ 1.059114] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 1.059400] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 1.060567] Using buffer write method vm-test-run-plv8> server # [ 1.061033] Concatenating MTD devices: vm-test-run-plv8> server # [ 1.061189] (0): "0.flash" vm-test-run-plv8> server # [ 1.061250] (1): "0.flash" vm-test-run-plv8> server # [ 1.061424] into device "0.flash" vm-test-run-plv8> server # [ 1.087934] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-plv8> server # [ 1.103023] thunder_xcv, ver 1.0 vm-test-run-plv8> server # [ 1.103299] thunder_bgx, ver 1.0 vm-test-run-plv8> server # [ 1.103475] nicpf, ver 1.0 vm-test-run-plv8> server # [ 1.106563] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-plv8> server # [ 1.106731] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-plv8> server # [ 1.107396] hclge is initializing vm-test-run-plv8> server # [ 1.107641] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 1.107730] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-plv8> server # [ 1.107935] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 1.108019] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-plv8> server # [ 1.108234] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-plv8> server # [ 1.108318] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-plv8> server # [ 1.108492] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-plv8> server # [ 1.108587] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-plv8> server # [ 1.109344] sky2: driver version 1.30 vm-test-run-plv8> server # [ 1.118754] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-plv8> server # [ 1.119668] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-plv8> server # [ 1.120287] usbcore: registered new interface driver usb-storage vm-test-run-plv8> server # [ 1.121076] usbcore: registered new interface driver usbserial_generic vm-test-run-plv8> server # [ 1.121351] usbserial: USB Serial support registered for generic vm-test-run-plv8> server # [ 1.123521] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-plv8> server # [ 1.132286] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-plv8> server # [ 1.133025] rtc-pl031 9010000.pl031: setting system clock to 2026-10-26T11:54:33 UTC (1793015673) vm-test-run-plv8> server # [ 1.135627] i2c_dev: i2c /dev entries driver vm-test-run-plv8> server # [ 1.138547] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-plv8> server # [ 1.147398] hub 1-0:1.0: USB hub found vm-test-run-plv8> server # [ 1.148082] hub 1-0:1.0: 6 ports detected vm-test-run-plv8> server # [ 1.151651] sdhci: Secure Digital Host Controller Interface driver vm-test-run-plv8> server # [ 1.152056] sdhci: Copyright(c) Pierre Ossman vm-test-run-plv8> server # [ 1.153715] Synopsys Designware Multimedia Card Interface Driver vm-test-run-plv8> server # [ 1.156378] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-plv8> server # [ 1.164066] hid: raw HID events driver (C) Jiri Kosina vm-test-run-plv8> server # [ 1.166950] usbcore: registered new interface driver usbhid vm-test-run-plv8> server # [ 1.167105] usbhid: USB HID core driver vm-test-run-plv8> server # [ 1.176880] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-plv8> server # [ 1.193626] drop_monitor: Initializing network drop monitor service vm-test-run-plv8> server # [ 1.195605] NET: Registered PF_INET6 protocol family vm-test-run-plv8> server # [ 1.216498] Segment Routing with IPv6 vm-test-run-plv8> server # [ 1.216935] In-situ OAM (IOAM) with IPv6 vm-test-run-plv8> server # [ 1.217670] NET: Registered PF_PACKET protocol family vm-test-run-plv8> server # [ 1.219745] 9pnet: Installing 9P2000 support vm-test-run-plv8> server # [ 1.224574] Key type dns_resolver registered vm-test-run-plv8> server # [ 1.263157] registered taskstats version 1 vm-test-run-plv8> server # [ 1.265373] Loading compiled-in X.509 certificates vm-test-run-plv8> server # [ 1.323687] Demotion targets for Node 0: null vm-test-run-plv8> server # [ 1.325767] Key type .fscrypt registered vm-test-run-plv8> server # [ 1.325934] Key type fscrypt-provisioning registered vm-test-run-plv8> server # [ 1.337716] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-plv8> server # [ 1.382920] clk: Disabling unused clocks vm-test-run-plv8> server # [ 1.383687] PM: genpd: Disabling unused power domains vm-test-run-plv8> server # [ 1.384063] ALSA device list: vm-test-run-plv8> server # [ 1.384177] No soundcards found. vm-test-run-plv8> server # [ 1.402496] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-plv8> server # [ 1.476711] Freeing unused kernel memory: 4416K vm-test-run-plv8> server # [ 1.478255] Run /init as init process vm-test-run-plv8> server # [ 1.591008] 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.727859] 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.850341] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-plv8> server # [ 2.025364] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 vm-test-run-plv8> server # [ 2.026986] 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 # [ 2.059252] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-plv8> server # [ 2.189273] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-plv8> server # [ 2.189934] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-plv8> server # [ 2.189956] [drm] features: -context_init vm-test-run-plv8> server # [ 2.192465] [drm] number of scanouts: 1 vm-test-run-plv8> server # [ 2.192584] [drm] number of cap sets: 0 vm-test-run-plv8> server # [ 2.203406] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-plv8> server # [ 2.235407] Console: switching to colour frame buffer device 160x50 vm-test-run-plv8> server # [ 2.246334] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-plv8> server # [ 5.215304] EXT4-fs (vda): mounted filesystem ef6aaa76-5de8-40fd-916b-df40355f937a r/w with ordered data mode. Quota mode: none. vm-test-run-plv8> server # [ 7.711818] EXT4-fs (vda): re-mounted ef6aaa76-5de8-40fd-916b-df40355f937a. vm-test-run-plv8> server # [ 7.729377] booting system configuration /nix/store/s41kpn48nabqakbhdcc2vfvxgy459mim-nixos-system-server-test vm-test-run-plv8> server # [ 20.118014] 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 # [ 20.128149] systemd[1]: Detected virtualization qemu. vm-test-run-plv8> server # [ 20.133164] systemd[1]: Detected architecture arm64. vm-test-run-plv8> server # [ 20.137722] systemd[1]: Detected first boot. vm-test-run-plv8> server # [ 20.167282] systemd[1]: Initializing machine ID from random generator. vm-test-run-plv8> server # [ 20.200293] systemd[1]: Hostname set to . vm-test-run-plv8> server # [ 21.410380] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-plv8> server # [ 22.832869] systemd[1]: Applying preset policy. vm-test-run-plv8> server # [ 26.414081] systemd[1]: Populated /etc with preset unit settings. 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.848305] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-plv8> server # [ 30.065455] systemd[1]: Created slice Slice /system/getty. vm-test-run-plv8> server # [ 30.080574] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-plv8> server # [ 30.093265] systemd[1]: Created slice User and Session Slice. vm-test-run-plv8> server # [ 30.101707] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-plv8> server # [ 30.107396] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-plv8> server # [ 30.112414] systemd[1]: Expecting device /dev/hvc0... vm-test-run-plv8> server # [ 30.117451] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-plv8> server # [ 30.121596] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-plv8> server # [ 30.126662] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-plv8> server # [ 30.131527] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-plv8> server # [ 30.135864] systemd[1]: Reached target Path Units. vm-test-run-plv8> server # [ 30.140821] systemd[1]: Reached target Remote File Systems. vm-test-run-plv8> server # [ 30.145498] systemd[1]: Reached target Slice Units. vm-test-run-plv8> server # [ 30.149907] systemd[1]: Reached target Swaps. vm-test-run-plv8> server # [ 30.183965] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-plv8> server # [ 30.206589] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-plv8> server # [ 30.216696] systemd[1]: Listening on Journal Audit Socket. vm-test-run-plv8> server # [ 30.223552] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-plv8> server # [ 30.229201] systemd[1]: Listening on Journal Sockets. vm-test-run-plv8> server # [ 30.236567] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-plv8> server # [ 30.241840] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 30.249020] systemd[1]: Listening on udev Control Socket. vm-test-run-plv8> server # [ 30.254997] systemd[1]: Listening on udev Kernel Socket. vm-test-run-plv8> server # [ 30.303074] systemd[1]: Mounting Huge Pages File System... vm-test-run-plv8> server # [ 30.336847] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-plv8> server # [ 30.401345] systemd[1]: Mounting Kernel Debug File System... vm-test-run-plv8> server # [ 30.497717] systemd[1]: Mounting Kernel Trace File System... vm-test-run-plv8> server # [ 30.626796] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-plv8> server # [ 30.741663] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-plv8> server # [ 30.768380] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-plv8> server # [ 30.848309] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-plv8> server # [ 30.855246] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-plv8> server # [ 30.860109] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-plv8> server # [ 30.905495] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-plv8> server # [ 30.935070] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-plv8> server # [ 30.956149] 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 # [ 31.035823] systemd[1]: Starting Journal Service... vm-test-run-plv8> server # [ 31.110918] systemd[1]: Starting Load Kernel Modules... vm-test-run-plv8> server # [ 31.196164] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-plv8> server # [ 31.250520] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-plv8> server # [ 31.255802] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 31.312117] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-plv8> server # [ 31.398741] systemd[1]: Mounted Huge Pages File System. vm-test-run-plv8> server # [ 31.408466] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-plv8> server # [ 31.424487] systemd[1]: Mounted Kernel Debug File System. vm-test-run-plv8> server # [ 31.437307] systemd[1]: Mounted Kernel Trace File System. vm-test-run-plv8> server # [ 31.450808] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-plv8> server # [ 31.492404] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-plv8> server # [ 31.560565] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-plv8> server # [ 32.242411] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-plv8> server # [ 32.260442] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-plv8> server # [ 32.378685] EXT4-fs (vda): re-mounted ef6aaa76-5de8-40fd-916b-df40355f937a. vm-test-run-plv8> server # [ 32.492422] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-plv8> server # [ 32.512139] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-plv8> server # [ 32.565740] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-plv8> server # [ 32.574992] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 32.635553] systemd[1]: Finished Load Kernel Modules. vm-test-run-plv8> server # [ 32.671296] fuse: init (API version 7.41) vm-test-run-plv8> server # [ 32.710617] systemd[1]: Starting Firewall... vm-test-run-plv8> server # [ 32.788594] systemd[1]: Starting Apply Kernel Variables... vm-test-run-plv8> server # [ 32.821132] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-plv8> server # [ 32.837822] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-plv8> server # [ 32.901358] systemd[1]: Mounting FUSE Control File System... vm-test-run-plv8> server # [ 33.177045] systemd[1]: Mounted FUSE Control File System. vm-test-run-plv8> server # [ 33.282262] systemd-journald[397]: Collecting audit messages is enabled. vm-test-run-plv8> server # [ 33.719479] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-plv8> server # [ 33.736579] systemd[1]: Reached target First Boot Complete. vm-test-run-plv8> server # [ 34.038761] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-plv8> server # [ 34.146856] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-plv8> server # [ 34.189119] systemd[1]: Finished Apply Kernel Variables. vm-test-run-plv8> server # [ 34.714490] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-plv8> server # [ 35.245663] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-plv8> server # [ 35.267794] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-plv8> server # [ 35.317836] systemd[1]: Mounting /run/wrappers... vm-test-run-plv8> server # [ 35.372006] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-plv8> server # [ 35.764406] systemd[1]: Mounted /run/wrappers. vm-test-run-plv8> server # [ 35.771676] systemd[1]: Reached target Local File Systems. vm-test-run-plv8> server # [ 35.801753] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-plv8> server # [ 35.846381] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-plv8> server # [ 35.859453] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-plv8> server # [ 35.927540] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-plv8> server # [ 35.973480] systemd[1]: Started Journal Service. vm-test-run-plv8> server # [ 35.952453] systemd-modules-load[398]: Module 'atkbd' is built in vm-test-run-plv8> server # [ 35.971959] systemd-modules-load[398]: Module 'loop' is built in vm-test-run-plv8> server # [ 36.030558] systemd-oomd[399]: No swap; memory pressure usage will be degraded vm-test-run-plv8> server # [ 36.067445] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-plv8> server # [ 36.973036] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-plv8> server # [ 37.023394] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-plv8> server # [ 37.051257] systemd-udevd[427]: Using default interface naming scheme 'v258'. vm-test-run-plv8> server # [ 37.147585] systemd-journald[397]: Received client request to flush runtime journal. vm-test-run-plv8> server # [ 37.702201] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-plv8> server # [ 37.741501] systemd[1]: Starting Create System Files and Directories... vm-test-run-plv8> server # [ 39.684063] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-plv8> server # [ 39.857672] systemd[1]: Finished Create System Files and Directories. vm-test-run-plv8> server # [ 39.959901] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-plv8> server # [ 40.023994] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-plv8> server # [ 41.087941] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-plv8> server # [ 42.237993] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-plv8> server # [ 42.269243] systemd[1]: Starting Update is Completed... vm-test-run-plv8> server # [ 42.940888] systemd[1]: Finished Update is Completed. vm-test-run-plv8> server # [ 46.100617] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-plv8> server # [ 46.105720] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-plv8> server # [ 46.117710] systemd[1]: suid-sgid-wrappers.service: Consumed 2.761s CPU time, 5.7M memory peak. vm-test-run-plv8> server # [ 48.430553] systemd[1]: Finished Firewall. vm-test-run-plv8> server # [ 50.266019] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-plv8> server # [ 50.278652] systemd[1]: Reached target System Initialization. vm-test-run-plv8> server # [ 50.285978] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-plv8> server # [ 50.297316] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-plv8> server # [ 50.301968] systemd[1]: Reached target Timer Units. vm-test-run-plv8> server # [ 50.309474] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-plv8> server # [ 50.319265] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-plv8> server # [ 50.325786] systemd[1]: Listening on Hostname Service Socket. vm-test-run-plv8> server # [ 50.333994] systemd[1]: Reached target Socket Units. vm-test-run-plv8> server # [ 50.337407] systemd[1]: Reached target Basic System. vm-test-run-plv8> server # [ 50.357256] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-plv8> server # [ 50.396838] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 50.449223] systemd[1]: Started Reset console on configuration changes. vm-test-run-plv8> server # [ 50.502983] systemd[1]: Starting resolvconf update... vm-test-run-plv8> server # [ 50.565047] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-plv8> server # [ 51.573215] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-plv8> server # [ 51.853086] nsncd[630]: Oct 26 11:55:24.222 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 51.867895] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 51.875758] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 51.888751] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 51.921136] systemd[1]: Starting User Login Management... vm-test-run-plv8> server # [ 51.969168] dbus-daemon[633]: dbus[633]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-plv8> server # [ 52.412945] systemd[1]: Started D-Bus System Message Bus. vm-test-run-plv8> server # [ 53.453142] systemd-logind[652]: New seat seat0. vm-test-run-plv8> server # [ 53.495974] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-plv8> server # [ 53.515889] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-plv8> server # [ 53.529874] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-plv8> server # [ 53.538570] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-plv8> server # [ 53.546137] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 53.562575] systemd[1]: Started User Login Management. vm-test-run-plv8> server # [ 53.581246] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-plv8> server # [ 53.602039] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 53.720935] systemd[1]: Starting linger-users.service... vm-test-run-plv8> server # [ 53.794485] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 54.293788] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-plv8> server # [ 54.321055] systemd[1]: Finished linger-users.service. vm-test-run-plv8> server # [ 54.539944] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 54.547546] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 54.563395] nsncd[692]: Oct 26 11:55:26.971 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 54.571322] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 54.901392] systemd[1]: Finished resolvconf update. vm-test-run-plv8> server # [ 54.923703] systemd[1]: Reached target Preparation for Network. vm-test-run-plv8> server # [ 54.972044] systemd[1]: Starting DHCP Client... vm-test-run-plv8> server # [ 56.090829] dhcpcd[741]: dhcpcd-10.2.4 starting vm-test-run-plv8> server # [ 56.170509] dhcpcd[745]: dev: loaded udev vm-test-run-plv8> server # [ 56.542158] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-plv8> server # [ 57.088273] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-plv8> server # [ 57.305008] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-plv8> server # [ 57.314735] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-plv8> server # [ 57.338552] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-plv8> server # [ 57.345489] cfg80211: failed to load regulatory.db vm-test-run-plv8> server # [ 57.341222] systemd[1]: Found device /dev/hvc0. vm-test-run-plv8> server # [ 58.098860] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-plv8> server # [ 58.043895] dhcpcd[745]: eth0: waiting for carrier vm-test-run-plv8> server # [ 58.051099] dhcpcd[745]: eth0: carrier acquired vm-test-run-plv8> server # [ 58.155474] dhcpcd[745]: DUID 00:01:00:01:32:71:fc:32:52:54:00:12:34:56 vm-test-run-plv8> server # [ 58.158272] dhcpcd[745]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 58.160114] dhcpcd[745]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-plv8> server # [ 58.375462] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-plv8> server # [ 58.423711] systemd[1]: Started backdoor.service. vm-test-run-plv8> server # connecting to host... 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: 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 60.10 seconds) vm-test-run-plv8> server: (finished: waiting for the VM to finish booting, in 60.10 seconds) vm-test-run-plv8> server # [ 59.590605] dhcpcd[745]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 59.619704] dhcpcd[745]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 59.653056] dhcpcd[745]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 60.535770] dhcpcd[745]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 60.545373] dhcpcd[745]: eth0: Router Advertisement from fe80::2 vm-test-run-plv8> server # [ 60.555834] dhcpcd[745]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-plv8> server # [ 60.568987] dhcpcd[745]: eth0: adding route to fec0::/64 vm-test-run-plv8> server # [ 60.573718] dhcpcd[745]: eth0: adding default route via fe80::2 vm-test-run-plv8> server # [ 61.023790] (udev-worker)[792]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-plv8> server # [ 61.029134] (udev-worker)[792]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 61.042437] (udev-worker)[790]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 61.729169] systemd-logind[652]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-plv8> server # [ 61.827075] systemd[1]: Found device Virtio network device. vm-test-run-plv8> server # [ 61.895412] systemd[1]: Starting Address configuration of eth1... vm-test-run-plv8> server # [ 62.847635] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-plv8> server # [ 62.847432] dhcpcd[745]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 62.930215] dhcpcd[745]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 62.934167] dhcpcd[745]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 62.944788] dhcpcd[745]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 63.035630] network-addresses-eth1-start[821]: adding address 192.168.1.1/24... done vm-test-run-plv8> server # [ 63.157011] dhcpcd[745]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 63.213804] network-addresses-eth1-start[821]: adding address 2001:db8:1::1/64... done vm-test-run-plv8> server # [ 63.496078] systemd[1]: Finished Address configuration of eth1. vm-test-run-plv8> server # [ 63.586522] systemd[1]: Starting Networking Setup... vm-test-run-plv8> server # [ 64.448847] mousedev: PS/2 mouse device common for all mice vm-test-run-plv8> server # [ 65.878601] systemd[1]: Finished Networking Setup. vm-test-run-plv8> server # [ 65.885701] systemd[1]: Reached target Network. vm-test-run-plv8> server # [ 65.917071] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-plv8> server # [ 65.963057] systemd[1]: Starting Permit User Sessions... vm-test-run-plv8> server # [ 66.373843] systemd[1]: Finished Permit User Sessions. vm-test-run-plv8> server # [ 66.427706] systemd[1]: Started Getty on tty1. vm-test-run-plv8> server # [ 66.436132] systemd[1]: Reached target Login Prompts. vm-test-run-plv8> server # [ 66.995872] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[925]: Initializing database at /var/lib/postgresql/data vm-test-run-plv8> server # [ 67.459976] dhcpcd[745]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-plv8> server # [ 67.473238] dhcpcd[745]: eth0: adding route to 10.0.2.0/24 vm-test-run-plv8> server # [ 67.475463] dhcpcd[745]: eth0: adding default route via 10.0.2.2 vm-test-run-plv8> server # [ 68.953268] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: The files belonging to this database system will be owned by user "postgres". vm-test-run-plv8> server # [ 68.978659] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: This user must also own the server process. vm-test-run-plv8> server # [ 69.065632] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-plv8> server # [ 69.077053] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: The default database encoding has accordingly been set to "UTF8". vm-test-run-plv8> server # [ 69.079103] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: The default text search configuration will be set to "english". vm-test-run-plv8> server # [ 69.089055] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: Data page checksums are enabled. vm-test-run-plv8> server # [ 69.089925] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-plv8> server # [ 69.100782] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: creating subdirectories ... ok vm-test-run-plv8> server # [ 69.113362] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: selecting dynamic shared memory implementation ... posix vm-test-run-plv8> server # [ 69.217981] systemd-logind[652]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-plv8> server # [ 70.291523] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: selecting default max_connections ... 100 vm-test-run-plv8> server # [ 70.623002] systemd[1]: Started DHCP Client. vm-test-run-plv8> server # [ 71.373931] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: selecting default shared_buffers ... 128MB vm-test-run-plv8> server # [ 80.634572] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: selecting default time zone ... UTC vm-test-run-plv8> server # [ 80.696907] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: creating configuration files ... ok vm-test-run-plv8> server # [ 84.879942] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: running bootstrap script ... ok vm-test-run-plv8> server # [ 95.541505] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: performing post-bootstrap initialization ... ok vm-test-run-plv8> server # [ 97.335363] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: syncing data to disk ... ok vm-test-run-plv8> server # [ 97.341013] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-plv8> server # [ 97.347252] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: 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 # [ 97.348434] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: Success. You can now start the database server using: vm-test-run-plv8> server # [ 97.349673] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[938]: /nix/store/pq36ia5m70l8q0iwq5vbv4y7i3aibf73-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-plv8> server # [ 98.888983] nksbn05hbj4lraga46vdki7fvb324dsr-postgresql-init[925]: Validating PostgreSQL configuration... vm-test-run-plv8> server # [ 99.228534] nksbn05hbj4lraga46vdki7fvb324dsr-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 # [ 99.875795] postgres[1333]: 2026-10-26 11:56:12.291 UTC [1333] LOG: pgaudit extension initialized vm-test-run-plv8> server # [ 100.669453] postgres[1333]: 2026-10-26 11:56:13.098 UTC [1333] LOG: pgsodium primary server secret key loaded vm-test-run-plv8> server # [ 101.197745] postgres[1333]: 2026-10-26 11:56:13.621 UTC [1333] LOG: vault primary server secret key loaded vm-test-run-plv8> server # [ 101.633989] postgres[1333]: 2026-10-26 11:56:14.068 UTC [1333] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-plv8> server # [ 101.653144] postgres[1333]: 2026-10-26 11:56:14.085 UTC [1333] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-plv8> server # [ 101.659763] postgres[1333]: 2026-10-26 11:56:14.095 UTC [1333] LOG: listening on IPv6 address "::", port 5432 vm-test-run-plv8> server # [ 101.693392] postgres[1333]: 2026-10-26 11:56:14.126 UTC [1333] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-plv8> server # [ 101.831716] postgres[1359]: 2026-10-26 11:56:14.254 UTC [1359] LOG: database system was shut down at 2026-10-26 11:56:07 UTC vm-test-run-plv8> server # [ 102.127856] postgres[1368]: 2026-10-26 11:56:14.547 UTC [1368] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 102.140606] postgres[1333]: 2026-10-26 11:56:14.553 UTC [1333] LOG: database system is ready to accept connections vm-test-run-plv8> server # [ 102.187296] postgres[1367]: 2026-10-26 11:56:14.620 UTC [1367] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-plv8> server # [ 102.204573] systemd[1]: Started PostgreSQL Database Server. vm-test-run-plv8> server # [ 102.251604] systemd[1]: Starting Supabase Database Initialization... vm-test-run-plv8> server # [ 102.279089] postgres[1333]: 2026-10-26 11:56:14.695 UTC [1333] LOG: background worker "pg_net 0.20.4 worker" (PID 1368) exited with exit code 1 vm-test-run-plv8> server # [ 102.388279] postgres[1369]: 2026-10-26 11:56:14.822 UTC [1369] LOG: pg_cron scheduler started vm-test-run-plv8> server # [ 102.626232] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Waiting for PostgreSQL to be ready... vm-test-run-plv8> server # [ 103.323739] postgres[1383]: 2026-10-26 11:56:15.732 UTC [1383] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 103.357488] postgres[1382]: ::1 2026-10-26 11:56:15.752 UTC [1382] root@root FATAL: role "root" does not exist vm-test-run-plv8> server # [ 103.370803] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: PostgreSQL is ready vm-test-run-plv8> server # [ 103.372014] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Creating postgres role... vm-test-run-plv8> server # [ 103.474341] postgres[1333]: 2026-10-26 11:56:15.900 UTC [1333] LOG: background worker "pg_net 0.20.4 worker" (PID 1383) exited with exit code 1 vm-test-run-plv8> server # [ 103.753393] postgres[1385]: ::1 2026-10-26 11:56:16.180 UTC [1385] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-plv8> server # [ 103.795539] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1384]: CREATE ROLE vm-test-run-plv8> server # [ 104.083972] postgres[1387]: ::1 2026-10-26 11:56:16.507 UTC [1387] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-plv8> server # [ 104.127445] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1386]: ALTER DATABASE vm-test-run-plv8> server # [ 104.157385] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-plv8> server # [ 104.531679] postgres[1392]: ::1 2026-10-26 11:56:16.955 UTC [1392] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-plv8> server # [ 104.599298] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: CREATE PUBLICATION vm-test-run-plv8> server # [ 104.605802] postgres[1392]: ::1 2026-10-26 11:56:17.023 UTC [1392] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-plv8> server # [ 104.616995] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: ALTER ROLE vm-test-run-plv8> server # [ 104.630201] postgres[1392]: ::1 2026-10-26 11:56:17.056 UTC [1392] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-plv8> server # [ 104.668711] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: CREATE ROLE vm-test-run-plv8> server # [ 104.685633] postgres[1392]: ::1 2026-10-26 11:56:17.101 UTC [1392] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-plv8> server # [ 104.687214] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: CREATE ROLE vm-test-run-plv8> server # [ 104.693016] postgres[1392]: ::1 2026-10-26 11:56:17.125 UTC [1392] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-plv8> server # [ 104.728060] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: GRANT ROLE vm-test-run-plv8> server # [ 104.729412] postgres[1392]: ::1 2026-10-26 11:56:17.165 UTC [1392] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-plv8> server # [ 104.739482] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: GRANT vm-test-run-plv8> server # [ 104.741672] postgres[1392]: ::1 2026-10-26 11:56:17.176 UTC [1392] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-plv8> server # [ 104.749724] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: CREATE ROLE vm-test-run-plv8> server # [ 104.754187] postgres[1392]: ::1 2026-10-26 11:56:17.190 UTC [1392] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-plv8> server # [ 104.766536] postgres[1392]: ::1 2026-10-26 11:56:17.202 UTC [1392] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-plv8> server # [ 104.767378] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: GRANT ROLE vm-test-run-plv8> server # [ 104.783550] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: CREATE SCHEMA vm-test-run-plv8> server # [ 104.792399] postgres[1392]: ::1 2026-10-26 11:56:17.220 UTC [1392] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-plv8> server # [ 107.139631] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: CREATE EXTENSION vm-test-run-plv8> server # [ 107.147913] postgres[1392]: ::1 2026-10-26 11:56:19.577 UTC [1392] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-plv8> server # [ 108.030152] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: CREATE EXTENSION vm-test-run-plv8> server # [ 108.034523] postgres[1392]: ::1 2026-10-26 11:56:20.467 UTC [1392] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-plv8> server # [ 108.041526] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: CREATE ROLE vm-test-run-plv8> server # [ 108.042660] postgres[1392]: ::1 2026-10-26 11:56:20.479 UTC [1392] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-plv8> server # [ 108.053289] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: CREATE ROLE vm-test-run-plv8> server # [ 108.054654] postgres[1392]: ::1 2026-10-26 11:56:20.487 UTC [1392] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-plv8> server # [ 108.058448] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: CREATE ROLE vm-test-run-plv8> server # [ 108.059918] postgres[1392]: ::1 2026-10-26 11:56:20.495 UTC [1392] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-plv8> server # [ 108.069207] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: CREATE ROLE vm-test-run-plv8> server # [ 108.070096] postgres[1392]: ::1 2026-10-26 11:56:20.506 UTC [1392] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-plv8> server # [ 108.079182] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: GRANT ROLE vm-test-run-plv8> server # [ 108.084062] postgres[1392]: ::1 2026-10-26 11:56:20.516 UTC [1392] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-plv8> server # [ 108.100076] postgres[1392]: ::1 2026-10-26 11:56:20.523 UTC [1392] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-plv8> server # [ 108.102158] postgres[1392]: ::1 2026-10-26 11:56:20.536 UTC [1392] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-plv8> server # [ 108.103576] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: GRANT ROLE vm-test-run-plv8> server # [ 108.122504] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: GRANT ROLE vm-test-run-plv8> server # [ 108.134005] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: GRANT ROLE vm-test-run-plv8> server # [ 108.135678] postgres[1392]: ::1 2026-10-26 11:56:20.546 UTC [1392] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 108.176734] postgres[1392]: ::1 2026-10-26 11:56:20.582 UTC [1392] 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 # [ 108.212715] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: GRANT vm-test-run-plv8> server # [ 108.214281] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 108.215100] postgres[1392]: ::1 2026-10-26 11:56:20.607 UTC [1392] 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 # [ 108.227635] postgres[1392]: ::1 2026-10-26 11:56:20.623 UTC [1392] 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 # [ 108.229820] postgres[1392]: ::1 2026-10-26 11:56:20.639 UTC [1392] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 108.230587] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 108.231958] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 108.244860] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: GRANT vm-test-run-plv8> server # [ 108.246950] postgres[1392]: ::1 2026-10-26 11:56:20.655 UTC [1392] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-plv8> server # [ 108.260832] postgres[1392]: ::1 2026-10-26 11:56:20.676 UTC [1392] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 108.262544] postgres[1392]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 108.263678] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: ALTER ROLE vm-test-run-plv8> server # [ 108.270149] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 108.273414] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 108.275249] postgres[1392]: ::1 2026-10-26 11:56:20.688 UTC [1392] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 108.284801] postgres[1392]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 108.286569] postgres[1392]: ::1 2026-10-26 11:56:20.700 UTC [1392] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 108.288351] postgres[1392]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 108.301983] postgres[1392]: ::1 2026-10-26 11:56:20.719 UTC [1392] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-plv8> server # [ 108.303540] postgres[1392]: ::1 2026-10-26 11:56:20.730 UTC [1392] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-plv8> server # [ 108.315437] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 108.318621] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: ALTER ROLE vm-test-run-plv8> server # [ 108.320297] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1388]: ALTER ROLE vm-test-run-plv8> server # [ 108.359373] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-plv8> server # [ 108.658181] postgres[1444]: ::1 2026-10-26 11:56:21.091 UTC [1444] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 108.690938] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE SCHEMA vm-test-run-plv8> server # [ 108.697552] postgres[1444]: ::1 2026-10-26 11:56:21.128 UTC [1444] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-plv8> server # [ 108.699074] postgres[1444]: instance_id uuid NULL, vm-test-run-plv8> server # [ 108.699728] postgres[1444]: id uuid NOT NULL UNIQUE, vm-test-run-plv8> server # [ 108.700180] postgres[1444]: aud varchar(255) NULL, vm-test-run-plv8> server # [ 108.705123] postgres[1444]: "role" varchar(255) NULL, vm-test-run-plv8> server # [ 108.706897] postgres[1444]: email varchar(255) NULL UNIQUE, vm-test-run-plv8> server # [ 108.709748] postgres[1444]: encrypted_password varchar(255) NULL, vm-test-run-plv8> server # [ 108.710350] postgres[1444]: confirmed_at timestamptz NULL, vm-test-run-plv8> server # [ 108.711487] postgres[1444]: invited_at timestamptz NULL, vm-test-run-plv8> server # [ 108.712200] postgres[1444]: confirmation_token varchar(255) NULL, vm-test-run-plv8> server # [ 108.713481] postgres[1444]: confirmation_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 108.714544] postgres[1444]: recovery_token varchar(255) NULL, vm-test-run-plv8> server # [ 108.715340] postgres[1444]: recovery_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 108.715748] postgres[1444]: email_change_token varchar(255) NULL, vm-test-run-plv8> server # [ 108.716103] postgres[1444]: email_change varchar(255) NULL, vm-test-run-plv8> server # [ 108.717170] postgres[1444]: email_change_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 108.721765] postgres[1444]: last_sign_in_at timestamptz NULL, vm-test-run-plv8> server # [ 108.723345] postgres[1444]: raw_app_meta_data jsonb NULL, vm-test-run-plv8> server # [ 108.723845] postgres[1444]: raw_user_meta_data jsonb NULL, vm-test-run-plv8> server # [ 108.729505] postgres[1444]: is_super_admin bool NULL, vm-test-run-plv8> server # [ 108.731682] postgres[1444]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 108.737478] postgres[1444]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 108.738332] postgres[1444]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 108.739402] postgres[1444]: ); vm-test-run-plv8> server # [ 108.864962] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE TABLE vm-test-run-plv8> server # [ 108.865818] postgres[1444]: ::1 2026-10-26 11:56:21.301 UTC [1444] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-plv8> server # [ 108.913215] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE INDEX vm-test-run-plv8> server # [ 108.918384] postgres[1444]: ::1 2026-10-26 11:56:21.353 UTC [1444] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-plv8> server # [ 108.940997] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE INDEX vm-test-run-plv8> server # [ 108.943285] postgres[1444]: ::1 2026-10-26 11:56:21.379 UTC [1444] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-plv8> server # [ 108.952432] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: COMMENT vm-test-run-plv8> server # [ 108.953791] postgres[1444]: ::1 2026-10-26 11:56:21.388 UTC [1444] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-plv8> server # [ 108.955272] postgres[1444]: instance_id uuid NULL, vm-test-run-plv8> server # [ 108.956943] postgres[1444]: id bigserial NOT NULL, vm-test-run-plv8> server # [ 108.957523] postgres[1444]: "token" varchar(255) NULL, vm-test-run-plv8> server # [ 108.957944] postgres[1444]: user_id varchar(255) NULL, vm-test-run-plv8> server # [ 108.958470] postgres[1444]: revoked bool NULL, vm-test-run-plv8> server # [ 108.959589] postgres[1444]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 108.959965] postgres[1444]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 108.961107] postgres[1444]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 108.961755] postgres[1444]: ); vm-test-run-plv8> server # [ 109.059742] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE TABLE vm-test-run-plv8> server # [ 109.065450] postgres[1444]: ::1 2026-10-26 11:56:21.499 UTC [1444] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-plv8> server # [ 109.083238] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE INDEX vm-test-run-plv8> server # [ 109.090798] postgres[1444]: ::1 2026-10-26 11:56:21.520 UTC [1444] 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 # [ 109.110796] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE INDEX vm-test-run-plv8> server # [ 109.111947] postgres[1444]: ::1 2026-10-26 11:56:21.547 UTC [1444] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-plv8> server # [ 109.138414] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE INDEX vm-test-run-plv8> server # [ 109.139382] postgres[1444]: ::1 2026-10-26 11:56:21.575 UTC [1444] 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 # [ 109.148086] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: COMMENT vm-test-run-plv8> server # [ 109.150069] postgres[1444]: ::1 2026-10-26 11:56:21.586 UTC [1444] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-plv8> server # [ 109.150836] postgres[1444]: id uuid NOT NULL, vm-test-run-plv8> server # [ 109.151545] postgres[1444]: uuid uuid NULL, vm-test-run-plv8> server # [ 109.152217] postgres[1444]: raw_base_config text NULL, vm-test-run-plv8> server # [ 109.161944] postgres[1444]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 109.162544] postgres[1444]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 109.163420] postgres[1444]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 109.164886] postgres[1444]: ); vm-test-run-plv8> server # [ 109.202232] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE TABLE vm-test-run-plv8> server # [ 109.205566] postgres[1444]: ::1 2026-10-26 11:56:21.641 UTC [1444] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-plv8> server # [ 109.214059] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: COMMENT vm-test-run-plv8> server # [ 109.216993] postgres[1444]: ::1 2026-10-26 11:56:21.652 UTC [1444] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-plv8> server # [ 109.218123] postgres[1444]: instance_id uuid NULL, vm-test-run-plv8> server # [ 109.218950] postgres[1444]: id uuid NOT NULL, vm-test-run-plv8> server # [ 109.219971] postgres[1444]: payload json NULL, vm-test-run-plv8> server # [ 109.225396] postgres[1444]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 109.226028] postgres[1444]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 109.226531] postgres[1444]: ); vm-test-run-plv8> server # [ 109.279203] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE TABLE vm-test-run-plv8> server # [ 109.281693] postgres[1444]: ::1 2026-10-26 11:56:21.718 UTC [1444] 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 # [ 109.313163] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE INDEX vm-test-run-plv8> server # [ 109.314649] postgres[1444]: ::1 2026-10-26 11:56:21.748 UTC [1444] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-plv8> server # [ 109.324788] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: COMMENT vm-test-run-plv8> server # [ 109.326458] postgres[1444]: ::1 2026-10-26 11:56:21.759 UTC [1444] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-plv8> server # [ 109.327853] postgres[1444]: "version" varchar(255) NOT NULL, vm-test-run-plv8> server # [ 109.329962] postgres[1444]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-plv8> server # [ 109.330492] postgres[1444]: ); vm-test-run-plv8> server # [ 109.357185] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE TABLE vm-test-run-plv8> server # [ 109.361634] postgres[1444]: ::1 2026-10-26 11:56:21.796 UTC [1444] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-plv8> server # [ 109.367870] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: COMMENT vm-test-run-plv8> server # [ 109.383678] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: INSERT 0 7 vm-test-run-plv8> server # [ 109.387320] postgres[1444]: ::1 2026-10-26 11:56:21.822 UTC [1444] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-plv8> server # [ 109.389630] postgres[1444]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-plv8> server # [ 109.390399] postgres[1444]: $$ language sql stable; vm-test-run-plv8> server # [ 109.398429] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE FUNCTION vm-test-run-plv8> server # [ 109.399461] postgres[1444]: ::1 2026-10-26 11:56:21.836 UTC [1444] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-plv8> server # [ 109.404936] postgres[1444]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-plv8> server # [ 109.405768] postgres[1444]: $$ language sql stable; vm-test-run-plv8> server # [ 109.411065] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE FUNCTION vm-test-run-plv8> server # [ 109.417315] postgres[1444]: ::1 2026-10-26 11:56:21.850 UTC [1444] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-plv8> server # [ 109.418105] postgres[1444]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-plv8> server # [ 109.418703] postgres[1444]: $$ language sql stable; vm-test-run-plv8> server # [ 109.423779] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE FUNCTION vm-test-run-plv8> server # [ 109.426968] postgres[1444]: ::1 2026-10-26 11:56:21.863 UTC [1444] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-plv8> server # [ 109.433876] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: GRANT vm-test-run-plv8> server # [ 109.434673] postgres[1444]: ::1 2026-10-26 11:56:21.871 UTC [1444] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 109.440112] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: CREATE ROLE vm-test-run-plv8> server # [ 109.445448] postgres[1444]: ::1 2026-10-26 11:56:21.879 UTC [1444] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.451901] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: GRANT vm-test-run-plv8> server # [ 109.457374] postgres[1444]: ::1 2026-10-26 11:56:21.890 UTC [1444] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.465675] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: GRANT vm-test-run-plv8> server # [ 109.469977] postgres[1444]: ::1 2026-10-26 11:56:21.904 UTC [1444] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.478267] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: GRANT vm-test-run-plv8> server # [ 109.482561] postgres[1444]: ::1 2026-10-26 11:56:21.916 UTC [1444] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-plv8> server # [ 109.488516] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: ALTER ROLE vm-test-run-plv8> server # [ 109.493077] postgres[1444]: ::1 2026-10-26 11:56:21.926 UTC [1444] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.502495] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: ALTER TABLE vm-test-run-plv8> server # [ 109.503429] postgres[1444]: ::1 2026-10-26 11:56:21.939 UTC [1444] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.518687] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: ALTER TABLE vm-test-run-plv8> server # [ 109.519739] postgres[1444]: ::1 2026-10-26 11:56:21.953 UTC [1444] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.525906] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: ALTER TABLE vm-test-run-plv8> server # [ 109.527728] postgres[1444]: ::1 2026-10-26 11:56:21.964 UTC [1444] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.540269] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: ALTER TABLE vm-test-run-plv8> server # [ 109.545025] postgres[1444]: ::1 2026-10-26 11:56:21.980 UTC [1444] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 109.554557] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1442]: ALTER TABLE vm-test-run-plv8> server # [ 109.594479] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-plv8> server # [ 109.834320] postgres[1446]: ::1 2026-10-26 11:56:22.263 UTC [1446] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 109.846645] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1445]: CREATE SCHEMA vm-test-run-plv8> server # [ 109.847924] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1445]: CREATE ROLE vm-test-run-plv8> server # [ 109.849710] postgres[1446]: ::1 2026-10-26 11:56:22.278 UTC [1446] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 109.852192] postgres[1446]: ::1 2026-10-26 11:56:22.288 UTC [1446] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-plv8> server # [ 109.862884] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1445]: ALTER ROLE vm-test-run-plv8> server # [ 109.863865] postgres[1446]: ::1 2026-10-26 11:56:22.300 UTC [1446] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-plv8> server # [ 109.876097] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1445]: GRANT vm-test-run-plv8> server # [ 109.905786] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1445]: DO vm-test-run-plv8> server # [ 109.944977] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-plv8> server # [ 110.309549] postgres[1456]: ::1 2026-10-26 11:56:22.729 UTC [1456] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-plv8> server # [ 110.341554] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: ALTER ROLE vm-test-run-plv8> server # [ 110.348680] postgres[1456]: ::1 2026-10-26 11:56:22.766 UTC [1456] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-plv8> server # [ 110.368889] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: ALTER ROLE vm-test-run-plv8> server # [ 110.373811] postgres[1456]: ::1 2026-10-26 11:56:22.810 UTC [1456] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-plv8> server # [ 110.374793] postgres[1456]: RETURNS event_trigger vm-test-run-plv8> server # [ 110.375540] postgres[1456]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 110.376146] postgres[1456]: AS $$ vm-test-run-plv8> server # [ 110.384885] postgres[1456]: DECLARE vm-test-run-plv8> server # [ 110.386687] postgres[1456]: schema_is_cron bool; vm-test-run-plv8> server # [ 110.387220] postgres[1456]: BEGIN vm-test-run-plv8> server # [ 110.388043] postgres[1456]: schema_is_cron = ( vm-test-run-plv8> server # [ 110.393163] postgres[1456]: SELECT n.nspname = 'cron' vm-test-run-plv8> server # [ 110.394158] postgres[1456]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 110.394702] postgres[1456]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-plv8> server # [ 110.395034] postgres[1456]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 110.396052] postgres[1456]: ); vm-test-run-plv8> server # [ 110.400050] postgres[1456]: vm-test-run-plv8> server # [ 110.405714] postgres[1456]: IF schema_is_cron vm-test-run-plv8> server # [ 110.406368] postgres[1456]: THEN vm-test-run-plv8> server # [ 110.406634] postgres[1456]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 110.406909] postgres[1456]: vm-test-run-plv8> server # [ 110.407197] postgres[1456]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 110.407573] postgres[1456]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 110.407893] postgres[1456]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 110.413675] postgres[1456]: vm-test-run-plv8> server # [ 110.414819] postgres[1456]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 110.415687] postgres[1456]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 110.421482] postgres[1456]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 110.422245] postgres[1456]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 110.423188] postgres[1456]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 110.426257] postgres[1456]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 110.426840] postgres[1456]: vm-test-run-plv8> server # [ 110.427464] postgres[1456]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 110.428205] postgres[1456]: vm-test-run-plv8> server # [ 110.444075] postgres[1456]: END IF; vm-test-run-plv8> server # [ 110.446804] postgres[1456]: vm-test-run-plv8> server # [ 110.447625] postgres[1456]: END; vm-test-run-plv8> server # [ 110.448473] postgres[1456]: $$; vm-test-run-plv8> server # [ 110.459967] postgres[1456]: ::1 2026-10-26 11:56:22.868 UTC [1456] 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 # [ 110.474294] postgres[1456]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 110.474964] postgres[1456]: ::1 2026-10-26 11:56:22.887 UTC [1456] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-plv8> server # [ 110.485888] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: CREATE FUNCTION vm-test-run-plv8> server # [ 110.487479] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 110.498832] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: COMMENT vm-test-run-plv8> server # [ 110.500095] postgres[1456]: ::1 2026-10-26 11:56:22.910 UTC [1456] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-plv8> server # [ 110.506975] postgres[1456]: RETURNS event_trigger vm-test-run-plv8> server # [ 110.507530] postgres[1456]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 110.508126] postgres[1456]: AS $$ vm-test-run-plv8> server # [ 110.518148] postgres[1456]: BEGIN vm-test-run-plv8> server # [ 110.518887] postgres[1456]: IF EXISTS ( vm-test-run-plv8> server # [ 110.519272] postgres[1456]: SELECT 1 vm-test-run-plv8> server # [ 110.520084] postgres[1456]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 110.526048] postgres[1456]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 110.526509] postgres[1456]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 110.527363] postgres[1456]: WHERE ext.extname = 'pg_net' vm-test-run-plv8> server # [ 110.527966] postgres[1456]: ) vm-test-run-plv8> server # [ 110.528231] postgres[1456]: THEN vm-test-run-plv8> server # [ 110.537291] postgres[1456]: IF NOT EXISTS ( vm-test-run-plv8> server # [ 110.538223] postgres[1456]: SELECT 1 vm-test-run-plv8> server # [ 110.538569] postgres[1456]: FROM pg_roles vm-test-run-plv8> server # [ 110.538814] postgres[1456]: WHERE rolname = 'supabase_functions_admin' vm-test-run-plv8> server # [ 110.539476] postgres[1456]: ) vm-test-run-plv8> server # [ 110.539810] postgres[1456]: THEN vm-test-run-plv8> server # [ 110.540083] postgres[1456]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 110.549092] postgres[1456]: END IF; vm-test-run-plv8> server # [ 110.549768] postgres[1456]: vm-test-run-plv8> server # [ 110.550064] postgres[1456]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 110.550386] postgres[1456]: vm-test-run-plv8> server # [ 110.550855] postgres[1456]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 110.551631] postgres[1456]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 110.551965] postgres[1456]: vm-test-run-plv8> server # [ 110.569078] postgres[1456]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plv8> server # [ 110.570117] postgres[1456]: 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 # [ 110.571038] postgres[1456]: vm-test-run-plv8> server # [ 110.571616] postgres[1456]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plv8> server # [ 110.571960] postgres[1456]: 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 # [ 110.594854] postgres[1456]: vm-test-run-plv8> server # [ 110.595673] postgres[1456]: 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 # [ 110.601601] postgres[1456]: 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 # [ 110.614109] postgres[1456]: END IF; vm-test-run-plv8> server # [ 110.614549] postgres[1456]: END; vm-test-run-plv8> server # [ 110.614815] postgres[1456]: $$; vm-test-run-plv8> server # [ 110.615601] postgres[1456]: ::1 2026-10-26 11:56:22.930 UTC [1456] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-plv8> server # [ 110.628625] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: CREATE FUNCTION vm-test-run-plv8> server # [ 110.629338] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: COMMENT vm-test-run-plv8> server # [ 110.629737] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: DO vm-test-run-plv8> server # [ 110.630633] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: CREATE ROLE vm-test-run-plv8> server # [ 110.631145] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: GRANT vm-test-run-plv8> server # [ 110.631647] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: GRANT vm-test-run-plv8> server # [ 110.647634] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: GRANT vm-test-run-plv8> server # [ 110.649143] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: GRANT vm-test-run-plv8> server # [ 110.649546] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: GRANT vm-test-run-plv8> server # [ 110.649823] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: GRANT vm-test-run-plv8> server # [ 110.650090] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: GRANT vm-test-run-plv8> server # [ 110.650597] postgres[1456]: ::1 2026-10-26 11:56:22.967 UTC [1456] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-plv8> server # [ 110.651090] postgres[1456]: ::1 2026-10-26 11:56:22.975 UTC [1456] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-plv8> server # [ 110.651938] postgres[1456]: ::1 2026-10-26 11:56:22.987 UTC [1456] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 110.652562] postgres[1456]: ::1 2026-10-26 11:56:22.999 UTC [1456] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 110.665420] postgres[1456]: ::1 2026-10-26 11:56:23.006 UTC [1456] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 110.667612] postgres[1456]: ::1 2026-10-26 11:56:23.019 UTC [1456] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 110.675592] postgres[1456]: ::1 2026-10-26 11:56:23.023 UTC [1456] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 110.684545] postgres[1456]: ::1 2026-10-26 11:56:23.030 UTC [1456] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 110.695883] postgres[1456]: ::1 2026-10-26 11:56:23.037 UTC [1456] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 110.705106] postgres[1456]: ::1 2026-10-26 11:56:23.059 UTC [1456] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 110.723121] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: GRANT vm-test-run-plv8> server # [ 110.740806] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: GRANT vm-test-run-plv8> server # [ 110.742354] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1448]: DO vm-test-run-plv8> server # [ 110.764225] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running pgbouncer auth schema... vm-test-run-plv8> server # [ 111.068837] postgres[1470]: ::1 2026-10-26 11:56:23.498 UTC [1470] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-plv8> server # [ 111.079739] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1464]: CREATE ROLE vm-test-run-plv8> server # [ 111.081215] postgres[1470]: ::1 2026-10-26 11:56:23.508 UTC [1470] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-plv8> server # [ 111.086936] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1464]: REVOKE vm-test-run-plv8> server # [ 111.088019] postgres[1470]: ::1 2026-10-26 11:56:23.524 UTC [1470] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-plv8> server # [ 111.169047] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1464]: CREATE SCHEMA vm-test-run-plv8> server # [ 111.171842] postgres[1470]: ::1 2026-10-26 11:56:23.608 UTC [1470] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-plv8> server # [ 111.172857] postgres[1470]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-plv8> server # [ 111.181030] postgres[1470]: $$ vm-test-run-plv8> server # [ 111.181759] postgres[1470]: BEGIN vm-test-run-plv8> server # [ 111.182619] postgres[1470]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-plv8> server # [ 111.189116] postgres[1470]: vm-test-run-plv8> server # [ 111.189934] postgres[1470]: RETURN QUERY vm-test-run-plv8> server # [ 111.190858] postgres[1470]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-plv8> server # [ 111.192300] postgres[1470]: WHERE usename = p_usename; vm-test-run-plv8> server # [ 111.197774] postgres[1470]: END; vm-test-run-plv8> server # [ 111.198375] postgres[1470]: $$ LANGUAGE plpgsql vm-test-run-plv8> server # [ 111.198707] postgres[1470]: SET search_path = '' vm-test-run-plv8> server # [ 111.198978] postgres[1470]: SECURITY DEFINER; vm-test-run-plv8> server # [ 111.205444] postgres[1470]: ::1 2026-10-26 11:56:23.634 UTC [1470] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-plv8> server # [ 111.206566] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1464]: CREATE FUNCTION vm-test-run-plv8> server # [ 111.207425] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1464]: REVOKE vm-test-run-plv8> server # [ 111.207950] postgres[1470]: ::1 2026-10-26 11:56:23.643 UTC [1470] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-plv8> server # [ 111.215746] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1464]: GRANT vm-test-run-plv8> server # [ 111.256757] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running stat extension... vm-test-run-plv8> server # [ 111.466753] postgres[1476]: ::1 2026-10-26 11:56:23.895 UTC [1476] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-plv8> server # [ 111.472965] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1475]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-plv8> server # [ 111.479472] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1475]: CREATE SCHEMA vm-test-run-plv8> server # [ 111.481763] postgres[1476]: ::1 2026-10-26 11:56:23.918 UTC [1476] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-plv8> server # [ 112.579074] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1475]: CREATE EXTENSION vm-test-run-plv8> server # [ 112.643419] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-plv8> server # [ 112.850730] postgres[1482]: ::1 2026-10-26 11:56:25.283 UTC [1482] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-plv8> server # [ 112.879197] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.880089] postgres[1482]: ::1 2026-10-26 11:56:25.300 UTC [1482] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 112.882292] postgres[1482]: ::1 2026-10-26 11:56:25.312 UTC [1482] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 112.886853] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.887470] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.892744] postgres[1482]: ::1 2026-10-26 11:56:25.326 UTC [1482] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 112.900309] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.905059] postgres[1482]: ::1 2026-10-26 11:56:25.339 UTC [1482] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 112.913307] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.916714] postgres[1482]: ::1 2026-10-26 11:56:25.351 UTC [1482] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 112.925179] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.926754] postgres[1482]: ::1 2026-10-26 11:56:25.361 UTC [1482] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 112.935017] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.937051] postgres[1482]: ::1 2026-10-26 11:56:25.367 UTC [1482] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 112.944428] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.951853] postgres[1482]: ::1 2026-10-26 11:56:25.383 UTC [1482] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 112.977193] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 113.001377] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1481]: DO vm-test-run-plv8> server # [ 113.002473] postgres[1482]: ::1 2026-10-26 11:56:25.438 UTC [1482] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-plv8> server # [ 113.011248] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1481]: ALTER ROLE vm-test-run-plv8> server # [ 113.050566] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-plv8> server # [ 113.306260] postgres[1484]: ::1 2026-10-26 11:56:25.731 UTC [1484] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 113.342821] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: GRANT vm-test-run-plv8> server # [ 113.346228] postgres[1484]: ::1 2026-10-26 11:56:25.760 UTC [1484] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 113.355483] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: GRANT vm-test-run-plv8> server # [ 113.361446] postgres[1484]: ::1 2026-10-26 11:56:25.795 UTC [1484] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 113.381168] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: GRANT vm-test-run-plv8> server # [ 113.389751] postgres[1484]: ::1 2026-10-26 11:56:25.815 UTC [1484] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 113.413879] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: ALTER TABLE vm-test-run-plv8> server # [ 113.414843] postgres[1484]: ::1 2026-10-26 11:56:25.846 UTC [1484] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 113.431022] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: ALTER TABLE vm-test-run-plv8> server # [ 113.433582] postgres[1484]: ::1 2026-10-26 11:56:25.869 UTC [1484] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 113.460900] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: ALTER TABLE vm-test-run-plv8> server # [ 113.462222] postgres[1484]: ::1 2026-10-26 11:56:25.895 UTC [1484] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 113.470921] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: ALTER TABLE vm-test-run-plv8> server # [ 113.471911] postgres[1484]: ::1 2026-10-26 11:56:25.908 UTC [1484] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 113.485570] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: ALTER TABLE vm-test-run-plv8> server # [ 113.486413] postgres[1484]: ::1 2026-10-26 11:56:25.923 UTC [1484] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 113.498482] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: GRANT vm-test-run-plv8> server # [ 113.499674] postgres[1484]: ::1 2026-10-26 11:56:25.936 UTC [1484] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 113.514211] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: GRANT vm-test-run-plv8> server # [ 113.515032] postgres[1484]: ::1 2026-10-26 11:56:25.951 UTC [1484] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 113.525370] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: GRANT vm-test-run-plv8> server # [ 113.533434] postgres[1484]: ::1 2026-10-26 11:56:25.968 UTC [1484] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 113.577057] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: GRANT vm-test-run-plv8> server # [ 113.587789] postgres[1484]: ::1 2026-10-26 11:56:26.019 UTC [1484] 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 # [ 113.637424] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 113.645796] postgres[1484]: ::1 2026-10-26 11:56:26.071 UTC [1484] 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 # [ 113.653095] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 113.654965] postgres[1484]: ::1 2026-10-26 11:56:26.087 UTC [1484] 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 # [ 113.671028] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1483]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 113.715404] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-plv8> server # [ 114.179284] postgres[1503]: ::1 2026-10-26 11:56:26.600 UTC [1503] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-plv8> server # [ 114.211908] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1499]: CREATE SCHEMA vm-test-run-plv8> server # [ 114.253407] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-plv8> server # [ 114.685456] postgres[1509]: ::1 2026-10-26 11:56:27.087 UTC [1509] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-plv8> server # [ 114.686977] postgres[1509]: ::1 2026-10-26 11:56:27.122 UTC [1509] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 114.691470] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 114.705697] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 114.707515] postgres[1509]: ::1 2026-10-26 11:56:27.140 UTC [1509] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 114.714090] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 114.715522] postgres[1509]: ::1 2026-10-26 11:56:27.151 UTC [1509] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 114.737169] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1505]: GRANT vm-test-run-plv8> server # [ 114.783968] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-plv8> server # [ 115.085362] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1513]: DO vm-test-run-plv8> server # [ 115.097046] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1513]: DO vm-test-run-plv8> server # [ 115.105758] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1513]: DO vm-test-run-plv8> server # [ 115.149887] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-plv8> server # [ 115.378627] postgres[1516]: ::1 2026-10-26 11:56:27.807 UTC [1516] 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 # [ 115.400401] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1515]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 115.402518] postgres[1516]: ::1 2026-10-26 11:56:27.837 UTC [1516] 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 # [ 115.410160] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1515]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 115.411826] postgres[1516]: ::1 2026-10-26 11:56:27.848 UTC [1516] 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 # [ 115.424858] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1515]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 115.469161] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-plv8> server # [ 115.818953] postgres[1521]: ::1 2026-10-26 11:56:28.252 UTC [1521] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-plv8> server # [ 115.851498] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1517]: ALTER ROLE vm-test-run-plv8> server # [ 115.895347] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-plv8> server # [ 116.229726] postgres[1524]: ::1 2026-10-26 11:56:28.656 UTC [1524] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 116.258886] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: 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 # [ 116.268741] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 116.270803] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: 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 # [ 116.278993] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: DROP FUNCTION vm-test-run-plv8> server # [ 116.282204] postgres[1524]: ::1 2026-10-26 11:56:28.678 UTC [1524] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 116.289385] postgres[1524]: ::1 2026-10-26 11:56:28.692 UTC [1524] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 116.290163] postgres[1524]: DECLARE vm-test-run-plv8> server # [ 116.291551] postgres[1524]: cmd record; vm-test-run-plv8> server # [ 116.295658] postgres[1524]: BEGIN vm-test-run-plv8> server # [ 116.298778] postgres[1524]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 116.302870] postgres[1524]: LOOP vm-test-run-plv8> server # [ 116.306940] postgres[1524]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 116.308135] postgres[1524]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 116.313183] postgres[1524]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 116.315313] postgres[1524]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 116.316258] postgres[1524]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 116.316593] postgres[1524]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 116.316891] postgres[1524]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 116.325020] postgres[1524]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 116.325757] postgres[1524]: , 'CREATE TYPE' vm-test-run-plv8> server # [ 116.326610] postgres[1524]: , 'CREATE RULE' vm-test-run-plv8> server # [ 116.327535] postgres[1524]: , 'COMMENT' vm-test-run-plv8> server # [ 116.328061] postgres[1524]: ) vm-test-run-plv8> server # [ 116.330298] postgres[1524]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 116.332521] postgres[1524]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 116.332872] postgres[1524]: THEN vm-test-run-plv8> server # [ 116.333716] postgres[1524]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 116.334399] postgres[1524]: END IF; vm-test-run-plv8> server # [ 116.334653] postgres[1524]: END LOOP; vm-test-run-plv8> server # [ 116.334889] postgres[1524]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 116.335977] postgres[1524]: ::1 2026-10-26 11:56:28.753 UTC [1524] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 116.337972] postgres[1524]: DECLARE vm-test-run-plv8> server # [ 116.338526] postgres[1524]: obj record; vm-test-run-plv8> server # [ 116.339485] postgres[1524]: BEGIN vm-test-run-plv8> server # [ 116.340017] postgres[1524]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 116.342570] postgres[1524]: LOOP vm-test-run-plv8> server # [ 116.343584] postgres[1524]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 116.344548] postgres[1524]: 'schema' vm-test-run-plv8> server # [ 116.344919] postgres[1524]: , 'table' vm-test-run-plv8> server # [ 116.345826] postgres[1524]: , 'foreign table' vm-test-run-plv8> server # [ 116.346121] postgres[1524]: , 'view' vm-test-run-plv8> server # [ 116.346645] postgres[1524]: , 'materialized view' vm-test-run-plv8> server # [ 116.346948] postgres[1524]: , 'function' vm-test-run-plv8> server # [ 116.348051] postgres[1524]: , 'trigger' vm-test-run-plv8> server # [ 116.348479] postgres[1524]: , 'type' vm-test-run-plv8> server # [ 116.349772] postgres[1524]: , 'rule' vm-test-run-plv8> server # [ 116.350945] postgres[1524]: ) vm-test-run-plv8> server # [ 116.352864] postgres[1524]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 116.354021] postgres[1524]: THEN vm-test-run-plv8> server # [ 116.354808] postgres[1524]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 116.355292] postgres[1524]: END IF; vm-test-run-plv8> server # [ 116.355637] postgres[1524]: END LOOP; vm-test-run-plv8> server # [ 116.356112] postgres[1524]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 116.356858] postgres[1524]: ::1 2026-10-26 11:56:28.772 UTC [1524] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 116.358148] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: CREATE FUNCTION vm-test-run-plv8> server # [ 116.360230] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: CREATE FUNCTION vm-test-run-plv8> server # [ 116.361692] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: 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 # [ 116.363568] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 116.365426] postgres[1524]: ::1 2026-10-26 11:56:28.789 UTC [1524] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 116.366250] postgres[1524]: ON ddl_command_end vm-test-run-plv8> server # [ 116.367319] postgres[1524]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 116.373573] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 116.374553] postgres[1524]: ::1 2026-10-26 11:56:28.810 UTC [1524] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 116.375482] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: 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 # [ 116.380185] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 116.385714] postgres[1524]: ::1 2026-10-26 11:56:28.816 UTC [1524] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 116.387675] postgres[1524]: ON sql_drop vm-test-run-plv8> server # [ 116.388277] postgres[1524]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 116.399545] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1523]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 116.445770] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-plv8> server # [ 117.685984] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1525]: DO vm-test-run-plv8> server # [ 117.718866] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-plv8> server # [ 118.124433] postgres[1552]: ::1 2026-10-26 11:56:30.553 UTC [1552] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-plv8> server # [ 118.174175] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: CREATE SCHEMA vm-test-run-plv8> server # [ 118.175639] postgres[1552]: ::1 2026-10-26 11:56:30.597 UTC [1552] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-plv8> server # [ 118.179620] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: 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 # [ 118.194275] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: DROP FUNCTION vm-test-run-plv8> server # [ 118.208807] postgres[1552]: ::1 2026-10-26 11:56:30.642 UTC [1552] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 118.210257] postgres[1552]: "operationName" text default null, vm-test-run-plv8> server # [ 118.210981] postgres[1552]: query text default null, vm-test-run-plv8> server # [ 118.215636] postgres[1552]: variables jsonb default null, vm-test-run-plv8> server # [ 118.221841] postgres[1552]: extensions jsonb default null vm-test-run-plv8> server # [ 118.230118] postgres[1552]: ) vm-test-run-plv8> server # [ 118.232848] postgres[1552]: returns jsonb vm-test-run-plv8> server # [ 118.233433] postgres[1552]: language plpgsql vm-test-run-plv8> server # [ 118.237448] postgres[1552]: as $$ vm-test-run-plv8> server # [ 118.238245] postgres[1552]: DECLARE vm-test-run-plv8> server # [ 118.239401] postgres[1552]: server_version float; vm-test-run-plv8> server # [ 118.240350] postgres[1552]: BEGIN vm-test-run-plv8> server # [ 118.241923] postgres[1552]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 118.242484] postgres[1552]: vm-test-run-plv8> server # [ 118.243056] postgres[1552]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 118.243744] postgres[1552]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 118.248147] postgres[1552]: 'data', null::jsonb, vm-test-run-plv8> server # [ 118.250386] postgres[1552]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 118.256992] postgres[1552]: ); vm-test-run-plv8> server # [ 118.260095] postgres[1552]: ELSE vm-test-run-plv8> server # [ 118.268823] postgres[1552]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 118.269742] postgres[1552]: 'data', null::jsonb, vm-test-run-plv8> server # [ 118.270319] postgres[1552]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 118.270677] postgres[1552]: ); vm-test-run-plv8> server # [ 118.270909] postgres[1552]: END IF; vm-test-run-plv8> server # [ 118.271184] postgres[1552]: END; vm-test-run-plv8> server # [ 118.271565] postgres[1552]: $$; vm-test-run-plv8> server # [ 118.273642] postgres[1552]: ::1 2026-10-26 11:56:30.700 UTC [1552] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.277084] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: CREATE FUNCTION vm-test-run-plv8> server # [ 118.285889] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: GRANT vm-test-run-plv8> server # [ 118.287593] postgres[1552]: ::1 2026-10-26 11:56:30.719 UTC [1552] 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 # [ 118.298795] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 118.300594] postgres[1552]: ::1 2026-10-26 11:56:30.737 UTC [1552] 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 # [ 118.313045] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 118.328337] postgres[1552]: ::1 2026-10-26 11:56:30.761 UTC [1552] 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 # [ 118.342871] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 118.343929] postgres[1552]: ::1 2026-10-26 11:56:30.776 UTC [1552] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 118.347095] postgres[1552]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.353579] postgres[1552]: ::1 2026-10-26 11:56:30.788 UTC [1552] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 118.354300] postgres[1552]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.355295] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 118.377522] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 118.378589] postgres[1552]: ::1 2026-10-26 11:56:30.803 UTC [1552] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 118.380121] postgres[1552]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.393344] postgres[1552]: ::1 2026-10-26 11:56:30.822 UTC [1552] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 118.394948] postgres[1552]: RETURNS event_trigger vm-test-run-plv8> server # [ 118.395611] postgres[1552]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 118.400643] postgres[1552]: AS $func$ vm-test-run-plv8> server # [ 118.403576] postgres[1552]: DECLARE vm-test-run-plv8> server # [ 118.403978] postgres[1552]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 118.410737] postgres[1552]: BEGIN vm-test-run-plv8> server # [ 118.411389] postgres[1552]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 118.411831] postgres[1552]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 118.413992] postgres[1552]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 118.415364] postgres[1552]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 118.415839] postgres[1552]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 118.417394] postgres[1552]: ); vm-test-run-plv8> server # [ 118.417696] postgres[1552]: vm-test-run-plv8> server # [ 118.417990] postgres[1552]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 118.419494] postgres[1552]: THEN vm-test-run-plv8> server # [ 118.420001] postgres[1552]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.422527] postgres[1552]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.424003] postgres[1552]: vm-test-run-plv8> server # [ 118.425514] postgres[1552]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.426574] postgres[1552]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.429166] postgres[1552]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.431346] postgres[1552]: vm-test-run-plv8> server # [ 118.431925] postgres[1552]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 118.434419] postgres[1552]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 118.434935] postgres[1552]: "operationName" text default null, vm-test-run-plv8> server # [ 118.435337] postgres[1552]: query text default null, vm-test-run-plv8> server # [ 118.437332] postgres[1552]: variables jsonb default null, vm-test-run-plv8> server # [ 118.438126] postgres[1552]: extensions jsonb default null vm-test-run-plv8> server # [ 118.438866] postgres[1552]: ) vm-test-run-plv8> server # [ 118.439488] postgres[1552]: returns jsonb vm-test-run-plv8> server # [ 118.441413] postgres[1552]: language sql vm-test-run-plv8> server # [ 118.441776] postgres[1552]: as $$ vm-test-run-plv8> server # [ 118.443117] postgres[1552]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-plv8> server # [ 118.443867] postgres[1552]: $$; vm-test-run-plv8> server # [ 118.444503] postgres[1552]: vm-test-run-plv8> server # [ 118.445625] postgres[1552]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 118.446556] postgres[1552]: END IF; vm-test-run-plv8> server # [ 118.447369] postgres[1552]: vm-test-run-plv8> server # [ 118.447919] postgres[1552]: END; vm-test-run-plv8> server # [ 118.448358] postgres[1552]: $func$; vm-test-run-plv8> server # [ 118.449405] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 118.450208] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: CREATE FUNCTION vm-test-run-plv8> server # [ 118.450639] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: 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 # [ 118.451867] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 118.454272] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 118.454832] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: COMMENT vm-test-run-plv8> server # [ 118.456307] postgres[1552]: ::1 2026-10-26 11:56:30.837 UTC [1552] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-plv8> server # [ 118.462796] postgres[1552]: ::1 2026-10-26 11:56:30.840 UTC [1552] 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 # [ 118.465684] postgres[1552]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-plv8> server # [ 118.467080] postgres[1552]: ::1 2026-10-26 11:56:30.850 UTC [1552] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-plv8> server # [ 118.469216] postgres[1552]: ::1 2026-10-26 11:56:30.871 UTC [1552] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 118.470368] postgres[1552]: RETURNS event_trigger vm-test-run-plv8> server # [ 118.471337] postgres[1552]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 118.472282] postgres[1552]: AS $func$ vm-test-run-plv8> server # [ 118.473319] postgres[1552]: DECLARE vm-test-run-plv8> server # [ 118.473643] postgres[1552]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 118.474193] postgres[1552]: BEGIN vm-test-run-plv8> server # [ 118.475791] postgres[1552]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 118.477276] postgres[1552]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 118.477833] postgres[1552]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 118.478385] postgres[1552]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 118.478883] postgres[1552]: ); vm-test-run-plv8> server # [ 118.479316] postgres[1552]: vm-test-run-plv8> server # [ 118.479623] postgres[1552]: IF graphql_is_dropped vm-test-run-plv8> server # [ 118.480200] postgres[1552]: THEN vm-test-run-plv8> server # [ 118.480504] postgres[1552]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 118.481996] postgres[1552]: "operationName" text default null, vm-test-run-plv8> server # [ 118.482389] postgres[1552]: query text default null, vm-test-run-plv8> server # [ 118.483782] postgres[1552]: variables jsonb default null, vm-test-run-plv8> server # [ 118.484800] postgres[1552]: extensions jsonb default null vm-test-run-plv8> server # [ 118.485749] postgres[1552]: ) vm-test-run-plv8> server # [ 118.486640] postgres[1552]: returns jsonb vm-test-run-plv8> server # [ 118.487047] postgres[1552]: language plpgsql vm-test-run-plv8> server # [ 118.487353] postgres[1552]: as $$ vm-test-run-plv8> server # [ 118.487702] postgres[1552]: DECLARE vm-test-run-plv8> server # [ 118.489086] postgres[1552]: server_version float; vm-test-run-plv8> server # [ 118.489617] postgres[1552]: BEGIN vm-test-run-plv8> server # [ 118.489930] postgres[1552]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 118.490687] postgres[1552]: vm-test-run-plv8> server # [ 118.491044] postgres[1552]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 118.492021] postgres[1552]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 118.493063] postgres[1552]: 'data', null::jsonb, vm-test-run-plv8> server # [ 118.493593] postgres[1552]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 118.493948] postgres[1552]: ); vm-test-run-plv8> server # [ 118.494346] postgres[1552]: ELSE vm-test-run-plv8> server # [ 118.494614] postgres[1552]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 118.494877] postgres[1552]: 'data', null::jsonb, vm-test-run-plv8> server # [ 118.495746] postgres[1552]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 118.496495] postgres[1552]: ); vm-test-run-plv8> server # [ 118.496951] postgres[1552]: END IF; vm-test-run-plv8> server # [ 118.497232] postgres[1552]: END; vm-test-run-plv8> server # [ 118.497663] postgres[1552]: $$; vm-test-run-plv8> server # [ 118.498108] postgres[1552]: END IF; vm-test-run-plv8> server # [ 118.499470] postgres[1552]: vm-test-run-plv8> server # [ 118.500540] postgres[1552]: END; vm-test-run-plv8> server # [ 118.501140] postgres[1552]: $func$; vm-test-run-plv8> server # [ 118.511387] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: CREATE FUNCTION vm-test-run-plv8> server # [ 118.515824] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: 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 # [ 118.524079] postgres[1552]: ::1 2026-10-26 11:56:30.949 UTC [1552] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-plv8> server # [ 118.526051] postgres[1552]: ::1 2026-10-26 11:56:30.956 UTC [1552] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-plv8> server # [ 118.527025] postgres[1552]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-plv8> server # [ 118.528193] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 118.535000] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 118.545544] postgres[1552]: ::1 2026-10-26 11:56:30.972 UTC [1552] 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 # [ 118.550580] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1551]: COMMENT vm-test-run-plv8> server # [ 118.591211] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-plv8> server # [ 118.780988] postgres[1554]: ::1 2026-10-26 11:56:31.214 UTC [1554] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 118.786778] postgres[1554]: ::1 2026-10-26 11:56:31.220 UTC [1554] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 118.791427] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1553]: 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 # [ 118.793908] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1553]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 118.795245] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1553]: 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 # [ 118.800152] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1553]: DROP FUNCTION vm-test-run-plv8> server # [ 118.800941] postgres[1554]: ::1 2026-10-26 11:56:31.237 UTC [1554] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 118.801419] postgres[1554]: DECLARE vm-test-run-plv8> server # [ 118.804274] postgres[1554]: cmd record; vm-test-run-plv8> server # [ 118.805453] postgres[1554]: BEGIN vm-test-run-plv8> server # [ 118.806004] postgres[1554]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 118.806341] postgres[1554]: LOOP vm-test-run-plv8> server # [ 118.806658] postgres[1554]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 118.806954] postgres[1554]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 118.807293] postgres[1554]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 118.813514] postgres[1554]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 118.814318] postgres[1554]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 118.814666] postgres[1554]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 118.815586] postgres[1554]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 118.816074] postgres[1554]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 118.818251] postgres[1554]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-plv8> server # [ 118.818694] postgres[1554]: , 'CREATE RULE' vm-test-run-plv8> server # [ 118.819333] postgres[1554]: , 'COMMENT' vm-test-run-plv8> server # [ 118.819663] postgres[1554]: ) vm-test-run-plv8> server # [ 118.820173] postgres[1554]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 118.820604] postgres[1554]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 118.822043] postgres[1554]: THEN vm-test-run-plv8> server # [ 118.822555] postgres[1554]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 118.823391] postgres[1554]: END IF; vm-test-run-plv8> server # [ 118.823884] postgres[1554]: END LOOP; vm-test-run-plv8> server # [ 118.824123] postgres[1554]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 118.845808] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1553]: CREATE FUNCTION vm-test-run-plv8> server # [ 118.846917] postgres[1554]: ::1 2026-10-26 11:56:31.281 UTC [1554] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 118.853092] postgres[1554]: DECLARE vm-test-run-plv8> server # [ 118.855164] postgres[1554]: obj record; vm-test-run-plv8> server # [ 118.856172] postgres[1554]: BEGIN vm-test-run-plv8> server # [ 118.862235] postgres[1554]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 118.863427] postgres[1554]: LOOP vm-test-run-plv8> server # [ 118.864129] postgres[1554]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 118.864991] postgres[1554]: 'schema' vm-test-run-plv8> server # [ 118.872941] postgres[1554]: , 'table' vm-test-run-plv8> server # [ 118.875093] postgres[1554]: , 'foreign table' vm-test-run-plv8> server # [ 118.881852] postgres[1554]: , 'view' vm-test-run-plv8> server # [ 118.883279] postgres[1554]: , 'materialized view' vm-test-run-plv8> server # [ 118.883696] postgres[1554]: , 'function' vm-test-run-plv8> server # [ 118.883991] postgres[1554]: , 'trigger' vm-test-run-plv8> server # [ 118.887421] postgres[1554]: , 'type' vm-test-run-plv8> server # [ 118.897958] postgres[1554]: , 'rule' vm-test-run-plv8> server # [ 118.898870] postgres[1554]: ) vm-test-run-plv8> server # [ 118.899504] postgres[1554]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 118.909531] postgres[1554]: THEN vm-test-run-plv8> server # [ 118.910217] postgres[1554]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 118.910524] postgres[1554]: END IF; vm-test-run-plv8> server # [ 118.911613] postgres[1554]: END LOOP; vm-test-run-plv8> server # [ 118.915692] postgres[1554]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 118.923943] postgres[1554]: ::1 2026-10-26 11:56:31.315 UTC [1554] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 118.930649] postgres[1554]: ::1 2026-10-26 11:56:31.327 UTC [1554] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 118.932423] postgres[1554]: ON ddl_command_end vm-test-run-plv8> server # [ 118.945286] postgres[1554]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 118.946147] postgres[1554]: ::1 2026-10-26 11:56:31.338 UTC [1554] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 118.947625] postgres[1554]: ::1 2026-10-26 11:56:31.343 UTC [1554] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 118.959368] postgres[1554]: ON sql_drop vm-test-run-plv8> server # [ 118.967755] postgres[1554]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 118.979855] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1553]: CREATE FUNCTION vm-test-run-plv8> server # [ 118.987369] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1553]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 118.994300] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1553]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 118.995339] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1553]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 118.995802] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1553]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 119.013633] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-plv8> server # [ 119.212249] postgres[1556]: ::1 2026-10-26 11:56:31.645 UTC [1556] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-plv8> server # [ 119.239516] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1555]: ALTER ROLE vm-test-run-plv8> server # [ 119.253061] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-plv8> server # [ 119.686509] postgres[1562]: ::1 2026-10-26 11:56:32.080 UTC [1562] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 119.687819] postgres[1562]: returns event_trigger vm-test-run-plv8> server # [ 119.699027] postgres[1562]: language plpgsql vm-test-run-plv8> server # [ 119.707347] postgres[1562]: AS $func$ vm-test-run-plv8> server # [ 119.708068] postgres[1562]: DECLARE vm-test-run-plv8> server # [ 119.722627] postgres[1562]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 119.723529] postgres[1562]: BEGIN vm-test-run-plv8> server # [ 119.724116] postgres[1562]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 119.731317] postgres[1562]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 119.733473] postgres[1562]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 119.735085] postgres[1562]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 119.741600] postgres[1562]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 119.743358] postgres[1562]: ); vm-test-run-plv8> server # [ 119.753059] postgres[1562]: vm-test-run-plv8> server # [ 119.753654] postgres[1562]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 119.755687] postgres[1562]: THEN vm-test-run-plv8> server # [ 119.769211] postgres[1562]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.770964] postgres[1562]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.777760] postgres[1562]: vm-test-run-plv8> server # [ 119.779664] postgres[1562]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.786943] postgres[1562]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.787987] postgres[1562]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.794607] postgres[1562]: vm-test-run-plv8> server # [ 119.795069] postgres[1562]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 119.802344] postgres[1562]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 119.803908] postgres[1562]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 119.805960] postgres[1562]: "operationName" text default null, vm-test-run-plv8> server # [ 119.807511] postgres[1562]: query text default null, vm-test-run-plv8> server # [ 119.808278] postgres[1562]: variables jsonb default null, vm-test-run-plv8> server # [ 119.813580] postgres[1562]: extensions jsonb default null vm-test-run-plv8> server # [ 119.814358] postgres[1562]: ) vm-test-run-plv8> server # [ 119.820950] postgres[1562]: returns jsonb vm-test-run-plv8> server # [ 119.821920] postgres[1562]: language sql vm-test-run-plv8> server # [ 119.822276] postgres[1562]: as $$ vm-test-run-plv8> server # [ 119.822743] postgres[1562]: -- This changed vm-test-run-plv8> server # [ 119.823896] postgres[1562]: select graphql.resolve( vm-test-run-plv8> server # [ 119.830608] postgres[1562]: query := query, vm-test-run-plv8> server # [ 119.831176] postgres[1562]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 119.831504] postgres[1562]: "operationName" := "operationName", vm-test-run-plv8> server # [ 119.832288] postgres[1562]: extensions := extensions vm-test-run-plv8> server # [ 119.832627] postgres[1562]: ); vm-test-run-plv8> server # [ 119.845260] postgres[1562]: $$; vm-test-run-plv8> server # [ 119.846302] postgres[1562]: vm-test-run-plv8> server # [ 119.852582] postgres[1562]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 119.854615] postgres[1562]: END IF; vm-test-run-plv8> server # [ 119.856316] postgres[1562]: vm-test-run-plv8> server # [ 119.861964] postgres[1562]: END; vm-test-run-plv8> server # [ 119.863105] postgres[1562]: $func$; vm-test-run-plv8> server # [ 119.869656] postgres[1562]: ::1 2026-10-26 11:56:32.279 UTC [1562] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 119.870559] postgres[1562]: RETURNS event_trigger vm-test-run-plv8> server # [ 119.870996] postgres[1562]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 119.871480] postgres[1562]: AS $func$ vm-test-run-plv8> server # [ 119.872063] postgres[1562]: DECLARE vm-test-run-plv8> server # [ 119.878041] postgres[1562]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 119.879539] postgres[1562]: BEGIN vm-test-run-plv8> server # [ 119.888903] postgres[1562]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 119.889710] postgres[1562]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 119.890549] postgres[1562]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 119.891072] postgres[1562]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 119.891629] postgres[1562]: ); vm-test-run-plv8> server # [ 119.909459] postgres[1562]: vm-test-run-plv8> server # [ 119.910267] postgres[1562]: IF graphql_is_dropped vm-test-run-plv8> server # [ 119.911289] postgres[1562]: THEN vm-test-run-plv8> server # [ 119.911619] postgres[1562]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 119.914321] postgres[1562]: "operationName" text default null, vm-test-run-plv8> server # [ 119.928955] postgres[1562]: query text default null, vm-test-run-plv8> server # [ 119.930013] postgres[1562]: variables jsonb default null, vm-test-run-plv8> server # [ 119.931971] postgres[1562]: extensions jsonb default null vm-test-run-plv8> server # [ 119.950740] postgres[1562]: ) vm-test-run-plv8> server # [ 119.951424] postgres[1562]: returns jsonb vm-test-run-plv8> server # [ 119.977079] postgres[1562]: language plpgsql vm-test-run-plv8> server # [ 119.978610] postgres[1562]: as $$ vm-test-run-plv8> server # [ 119.979016] postgres[1562]: DECLARE vm-test-run-plv8> server # [ 119.980377] postgres[1562]: server_version float; vm-test-run-plv8> server # [ 120.005908] postgres[1562]: BEGIN vm-test-run-plv8> server # [ 120.007458] postgres[1562]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 120.007839] postgres[1562]: vm-test-run-plv8> server # [ 120.016702] postgres[1562]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 120.019015] postgres[1562]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 120.025557] postgres[1562]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 120.027953] postgres[1562]: jsonb_build_object( vm-test-run-plv8> server # [ 120.033111] postgres[1562]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 120.034879] postgres[1562]: ) vm-test-run-plv8> server # [ 120.035638] postgres[1562]: ) vm-test-run-plv8> server # [ 120.046018] postgres[1562]: ); vm-test-run-plv8> server # [ 120.047411] postgres[1562]: ELSE vm-test-run-plv8> server # [ 120.059851] postgres[1562]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 120.073463] postgres[1562]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 120.074061] postgres[1562]: jsonb_build_object( vm-test-run-plv8> server # [ 120.074495] postgres[1562]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 120.075489] postgres[1562]: ) vm-test-run-plv8> server # [ 120.075850] postgres[1562]: ) vm-test-run-plv8> server # [ 120.076354] postgres[1562]: ); vm-test-run-plv8> server # [ 120.076741] postgres[1562]: END IF; vm-test-run-plv8> server # [ 120.090282] postgres[1562]: END; vm-test-run-plv8> server # [ 120.091411] postgres[1562]: $$; vm-test-run-plv8> server # [ 120.091966] postgres[1562]: END IF; vm-test-run-plv8> server # [ 120.108971] postgres[1562]: vm-test-run-plv8> server # [ 120.110459] postgres[1562]: END; vm-test-run-plv8> server # [ 120.110998] postgres[1562]: $func$; vm-test-run-plv8> server # [ 120.143248] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1557]: CREATE FUNCTION vm-test-run-plv8> server # [ 120.154637] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1557]: CREATE FUNCTION vm-test-run-plv8> server # [ 120.155565] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1557]: CREATE FUNCTION vm-test-run-plv8> server # [ 120.161141] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1557]: 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 # [ 120.163085] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1557]: DROP EXTENSION vm-test-run-plv8> server # [ 120.170219] postgres[1562]: ::1 2026-10-26 11:56:32.323 UTC [1562] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 120.171563] postgres[1562]: "operationName" text default null, vm-test-run-plv8> server # [ 120.172199] postgres[1562]: query text default null, vm-test-run-plv8> server # [ 120.174442] postgres[1562]: variables jsonb default null, vm-test-run-plv8> server # [ 120.175706] postgres[1562]: extensions jsonb default null vm-test-run-plv8> server # [ 120.181509] postgres[1562]: ) vm-test-run-plv8> server # [ 120.182650] postgres[1562]: returns jsonb vm-test-run-plv8> server # [ 120.185385] postgres[1562]: language plpgsql vm-test-run-plv8> server # [ 120.186090] postgres[1562]: as $$ vm-test-run-plv8> server # [ 120.187354] postgres[1562]: DECLARE vm-test-run-plv8> server # [ 120.187773] postgres[1562]: server_version float; vm-test-run-plv8> server # [ 120.194032] postgres[1562]: BEGIN vm-test-run-plv8> server # [ 120.195018] postgres[1562]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 120.196715] postgres[1562]: vm-test-run-plv8> server # [ 120.197301] postgres[1562]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 120.198063] postgres[1562]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 120.198725] postgres[1562]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 120.199902] postgres[1562]: jsonb_build_object( vm-test-run-plv8> server # [ 120.205819] postgres[1562]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 120.212970] postgres[1562]: ) vm-test-run-plv8> server # [ 120.214938] postgres[1562]: ) vm-test-run-plv8> server # [ 120.215886] postgres[1562]: ); vm-test-run-plv8> server # [ 120.217789] postgres[1562]: ELSE vm-test-run-plv8> server # [ 120.219015] postgres[1562]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 120.220056] postgres[1562]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 120.226624] postgres[1562]: jsonb_build_object( vm-test-run-plv8> server # [ 120.233875] postgres[1562]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 120.237379] postgres[1562]: ) vm-test-run-plv8> server # [ 120.238774] postgres[1562]: ) vm-test-run-plv8> server # [ 120.239721] postgres[1562]: ); vm-test-run-plv8> server # [ 120.246503] postgres[1562]: END IF; vm-test-run-plv8> server # [ 120.247461] postgres[1562]: END; vm-test-run-plv8> server # [ 120.250380] postgres[1562]: $$; vm-test-run-plv8> server # [ 120.252156] postgres[1562]: ::1 2026-10-26 11:56:32.347 UTC [1562] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 121.765273] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1557]: DO vm-test-run-plv8> server # [ 121.817628] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: 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 # [ 122.076486] postgres[1588]: ::1 2026-10-26 11:56:34.509 UTC [1588] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-plv8> server # [ 122.101280] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1587]: GRANT ROLE vm-test-run-plv8> server # [ 122.129167] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-plv8> server # [ 122.361938] postgres[1590]: ::1 2026-10-26 11:56:34.790 UTC [1590] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 122.362760] postgres[1590]: returns event_trigger vm-test-run-plv8> server # [ 122.363743] postgres[1590]: language plpgsql vm-test-run-plv8> server # [ 122.364186] postgres[1590]: AS $func$ vm-test-run-plv8> server # [ 122.365913] postgres[1590]: DECLARE vm-test-run-plv8> server # [ 122.366281] postgres[1590]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 122.366560] postgres[1590]: BEGIN vm-test-run-plv8> server # [ 122.367043] postgres[1590]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 122.369099] postgres[1590]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 122.369829] postgres[1590]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 122.370507] postgres[1590]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 122.371358] postgres[1590]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 122.372671] postgres[1590]: ); vm-test-run-plv8> server # [ 122.373211] postgres[1590]: vm-test-run-plv8> server # [ 122.374905] postgres[1590]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 122.375465] postgres[1590]: THEN vm-test-run-plv8> server # [ 122.375741] postgres[1590]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 122.376420] postgres[1590]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 122.378661] postgres[1590]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 122.379265] postgres[1590]: "operationName" text default null, vm-test-run-plv8> server # [ 122.382646] postgres[1590]: query text default null, vm-test-run-plv8> server # [ 122.384226] postgres[1590]: variables jsonb default null, vm-test-run-plv8> server # [ 122.385230] postgres[1590]: extensions jsonb default null vm-test-run-plv8> server # [ 122.387676] postgres[1590]: ) vm-test-run-plv8> server # [ 122.388771] postgres[1590]: returns jsonb vm-test-run-plv8> server # [ 122.390098] postgres[1590]: language sql vm-test-run-plv8> server # [ 122.390665] postgres[1590]: as $$ vm-test-run-plv8> server # [ 122.391497] postgres[1590]: select graphql.resolve( vm-test-run-plv8> server # [ 122.392087] postgres[1590]: query := query, vm-test-run-plv8> server # [ 122.392412] postgres[1590]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 122.395539] postgres[1590]: "operationName" := "operationName", vm-test-run-plv8> server # [ 122.396108] postgres[1590]: extensions := extensions vm-test-run-plv8> server # [ 122.398045] postgres[1590]: ); vm-test-run-plv8> server # [ 122.398645] postgres[1590]: $$; vm-test-run-plv8> server # [ 122.399330] postgres[1590]: vm-test-run-plv8> server # [ 122.400095] postgres[1590]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 122.402481] postgres[1590]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 122.403331] postgres[1590]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 122.403683] postgres[1590]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 122.404209] postgres[1590]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 122.406032] postgres[1590]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 122.407466] postgres[1590]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 122.409702] postgres[1590]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 122.410574] postgres[1590]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 122.411540] postgres[1590]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 122.413568] postgres[1590]: END IF; vm-test-run-plv8> server # [ 122.414792] postgres[1590]: vm-test-run-plv8> server # [ 122.415426] postgres[1590]: END; vm-test-run-plv8> server # [ 122.416005] postgres[1590]: $func$; vm-test-run-plv8> server # [ 122.451349] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1589]: CREATE FUNCTION vm-test-run-plv8> server # [ 122.453386] postgres[1590]: ::1 2026-10-26 11:56:34.885 UTC [1590] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 122.505632] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1589]: DROP EXTENSION vm-test-run-plv8> server # [ 124.264043] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1589]: DO vm-test-run-plv8> server # [ 124.315602] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-plv8> server # [ 125.244590] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1615]: DO vm-test-run-plv8> server # [ 125.888309] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1615]: DO vm-test-run-plv8> server # [ 125.951348] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-plv8> server # [ 126.351386] postgres[1628]: ::1 2026-10-26 11:56:38.774 UTC [1628] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-plv8> server # [ 126.387680] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1622]: ALTER ROLE vm-test-run-plv8> server # [ 126.412098] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-plv8> server # [ 126.839436] postgres[1639]: ::1 2026-10-26 11:56:39.264 UTC [1639] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-plv8> server # [ 126.865608] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1634]: REVOKE ROLE vm-test-run-plv8> server # [ 126.886142] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-plv8> server # [ 129.467099] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1645]: DO vm-test-run-plv8> server # [ 129.523538] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-plv8> server # [ 129.875364] postgres[1671]: ::1 2026-10-26 11:56:42.294 UTC [1671] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-plv8> server # [ 129.933269] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1665]: GRANT ROLE vm-test-run-plv8> server # [ 129.941504] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-plv8> server # [ 130.264162] postgres[1678]: ::1 2026-10-26 11:56:42.691 UTC [1678] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 130.303807] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1676]: GRANT vm-test-run-plv8> server # [ 130.306308] postgres[1678]: ::1 2026-10-26 11:56:42.730 UTC [1678] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 130.337184] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1676]: GRANT vm-test-run-plv8> server # [ 130.338071] postgres[1678]: ::1 2026-10-26 11:56:42.774 UTC [1678] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 130.346213] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1676]: GRANT vm-test-run-plv8> server # [ 130.347121] postgres[1678]: ::1 2026-10-26 11:56:42.783 UTC [1678] 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 # [ 130.367016] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1676]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 130.374030] postgres[1678]: ::1 2026-10-26 11:56:42.804 UTC [1678] 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 # [ 130.381075] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1676]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 130.381943] postgres[1678]: ::1 2026-10-26 11:56:42.818 UTC [1678] 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 # [ 130.389901] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1676]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 130.426908] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-plv8> server # [ 130.759664] postgres[1683]: ::1 2026-10-26 11:56:43.180 UTC [1683] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-plv8> server # [ 130.804202] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1679]: GRANT ROLE vm-test-run-plv8> server # [ 130.844020] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 131.212473] postgres[1686]: ::1 2026-10-26 11:56:43.639 UTC [1686] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-plv8> server # [ 131.250427] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1685]: GRANT ROLE vm-test-run-plv8> server # [ 131.287289] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-plv8> server # [ 131.534485] postgres[1688]: ::1 2026-10-26 11:56:43.962 UTC [1688] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-plv8> server # [ 131.546896] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1687]: ALTER ROLE vm-test-run-plv8> server # [ 131.550212] postgres[1688]: ::1 2026-10-26 11:56:43.979 UTC [1688] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-plv8> server # [ 131.556095] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1687]: ALTER ROLE vm-test-run-plv8> server # [ 131.561029] postgres[1688]: ::1 2026-10-26 11:56:43.996 UTC [1688] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-plv8> server # [ 131.569913] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1687]: ALTER ROLE vm-test-run-plv8> server # [ 131.593256] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1687]: DO vm-test-run-plv8> server # [ 131.628805] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 131.867714] postgres[1690]: ::1 2026-10-26 11:56:44.300 UTC [1690] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-plv8> server # [ 131.881893] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1689]: GRANT ROLE vm-test-run-plv8> server # [ 131.883586] postgres[1690]: ::1 2026-10-26 11:56:44.312 UTC [1690] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-plv8> server # [ 131.886904] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1689]: REVOKE ROLE vm-test-run-plv8> server # [ 131.934201] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-plv8> server # [ 132.203235] postgres[1692]: ::1 2026-10-26 11:56:44.633 UTC [1692] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 132.206673] postgres[1692]: returns event_trigger vm-test-run-plv8> server # [ 132.208215] postgres[1692]: language plpgsql vm-test-run-plv8> server # [ 132.211047] postgres[1692]: AS $func$ vm-test-run-plv8> server # [ 132.213637] postgres[1692]: DECLARE vm-test-run-plv8> server # [ 132.214157] postgres[1692]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 132.214707] postgres[1692]: BEGIN vm-test-run-plv8> server # [ 132.215623] postgres[1692]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 132.218390] postgres[1692]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 132.219412] postgres[1692]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 132.221687] postgres[1692]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 132.222281] postgres[1692]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 132.223456] postgres[1692]: ); vm-test-run-plv8> server # [ 132.225206] postgres[1692]: vm-test-run-plv8> server # [ 132.227229] postgres[1692]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 132.229722] postgres[1692]: THEN vm-test-run-plv8> server # [ 132.231772] postgres[1692]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 132.233192] postgres[1692]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 132.235076] postgres[1692]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 132.236346] postgres[1692]: "operationName" text default null, vm-test-run-plv8> server # [ 132.237576] postgres[1692]: query text default null, vm-test-run-plv8> server # [ 132.238633] postgres[1692]: variables jsonb default null, vm-test-run-plv8> server # [ 132.240984] postgres[1692]: extensions jsonb default null vm-test-run-plv8> server # [ 132.241629] postgres[1692]: ) vm-test-run-plv8> server # [ 132.243114] postgres[1692]: returns jsonb vm-test-run-plv8> server # [ 132.243837] postgres[1692]: language sql vm-test-run-plv8> server # [ 132.244302] postgres[1692]: as $$ vm-test-run-plv8> server # [ 132.245925] postgres[1692]: select graphql.resolve( vm-test-run-plv8> server # [ 132.249642] postgres[1692]: query := query, vm-test-run-plv8> server # [ 132.250162] postgres[1692]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 132.250473] postgres[1692]: "operationName" := "operationName", vm-test-run-plv8> server # [ 132.251544] postgres[1692]: extensions := extensions vm-test-run-plv8> server # [ 132.253195] postgres[1692]: ); vm-test-run-plv8> server # [ 132.254928] postgres[1692]: $$; vm-test-run-plv8> server # [ 132.257094] postgres[1692]: vm-test-run-plv8> server # [ 132.258560] postgres[1692]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 132.260064] postgres[1692]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 132.262025] postgres[1692]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 132.264751] postgres[1692]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 132.267723] postgres[1692]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 132.269372] postgres[1692]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 132.272453] postgres[1692]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 132.273597] postgres[1692]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 132.275814] postgres[1692]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 132.277446] postgres[1692]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 132.278480] postgres[1692]: vm-test-run-plv8> server # [ 132.280815] postgres[1692]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-plv8> server # [ 132.281793] postgres[1692]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-plv8> server # [ 132.285080] postgres[1692]: grant usage on schema graphql to postgres with grant option; vm-test-run-plv8> server # [ 132.285966] postgres[1692]: END IF; vm-test-run-plv8> server # [ 132.286286] postgres[1692]: vm-test-run-plv8> server # [ 132.286965] postgres[1692]: END; vm-test-run-plv8> server # [ 132.288565] postgres[1692]: $func$; vm-test-run-plv8> server # [ 132.422812] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1691]: CREATE FUNCTION vm-test-run-plv8> server # [ 132.429406] postgres[1692]: ::1 2026-10-26 11:56:44.844 UTC [1692] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 132.563346] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1691]: DROP EXTENSION vm-test-run-plv8> server # [ 134.513459] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1691]: DO vm-test-run-plv8> server # [ 134.543925] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-plv8> server # [ 134.950395] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1717]: DO vm-test-run-plv8> server # [ 134.973648] postgres[1721]: ::1 2026-10-26 11:56:47.381 UTC [1721] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-plv8> server # [ 134.974706] postgres[1721]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 134.975083] postgres[1721]: AS $$ vm-test-run-plv8> server # [ 134.975670] postgres[1721]: BEGIN vm-test-run-plv8> server # [ 134.976300] postgres[1721]: IF EXISTS ( vm-test-run-plv8> server # [ 134.977880] postgres[1721]: SELECT vm-test-run-plv8> server # [ 134.978389] postgres[1721]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 134.982360] postgres[1721]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 134.982885] postgres[1721]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 134.983462] postgres[1721]: WHERE ext.extname = 'pg_cron' vm-test-run-plv8> server # [ 134.985366] postgres[1721]: ) vm-test-run-plv8> server # [ 134.986837] postgres[1721]: THEN vm-test-run-plv8> server # [ 134.987511] postgres[1721]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 134.988038] postgres[1721]: vm-test-run-plv8> server # [ 134.989348] postgres[1721]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 134.990517] postgres[1721]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 134.993696] postgres[1721]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 134.994964] postgres[1721]: vm-test-run-plv8> server # [ 134.996142] postgres[1721]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 134.998062] postgres[1721]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 134.999925] postgres[1721]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 135.001156] postgres[1721]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 135.001605] postgres[1721]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 135.001949] postgres[1721]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 135.005609] postgres[1721]: vm-test-run-plv8> server # [ 135.006681] postgres[1721]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 135.011074] postgres[1721]: revoke all on table cron.job from postgres; vm-test-run-plv8> server # [ 135.012050] postgres[1721]: grant select on table cron.job to postgres with grant option; vm-test-run-plv8> server # [ 135.013822] postgres[1721]: END IF; vm-test-run-plv8> server # [ 135.022726] postgres[1721]: END; vm-test-run-plv8> server # [ 135.023380] postgres[1721]: $$; vm-test-run-plv8> server # [ 135.038478] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1717]: CREATE FUNCTION vm-test-run-plv8> server # [ 135.039872] postgres[1721]: ::1 2026-10-26 11:56:47.475 UTC [1721] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-plv8> server # [ 135.061319] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1717]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 135.062814] postgres[1721]: ::1 2026-10-26 11:56:47.494 UTC [1721] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-plv8> server # [ 135.070286] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1717]: ALTER FUNCTION vm-test-run-plv8> server # [ 135.076907] postgres[1721]: ::1 2026-10-26 11:56:47.509 UTC [1721] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-plv8> server # [ 135.078154] postgres[1721]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-plv8> server # [ 135.078580] postgres[1721]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 135.083972] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1717]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 135.143788] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-plv8> server # [ 135.470896] postgres[1724]: ::1 2026-10-26 11:56:47.894 UTC [1724] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-plv8> server # [ 135.496189] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1723]: ALTER ROLE vm-test-run-plv8> server # [ 135.532996] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-plv8> server # [ 135.833858] postgres[1726]: ::1 2026-10-26 11:56:48.262 UTC [1726] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-plv8> server # [ 135.875039] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1725]: ALTER FUNCTION vm-test-run-plv8> server # [ 135.881098] postgres[1726]: ::1 2026-10-26 11:56:48.304 UTC [1726] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-plv8> server # [ 135.883522] postgres[1726]: ::1 2026-10-26 11:56:48.311 UTC [1726] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-plv8> server # [ 135.890823] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1725]: ALTER FUNCTION vm-test-run-plv8> server # [ 135.891530] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1725]: ALTER FUNCTION vm-test-run-plv8> server # [ 135.947791] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-plv8> server # [ 136.379875] postgres[1734]: ::1 2026-10-26 11:56:48.794 UTC [1734] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-plv8> server # [ 136.433940] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1727]: GRANT ROLE vm-test-run-plv8> server # [ 136.465682] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-plv8> server # [ 137.760112] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1739]: DO vm-test-run-plv8> server # [ 137.834342] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-plv8> server # [ 138.147917] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1755]: DO vm-test-run-plv8> server # [ 138.152044] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1755]: DO vm-test-run-plv8> server # [ 138.182495] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-plv8> server # [ 138.419695] postgres[1758]: ::1 2026-10-26 11:56:50.851 UTC [1758] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-plv8> server # [ 138.450618] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1757]: ALTER ROLE vm-test-run-plv8> server # [ 138.452088] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1757]: ALTER ROLE vm-test-run-plv8> server # [ 138.458437] postgres[1758]: ::1 2026-10-26 11:56:50.874 UTC [1758] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-plv8> server # [ 138.459483] postgres[1758]: ::1 2026-10-26 11:56:50.882 UTC [1758] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-plv8> server # [ 138.469460] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1757]: ALTER ROLE vm-test-run-plv8> server # [ 138.490851] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-plv8> server # [ 138.942751] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1759]: DO vm-test-run-plv8> server # [ 138.993714] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-plv8> server # [ 139.401828] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1765]: DO vm-test-run-plv8> server # [ 139.441408] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-plv8> server # [ 140.122453] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1767]: CREATE FUNCTION vm-test-run-plv8> server # [ 140.127690] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1767]: DO vm-test-run-plv8> server # [ 140.195292] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-plv8> server # [ 140.806953] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1780]: ALTER FUNCTION vm-test-run-plv8> server # [ 140.843757] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1780]: GRANT vm-test-run-plv8> server # [ 140.889247] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-plv8> server # [ 141.318114] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1795]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 141.342061] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1795]: ALTER FUNCTION vm-test-run-plv8> server # [ 141.361085] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1795]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 141.443871] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 141.733792] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1797]: DO vm-test-run-plv8> server # [ 141.770727] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-plv8> server # [ 142.101633] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1799]: CREATE FUNCTION vm-test-run-plv8> server # [ 142.113141] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1799]: GRANT vm-test-run-plv8> server # [ 142.158009] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-plv8> server # [ 142.432469] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1801]: REVOKE ROLE vm-test-run-plv8> server # [ 142.475967] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1801]: DO vm-test-run-plv8> server # [ 142.492527] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1801]: DO vm-test-run-plv8> server # [ 142.498470] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1801]: REVOKE ROLE vm-test-run-plv8> server # [ 142.518201] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1801]: REVOKE vm-test-run-plv8> server # [ 142.575192] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1801]: DO vm-test-run-plv8> server # [ 142.635545] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 143.151014] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1806]: DO vm-test-run-plv8> server # [ 143.204858] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 143.770183] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1817]: DO vm-test-run-plv8> server # [ 143.803962] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 144.318983] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1826]: DO vm-test-run-plv8> server # [ 144.346080] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-plv8> server # [ 144.743336] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1833]: ALTER ROLE vm-test-run-plv8> server # [ 144.781209] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-plv8> server # [ 145.201452] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1839]: GRANT ROLE vm-test-run-plv8> server # [ 145.212659] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1839]: DO vm-test-run-plv8> server # [ 145.257536] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-plv8> server # [ 145.657021] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1842]: GRANT vm-test-run-plv8> server # [ 145.697382] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-plv8> server # [ 145.995009] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1844]: CREATE FUNCTION vm-test-run-plv8> server # [ 146.003403] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1844]: REVOKE vm-test-run-plv8> server # [ 146.017221] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1844]: REVOKE vm-test-run-plv8> server # [ 146.031458] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1844]: GRANT vm-test-run-plv8> server # [ 146.073689] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-plv8> server # [ 146.390317] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1846]: DO vm-test-run-plv8> server # [ 146.438852] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-plv8> server # [ 146.871418] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1848]: ALTER ROLE vm-test-run-plv8> server # [ 146.911374] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-plv8> server # [ 147.256898] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 vm-test-run-plv8> server # [ 147.849551] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1860]: DROP EXTENSION vm-test-run-plv8> server # [ 147.869220] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-plv8> server # [ 148.302849] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1876]: CREATE FUNCTION vm-test-run-plv8> server # [ 148.313680] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1876]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 148.318216] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1876]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 148.351223] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-plv8> server # [ 148.640245] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1879]: DO vm-test-run-plv8> server # [ 148.680072] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1879]: CREATE FUNCTION vm-test-run-plv8> server # [ 148.739329] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-plv8> server # [ 149.210737] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1883]: CREATE FUNCTION vm-test-run-plv8> server # [ 149.233904] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1883]: CREATE FUNCTION vm-test-run-plv8> server # [ 149.306776] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql vm-test-run-plv8> server # [ 149.631641] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1887]: CREATE FUNCTION vm-test-run-plv8> server # [ 149.645974] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1887]: CREATE FUNCTION vm-test-run-plv8> server # [ 149.660819] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1887]: CREATE FUNCTION vm-test-run-plv8> server # [ 149.678313] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1887]: CREATE FUNCTION vm-test-run-plv8> server # [ 149.691027] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1887]: CREATE FUNCTION vm-test-run-plv8> server # [ 149.702462] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1887]: CREATE FUNCTION vm-test-run-plv8> server # [ 149.746142] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Running postgresql schema... vm-test-run-plv8> server # [ 150.034801] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER DATABASE vm-test-run-plv8> server # [ 150.044046] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER DATABASE vm-test-run-plv8> server # [ 150.194121] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER ROLE vm-test-run-plv8> server # [ 150.314245] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER ROLE vm-test-run-plv8> server # [ 150.441186] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER ROLE vm-test-run-plv8> server # [ 150.551174] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER ROLE vm-test-run-plv8> server # [ 150.663372] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER ROLE vm-test-run-plv8> server # [ 150.760988] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER ROLE vm-test-run-plv8> server # [ 150.841778] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER ROLE vm-test-run-plv8> server # [ 150.925265] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER ROLE vm-test-run-plv8> server # [ 151.018409] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER ROLE vm-test-run-plv8> server # [ 151.066046] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1889]: ALTER ROLE vm-test-run-plv8> server # [ 151.133630] y0hwskss2y0bl4czgb61m2glslcfbrb0-supabase-db-init[1373]: Database initialization complete vm-test-run-plv8> server # [ 151.163739] systemd[1]: Finished Supabase Database Initialization. vm-test-run-plv8> server # [ 151.194197] systemd[1]: Reached target Multi-User System. vm-test-run-plv8> server # [ 151.196110] systemd[1]: Startup finished in 19.322s (kernel) + 2min 11.843s (userspace) = 2min 31.166s. vm-test-run-plv8> server: (finished: waiting for unit supabase-db-init.service, in 152.49 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.51 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.4' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.4' CASCADE;" , in 6.85 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.71 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.86 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 # [ 163.433465] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 163.627767] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-plv8> server # [ 163.651711] systemd[1]: Stopped Virtual Console Setup. vm-test-run-plv8> server # [ 163.700999] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 169.123692] systemd[1]: Finished Virtual Console Setup. 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 8.87 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 # [ 169.522162] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. 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.62 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.52 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 # [ 172.555835] systemd-logind[652]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 6.02 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.40 seconds) vm-test-run-plv8> (finished: subtest: Check upgrade path with postgresql 15, in 25.35 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.42 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 1.37 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.41 seconds) vm-test-run-plv8> (finished: subtest: Check the install of the last version of the extension, in 2.20 seconds) vm-test-run-plv8> (finished: run the VM test script, in 180.17 seconds) vm-test-run-plv8> test script finished in 180.50s 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> 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