these 12 derivations will be built: /nix/store/zy6jp7vh9r635a7yffsl463zj7y2r86c-processed-postgresql-config-15.drv /nix/store/2dg7pbijxsij5hw6vdvi5vkrxr7q106p-postgresql-init.drv /nix/store/z2zz82m1y4ysbpn1lqi19gvfpf5bdpka-unit-postgresql.service.drv /nix/store/wqda9hzdnmqm4iv2nfq1blrw3yfnx1ng-system-units.drv /nix/store/gxlxsrhpf8r9gcmd2wyl84xvppld30ry-etc.drv /nix/store/ms6a50pi37hg4ns8mj1jwb6jcm94nr55-activate.drv /nix/store/6lmd31fjnwh2z3szl2svbx0aiazlhljc-nixos-system-server-test.drv /nix/store/q0bs4xr53xdsj1ic4cv268bx7a7ga266-closure-info.drv /nix/store/cpdxw1q2whxkd48w48hkvq5p6afwvsfa-run-nixos-vm.drv /nix/store/y469kszvwah55v57dq3xng4gsxr70k1v-nixos-vm.drv /nix/store/a28a6mhwxfpsyq43l3h9qygl6ywm6ijc-nixos-test-driver-plv8.drv /nix/store/g2smnvla7wxqy5837dm6m8ilbpvw7cg4-vm-test-run-plv8.drv building '/nix/store/zy6jp7vh9r635a7yffsl463zj7y2r86c-processed-postgresql-config-15.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/zy6jp7vh9r635a7yffsl463zj7y2r86c-processed-postgresql-config-15.drv' building '/nix/store/2dg7pbijxsij5hw6vdvi5vkrxr7q106p-postgresql-init.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/2dg7pbijxsij5hw6vdvi5vkrxr7q106p-postgresql-init.drv' building '/nix/store/z2zz82m1y4ysbpn1lqi19gvfpf5bdpka-unit-postgresql.service.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/z2zz82m1y4ysbpn1lqi19gvfpf5bdpka-unit-postgresql.service.drv' building '/nix/store/wqda9hzdnmqm4iv2nfq1blrw3yfnx1ng-system-units.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/wqda9hzdnmqm4iv2nfq1blrw3yfnx1ng-system-units.drv' building '/nix/store/gxlxsrhpf8r9gcmd2wyl84xvppld30ry-etc.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/gxlxsrhpf8r9gcmd2wyl84xvppld30ry-etc.drv' building '/nix/store/ms6a50pi37hg4ns8mj1jwb6jcm94nr55-activate.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/ms6a50pi37hg4ns8mj1jwb6jcm94nr55-activate.drv' building '/nix/store/6lmd31fjnwh2z3szl2svbx0aiazlhljc-nixos-system-server-test.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/6lmd31fjnwh2z3szl2svbx0aiazlhljc-nixos-system-server-test.drv' building '/nix/store/q0bs4xr53xdsj1ic4cv268bx7a7ga266-closure-info.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/q0bs4xr53xdsj1ic4cv268bx7a7ga266-closure-info.drv' closure-info> structuredAttrs is enabled building '/nix/store/cpdxw1q2whxkd48w48hkvq5p6afwvsfa-run-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/cpdxw1q2whxkd48w48hkvq5p6afwvsfa-run-nixos-vm.drv' building '/nix/store/y469kszvwah55v57dq3xng4gsxr70k1v-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/y469kszvwah55v57dq3xng4gsxr70k1v-nixos-vm.drv' building '/nix/store/a28a6mhwxfpsyq43l3h9qygl6ywm6ijc-nixos-test-driver-plv8.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/a28a6mhwxfpsyq43l3h9qygl6ywm6ijc-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/g2smnvla7wxqy5837dm6m8ilbpvw7cg4-vm-test-run-plv8.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/g2smnvla7wxqy5837dm6m8ilbpvw7cg4-vm-test-run-plv8.drv' vm-test-run-plv8> Machine state will be reset. To keep it, pass --keep-vm-state vm-test-run-plv8> start all VLans vm-test-run-plv8> start vlan vm-test-run-plv8> running vlan (pid 7; ctl /build/vde1.ctl) vm-test-run-plv8> (finished: start all VLans, in 0.00 seconds) vm-test-run-plv8> Test will time out and terminate in 3600 seconds vm-test-run-plv8> run the VM test script vm-test-run-plv8> additionally exposed symbols: vm-test-run-plv8> server, vm-test-run-plv8> vlan1, vm-test-run-plv8> start_all, test_script, machines, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, Machine, t, debug vm-test-run-plv8> start all VMs vm-test-run-plv8> server: starting vm vm-test-run-plv8> mke2fs 1.47.3 (8-Jul-2025) vm-test-run-plv8> qemu-system-aarch64: Could not access KVM kernel module: No such file or directory vm-test-run-plv8> qemu-system-aarch64: failed to initialize kvm: No such file or directory vm-test-run-plv8> qemu-system-aarch64: falling back to tcg vm-test-run-plv8> server: QEMU running (pid 9) vm-test-run-plv8> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-plv8> server # Formatting '/build/vm-state-server/tmp.MVLA8vse1u', 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> (finished: start all VMs, in 0.14 seconds) vm-test-run-plv8> server: waiting for unit supabase-db-init.service vm-test-run-plv8> server # Filesystem UUID: 352f2c98-d03a-40e2-ad8c-868bf68fcf56 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: waiting for the VM to finish booting vm-test-run-plv8> server # Creating journal (8192 blocks): done vm-test-run-plv8> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-plv8> server # vm-test-run-plv8> server # Virtualisation disk image created. vm-test-run-plv8> server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510] vm-test-run-plv8> server # [ 0.000000] Linux version 6.12.63 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP Thu Dec 18 12:55:23 UTC 2025 vm-test-run-plv8> server # [ 0.000000] KASLR enabled vm-test-run-plv8> server # [ 0.000000] random: crng init done vm-test-run-plv8> server # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-plv8> server # [ 0.000000] efi: UEFI not found. vm-test-run-plv8> server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-plv8> server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f602200-0x13f60593f] vm-test-run-plv8> server # [ 0.000000] Zone ranges: vm-test-run-plv8> server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] vm-test-run-plv8> server # [ 0.000000] DMA32 empty vm-test-run-plv8> server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] Device empty vm-test-run-plv8> server # [ 0.000000] Movable zone start for each node vm-test-run-plv8> server # [ 0.000000] Early memory node ranges vm-test-run-plv8> server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -1 vm-test-run-plv8> server # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-plv8> server # [ 0.000000] psci: PSCIv1.1 detected in firmware. vm-test-run-plv8> server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-plv8> server # [ 0.000000] psci: Trusted OS migration not required vm-test-run-plv8> server # [ 0.000000] psci: SMC Calling Convention v1.0 vm-test-run-plv8> server # [ 0.000000] percpu: Embedded 88 pages/cpu s180056 r65536 d114856 u360448 vm-test-run-plv8> server # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-plv8> server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm) vm-test-run-plv8> server # [ 0.000000] CPU features: detected: GIC system register CPU interface vm-test-run-plv8> server # [ 0.000000] CPU features: detected: HCRX_EL2 register vm-test-run-plv8> server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2) vm-test-run-plv8> server # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-plv8> server # [ 0.000000] alternatives: applying boot alternatives vm-test-run-plv8> server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/4hhhikl5w9bb497mkia2vbj3g9lcc33m-nixos-system-server-test/init regInfo=/nix/store/1jghm03db8fqfhgqiwpxb61fwi4wjspa-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-plv8> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/1jghm03db8fqfhgqiwpxb61fwi4wjspa-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 @100af0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-plv8> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b00000 (flat, esz 8, psz 64K, shr 1) vm-test-run-plv8> server # [ 0.000000] GICv3: using LPI property table @0x0000000100b10000 vm-test-run-plv8> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b20000 vm-test-run-plv8> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-plv8> server # [ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (virt). vm-test-run-plv8> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-plv8> server # [ 0.000026] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-plv8> server # [ 0.002340] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-plv8> server # [ 0.008003] Console: colour dummy device 80x25 vm-test-run-plv8> server # [ 0.009023] printk: legacy console [tty0] enabled vm-test-run-plv8> server # [ 0.013046] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-plv8> server # [ 0.013327] pid_max: default: 32768 minimum: 301 vm-test-run-plv8> server # [ 0.014703] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-plv8> server # [ 0.015777] landlock: Up and running. vm-test-run-plv8> server # [ 0.015806] Yama: becoming mindful. vm-test-run-plv8> server # [ 0.019689] LSM support for eBPF active vm-test-run-plv8> server # [ 0.021924] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.022037] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.043273] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-plv8> server # [ 0.050929] rcu: Hierarchical SRCU implementation. vm-test-run-plv8> server # [ 0.050976] rcu: Max phase no-delay instances is 1000. vm-test-run-plv8> server # [ 0.051988] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-plv8> server # [ 0.056590] fsl-mc MSI: its@8080000 domain created vm-test-run-plv8> server # [ 0.058018] EFI services will not be available. vm-test-run-plv8> server # [ 0.059085] smp: Bringing up secondary CPUs ... vm-test-run-plv8> server # [ 0.062360] Detected PIPT I-cache on CPU1 vm-test-run-plv8> server # [ 0.063230] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-plv8> server # [ 0.063708] GICv3: CPU1: using allocated LPI pending table @0x0000000100b30000 vm-test-run-plv8> server # [ 0.064877] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-plv8> server # [ 0.067318] smp: Brought up 1 node, 2 CPUs vm-test-run-plv8> server # [ 0.067421] SMP: Total of 2 processors activated. vm-test-run-plv8> server # [ 0.067450] CPU: All CPU(s) started at EL1 vm-test-run-plv8> server # [ 0.067574] CPU features: detected: Branch Target Identification vm-test-run-plv8> server # [ 0.067610] CPU features: detected: 32-bit EL0 Support vm-test-run-plv8> server # [ 0.067630] CPU features: detected: 32-bit EL1 Support vm-test-run-plv8> server # [ 0.067647] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-plv8> server # [ 0.067670] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-plv8> server # [ 0.067697] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-plv8> server # [ 0.067740] CPU features: detected: Common not Private translations vm-test-run-plv8> server # [ 0.067758] CPU features: detected: CRC32 instructions vm-test-run-plv8> server # [ 0.067774] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-plv8> server # [ 0.067794] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-plv8> server # [ 0.067812] CPU features: detected: Data independent timing control (DIT) vm-test-run-plv8> server # [ 0.067829] CPU features: detected: E0PD vm-test-run-plv8> server # [ 0.067843] CPU features: detected: Enhanced Counter Virtualization vm-test-run-plv8> server # [ 0.067860] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-plv8> server # [ 0.067878] CPU features: detected: Enhanced Privileged Access Never vm-test-run-plv8> server # [ 0.067895] CPU features: detected: Enhanced Virtualization Traps vm-test-run-plv8> server # [ 0.067912] CPU features: detected: Fine Grained Traps vm-test-run-plv8> server # [ 0.067951] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-plv8> server # [ 0.068009] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-plv8> server # [ 0.068041] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-plv8> server # [ 0.068060] CPU features: detected: LSE atomic instructions vm-test-run-plv8> server # [ 0.068076] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-plv8> server # [ 0.068094] CPU features: detected: Privileged Access Never vm-test-run-plv8> server # [ 0.068110] CPU features: detected: RAS Extension Support vm-test-run-plv8> server # [ 0.068126] CPU features: detected: Random Number Generator vm-test-run-plv8> server # [ 0.068142] CPU features: detected: Speculation barrier (SB) vm-test-run-plv8> server # [ 0.068158] CPU features: detected: Stage-2 Force Write-Back vm-test-run-plv8> server # [ 0.068175] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-plv8> server # [ 0.068197] CPU features: detected: TLB range maintenance instructions vm-test-run-plv8> server # [ 0.068216] CPU features: detected: WFx with timeout vm-test-run-plv8> server # [ 0.068247] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-plv8> server # [ 0.068265] CPU features: detected: Scalable Vector Extension vm-test-run-plv8> server # [ 0.071698] alternatives: applying system-wide alternatives vm-test-run-plv8> server # [ 0.082391] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-plv8> server # [ 0.082851] SVE: maximum available vector length 256 bytes per vector vm-test-run-plv8> server # [ 0.082913] SVE: default vector length 64 bytes per vector vm-test-run-plv8> server # [ 0.091263] Memory: 3922820K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-plv8> server # [ 0.108388] devtmpfs: initialized vm-test-run-plv8> server # [ 0.127131] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-plv8> server # [ 0.127499] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.129362] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-plv8> server # [ 0.129419] 0 pages in range for non-PLT usage vm-test-run-plv8> server # [ 0.129449] 509248 pages in range for PLT usage vm-test-run-plv8> server # [ 0.131484] pinctrl core: initialized pinctrl subsystem vm-test-run-plv8> server # [ 0.138690] DMI not present or invalid. vm-test-run-plv8> server # [ 0.151070] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-plv8> server # [ 0.159528] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-plv8> server # [ 0.160135] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-plv8> server # [ 0.160842] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-plv8> server # [ 0.161020] audit: initializing netlink subsys (disabled) vm-test-run-plv8> server # [ 0.162290] audit: type=2000 audit(0.028:1): state=initialized audit_enabled=0 res=1 vm-test-run-plv8> server # [ 0.166288] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-plv8> server # [ 0.166317] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-plv8> server # [ 0.166348] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-plv8> server # [ 0.166368] thermal_sys: Registered thermal governor 'user_space' vm-test-run-plv8> server # [ 0.166386] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-plv8> server # [ 0.166747] cpuidle: using governor ladder vm-test-run-plv8> server # [ 0.166927] cpuidle: using governor menu vm-test-run-plv8> server # [ 0.168240] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-plv8> server # [ 0.168617] ASID allocator initialised with 65536 entries vm-test-run-plv8> server # [ 0.173673] Serial: AMBA PL011 UART driver vm-test-run-plv8> server # [ 0.206065] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-plv8> server # [ 0.206825] printk: legacy console [ttyAMA0] enabled vm-test-run-plv8> server # [ 0.232256] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.232403] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-plv8> server # [ 0.232552] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.232653] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-plv8> server # [ 0.232736] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.232821] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-plv8> server # [ 0.232901] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.232999] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-plv8> server # [ 0.241697] fbcon: Taking over console vm-test-run-plv8> server # [ 0.242231] ACPI: Interpreter disabled. vm-test-run-plv8> server # [ 0.247779] iommu: Default domain type: Translated vm-test-run-plv8> server # [ 0.247898] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-plv8> server # [ 0.249835] SCSI subsystem initialized vm-test-run-plv8> server # [ 0.251477] usbcore: registered new interface driver usbfs vm-test-run-plv8> server # [ 0.251780] usbcore: registered new interface driver hub vm-test-run-plv8> server # [ 0.252284] usbcore: registered new device driver usb vm-test-run-plv8> server # [ 0.254202] pps_core: LinuxPPS API ver. 1 registered vm-test-run-plv8> server # [ 0.254308] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-plv8> server # [ 0.254537] PTP clock support registered vm-test-run-plv8> server # [ 0.254926] EDAC MC: Ver: 3.0.0 vm-test-run-plv8> server # [ 0.256136] scmi_core: SCMI protocol bus registered vm-test-run-plv8> server # [ 0.258323] FPGA manager framework vm-test-run-plv8> server # [ 0.259242] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-plv8> server # [ 0.265564] vgaarb: loaded vm-test-run-plv8> server # [ 0.269268] clocksource: Switched to clocksource arch_sys_counter vm-test-run-plv8> server # [ 0.271296] VFS: Disk quotas dquot_6.6.0 vm-test-run-plv8> server # [ 0.271467] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-plv8> server # [ 0.274750] netfs: FS-Cache loaded vm-test-run-plv8> server # [ 0.275993] pnp: PnP ACPI: disabled vm-test-run-plv8> server # [ 0.292013] NET: Registered PF_INET protocol family vm-test-run-plv8> server # [ 0.293285] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-plv8> server # [ 0.374511] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.374858] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.375118] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.376523] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-plv8> server # [ 0.377162] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-plv8> server # [ 0.378360] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-plv8> server # [ 0.378782] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.379322] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.380535] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-plv8> server # [ 0.380976] NET: Registered PF_XDP protocol family vm-test-run-plv8> server # [ 0.381195] PCI: CLS 0 bytes, default 64 vm-test-run-plv8> server # [ 0.383784] Trying to unpack rootfs image as initramfs... vm-test-run-plv8> server # [ 0.393951] kvm [1]: HYP mode not available vm-test-run-plv8> server # [ 0.468390] Initialise system trusted keyrings vm-test-run-plv8> server # [ 0.469914] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-plv8> server # [ 0.472549] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-plv8> server # [ 0.473030] 9p: Installing v9fs 9p2000 file system support vm-test-run-plv8> server # [ 0.515335] Key type asymmetric registered vm-test-run-plv8> server # [ 0.515521] Asymmetric key parser 'x509' registered vm-test-run-plv8> server # [ 0.515960] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-plv8> server # [ 0.516906] io scheduler mq-deadline registered vm-test-run-plv8> server # [ 0.517058] io scheduler kyber registered vm-test-run-plv8> server # [ 0.534435] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-plv8> server # [ 0.537534] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-plv8> server # [ 0.540146] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-plv8> server # [ 0.540674] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-plv8> server # [ 0.541362] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-plv8> server # [ 0.541583] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-plv8> server # [ 0.542230] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-plv8> server # [ 0.542704] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-plv8> server # [ 0.543862] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-plv8> server # [ 0.544237] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-plv8> server # [ 0.544474] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.544803] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.544930] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.546153] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.548445] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.548781] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.548961] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.549122] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.549295] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.550273] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.550547] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.550681] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.550790] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.551314] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.551611] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.551721] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.552056] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.552530] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.552849] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.552935] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.553033] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.553638] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.553936] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.554050] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.554402] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.554811] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.555007] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-plv8> server # [ 0.555137] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.555504] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.556131] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.556436] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.556553] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.556869] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.557018] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.557600] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.557896] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.558012] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.558465] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.558658] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.558820] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.559354] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-plv8> server # [ 0.559609] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.560087] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.560401] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.560510] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.560610] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.561045] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.561624] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.561726] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.561933] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.563523] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-plv8> server # [ 0.563757] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-plv8> server # [ 0.563988] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.564208] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.564358] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.564513] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.564622] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.564767] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.564935] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.565068] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.565234] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.565349] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.565929] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.566143] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-plv8> server # [ 0.566302] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-plv8> server # [ 0.566408] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-plv8> server # [ 0.566643] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-plv8> server # [ 0.566749] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-plv8> server # [ 0.566846] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-plv8> server # [ 0.566987] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-plv8> server # [ 0.567102] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-plv8> server # [ 0.567352] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-plv8> server # [ 0.567561] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-plv8> server # [ 0.567656] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-plv8> server # [ 0.567793] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-plv8> server # [ 0.567894] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-plv8> server # [ 0.568005] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-plv8> server # [ 0.568272] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-plv8> server # [ 0.568363] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-plv8> server # [ 0.568459] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-plv8> server # [ 0.568540] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-plv8> server # [ 0.568625] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-plv8> server # [ 0.568758] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-plv8> server # [ 0.569001] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-plv8> server # [ 0.569370] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.569926] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.570078] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.570853] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.612966] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.615440] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.616668] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.618390] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.619655] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.620695] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.621951] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.623060] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.624117] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.625591] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.627299] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.637819] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-plv8> server # [ 0.644340] msm_serial: driver initialized vm-test-run-plv8> server # [ 0.645246] SuperH (H)SCI(F) driver initialized vm-test-run-plv8> server # [ 0.645623] STM32 USART driver initialized vm-test-run-plv8> server # [ 0.670610] Freeing initrd memory: 10684K vm-test-run-plv8> server # [ 0.683748] loop: module loaded vm-test-run-plv8> server # [ 0.684348] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-plv8> server # [ 0.686943] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-plv8> server # [ 0.695266] megasas: 07.727.03.00-rc1 vm-test-run-plv8> server # [ 0.698632] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-plv8> server # [ 0.700650] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 0.701193] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 0.702468] Using buffer write method vm-test-run-plv8> server # [ 0.702951] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-plv8> server # [ 0.704362] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 0.704576] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 0.705748] Using buffer write method vm-test-run-plv8> server # [ 0.705923] Concatenating MTD devices: vm-test-run-plv8> server # [ 0.706182] (0): "0.flash" vm-test-run-plv8> server # [ 0.706258] (1): "0.flash" vm-test-run-plv8> server # [ 0.706338] into device "0.flash" vm-test-run-plv8> server # [ 0.720686] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-plv8> server # [ 0.728066] thunder_xcv, ver 1.0 vm-test-run-plv8> server # [ 0.728270] thunder_bgx, ver 1.0 vm-test-run-plv8> server # [ 0.728572] nicpf, ver 1.0 vm-test-run-plv8> server # [ 0.730577] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-plv8> server # [ 0.730740] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-plv8> server # [ 0.731081] hclge is initializing vm-test-run-plv8> server # [ 0.731331] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 0.731556] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-plv8> server # [ 0.731771] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 0.731839] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-plv8> server # [ 0.732028] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-plv8> server # [ 0.732099] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-plv8> server # [ 0.732257] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-plv8> server # [ 0.732344] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-plv8> server # [ 0.732938] sky2: driver version 1.30 vm-test-run-plv8> server # [ 0.737968] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-plv8> server # [ 0.738373] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-plv8> server # [ 0.739318] usbcore: registered new interface driver usb-storage vm-test-run-plv8> server # [ 0.740034] usbcore: registered new interface driver usbserial_generic vm-test-run-plv8> server # [ 0.740323] usbserial: USB Serial support registered for generic vm-test-run-plv8> server # [ 0.740961] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-plv8> server # [ 0.746387] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-plv8> server # [ 0.747293] rtc-pl031 9010000.pl031: setting system clock to 2026-10-22T21:21:44 UTC (1792704104) vm-test-run-plv8> server # [ 0.748703] i2c_dev: i2c /dev entries driver vm-test-run-plv8> server # [ 0.756176] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-plv8> server # [ 0.757866] sdhci: Secure Digital Host Controller Interface driver vm-test-run-plv8> server # [ 0.757988] sdhci: Copyright(c) Pierre Ossman vm-test-run-plv8> server # [ 0.759412] Synopsys Designware Multimedia Card Interface Driver vm-test-run-plv8> server # [ 0.760847] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-plv8> server # [ 0.761770] hub 1-0:1.0: USB hub found vm-test-run-plv8> server # [ 0.762221] hub 1-0:1.0: 6 ports detected vm-test-run-plv8> server # [ 0.765466] hid: raw HID events driver (C) Jiri Kosina vm-test-run-plv8> server # [ 0.766889] usbcore: registered new interface driver usbhid vm-test-run-plv8> server # [ 0.766998] usbhid: USB HID core driver vm-test-run-plv8> server # [ 0.771999] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-plv8> server # [ 0.780012] drop_monitor: Initializing network drop monitor service vm-test-run-plv8> server # [ 0.781198] NET: Registered PF_INET6 protocol family vm-test-run-plv8> server # [ 0.789484] Segment Routing with IPv6 vm-test-run-plv8> server # [ 0.790076] In-situ OAM (IOAM) with IPv6 vm-test-run-plv8> server # [ 0.790634] NET: Registered PF_PACKET protocol family vm-test-run-plv8> server # [ 0.791451] 9pnet: Installing 9P2000 support vm-test-run-plv8> server # [ 0.794264] Key type dns_resolver registered vm-test-run-plv8> server # [ 0.817333] registered taskstats version 1 vm-test-run-plv8> server # [ 0.818998] Loading compiled-in X.509 certificates vm-test-run-plv8> server # [ 0.856882] Demotion targets for Node 0: null vm-test-run-plv8> server # [ 0.858246] Key type .fscrypt registered vm-test-run-plv8> server # [ 0.858366] Key type fscrypt-provisioning registered vm-test-run-plv8> server # [ 0.863993] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-plv8> server # [ 0.892950] clk: Disabling unused clocks vm-test-run-plv8> server # [ 0.893193] PM: genpd: Disabling unused power domains vm-test-run-plv8> server # [ 0.893856] ALSA device list: vm-test-run-plv8> server # [ 0.894000] No soundcards found. vm-test-run-plv8> server # [ 0.947551] Freeing unused kernel memory: 4416K vm-test-run-plv8> server # [ 0.948688] Run /init as init process vm-test-run-plv8> server # [ 1.041548] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-plv8> server # [ 1.231572] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-plv8> server # [ 1.291567] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-plv8> server # [ 1.292617] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-plv8> server # [ 1.292634] [drm] features: -context_init vm-test-run-plv8> server # [ 1.294350] [drm] number of scanouts: 1 vm-test-run-plv8> server # [ 1.294555] [drm] number of cap sets: 0 vm-test-run-plv8> server # [ 1.300813] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-plv8> server # [ 1.305013] 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.324512] Console: switching to colour frame buffer device 160x50 vm-test-run-plv8> server # [ 1.331744] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-plv8> server # [ 1.556699] 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.691767] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-plv8> server # [ 1.928505] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 vm-test-run-plv8> server # [ 1.931864] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 vm-test-run-plv8> server # [ 3.153933] EXT4-fs (vda): mounted filesystem 352f2c98-d03a-40e2-ad8c-868bf68fcf56 r/w with ordered data mode. Quota mode: none. vm-test-run-plv8> server # [ 5.306434] EXT4-fs (vda): re-mounted 352f2c98-d03a-40e2-ad8c-868bf68fcf56. vm-test-run-plv8> server # [ 5.330190] booting system configuration /nix/store/4hhhikl5w9bb497mkia2vbj3g9lcc33m-nixos-system-server-test vm-test-run-plv8> server # [ 15.681029] systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN -IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) vm-test-run-plv8> server # [ 15.691225] systemd[1]: Detected virtualization qemu. vm-test-run-plv8> server # [ 15.695821] systemd[1]: Detected architecture arm64. vm-test-run-plv8> server # [ 15.700900] systemd[1]: Detected first boot. vm-test-run-plv8> server # [ 15.725056] systemd[1]: Initializing machine ID from random generator. vm-test-run-plv8> server # [ 15.751899] systemd[1]: Hostname set to . vm-test-run-plv8> server # [ 16.841415] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-plv8> server # [ 17.960201] systemd[1]: Applying preset policy. vm-test-run-plv8> server # [ 20.657938] systemd[1]: Populated /etc with preset unit settings. vm-test-run-plv8> server # [ 23.559035] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-plv8> server # [ 23.735940] systemd[1]: Created slice Slice /system/getty. vm-test-run-plv8> server # [ 23.749976] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-plv8> server # [ 23.761325] systemd[1]: Created slice User and Session Slice. vm-test-run-plv8> server # [ 23.768863] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-plv8> server # [ 23.774326] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-plv8> server # [ 23.778959] systemd[1]: Expecting device /dev/hvc0... vm-test-run-plv8> server # [ 23.783372] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-plv8> server # [ 23.787921] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-plv8> server # [ 23.792171] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-plv8> server # [ 23.796273] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-plv8> server # [ 23.800432] systemd[1]: Reached target Path Units. vm-test-run-plv8> server # [ 23.804600] systemd[1]: Reached target Remote File Systems. vm-test-run-plv8> server # [ 23.808510] systemd[1]: Reached target Slice Units. vm-test-run-plv8> server # [ 23.812900] systemd[1]: Reached target Swaps. vm-test-run-plv8> server # [ 23.843372] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-plv8> server # [ 23.863043] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-plv8> server # [ 23.871973] systemd[1]: Listening on Journal Audit Socket. vm-test-run-plv8> server # [ 23.878575] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-plv8> server # [ 23.883511] systemd[1]: Listening on Journal Sockets. vm-test-run-plv8> server # [ 23.890786] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-plv8> server # [ 23.894982] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 23.900388] systemd[1]: Listening on udev Control Socket. vm-test-run-plv8> server # [ 23.905269] systemd[1]: Listening on udev Kernel Socket. vm-test-run-plv8> server # [ 23.946419] systemd[1]: Mounting Huge Pages File System... vm-test-run-plv8> server # [ 23.975795] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-plv8> server # [ 24.015711] systemd[1]: Mounting Kernel Debug File System... vm-test-run-plv8> server # [ 24.055918] systemd[1]: Mounting Kernel Trace File System... vm-test-run-plv8> server # [ 24.177085] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-plv8> server # [ 24.255123] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-plv8> server # [ 24.260645] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-plv8> server # [ 24.308780] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-plv8> server # [ 24.331556] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-plv8> server # [ 24.363862] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-plv8> server # [ 24.488252] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-plv8> server # [ 24.506269] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-plv8> server # [ 24.518657] systemd[1]: Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). vm-test-run-plv8> server # [ 24.621105] systemd[1]: Starting Journal Service... vm-test-run-plv8> server # [ 24.684808] systemd[1]: Starting Load Kernel Modules... vm-test-run-plv8> server # [ 24.732572] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-plv8> server # [ 24.779532] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-plv8> server # [ 24.786389] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 24.837019] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-plv8> server # [ 24.905879] systemd[1]: Mounted Huge Pages File System. vm-test-run-plv8> server # [ 24.913089] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-plv8> server # [ 24.925072] systemd[1]: Mounted Kernel Debug File System. vm-test-run-plv8> server # [ 24.934867] systemd[1]: Mounted Kernel Trace File System. vm-test-run-plv8> server # [ 24.955940] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-plv8> server # [ 24.970127] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-plv8> server # [ 25.027206] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-plv8> server # [ 25.333377] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-plv8> server # [ 25.352061] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-plv8> server # [ 25.698802] systemd[1]: Finished Load Kernel Modules. vm-test-run-plv8> server # [ 25.758688] systemd[1]: Starting Firewall... vm-test-run-plv8> server # [ 25.759634] fuse: init (API version 7.41) vm-test-run-plv8> server # [ 25.793359] EXT4-fs (vda): re-mounted 352f2c98-d03a-40e2-ad8c-868bf68fcf56. vm-test-run-plv8> server # [ 25.808960] systemd[1]: Starting Apply Kernel Variables... vm-test-run-plv8> server # [ 25.892396] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-plv8> server # [ 25.904769] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-plv8> server # [ 25.956136] systemd[1]: Mounting FUSE Control File System... vm-test-run-plv8> server # [ 25.975931] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-plv8> server # [ 25.990629] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-plv8> server # [ 26.061704] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-plv8> server # [ 26.066473] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 26.110761] systemd-journald[397]: Collecting audit messages is enabled. vm-test-run-plv8> server # [ 26.194985] systemd[1]: Mounted FUSE Control File System. vm-test-run-plv8> server # [ 26.919402] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-plv8> server # [ 26.926318] systemd[1]: Reached target First Boot Complete. vm-test-run-plv8> server # [ 27.063124] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-plv8> server # [ 27.128794] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-plv8> server # [ 27.163201] systemd[1]: Finished Apply Kernel Variables. vm-test-run-plv8> server # [ 27.381217] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-plv8> server # [ 27.999273] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-plv8> server # [ 28.025289] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-plv8> server # [ 28.059885] systemd[1]: Mounting /run/wrappers... vm-test-run-plv8> server # [ 28.108092] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-plv8> server # [ 28.429133] systemd[1]: Started Journal Service. vm-test-run-plv8> server # [ 28.269081] systemd-modules-load[398]: Module 'atkbd' is built in vm-test-run-plv8> server # [ 28.289199] systemd-modules-load[398]: Module 'loop' is built in vm-test-run-plv8> server # [ 28.306970] systemd-oomd[399]: No swap; memory pressure usage will be degraded vm-test-run-plv8> server # [ 28.347135] systemd[1]: Mounted /run/wrappers. vm-test-run-plv8> server # [ 28.386862] systemd[1]: Reached target Local File Systems. vm-test-run-plv8> server # [ 28.394653] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-plv8> server # [ 28.420377] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-plv8> server # [ 28.467969] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-plv8> server # [ 28.483788] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-plv8> server # [ 28.555698] systemd[1]: Starting Save Transient machine-id to Disk... 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.481273] systemd-journald[397]: Received client request to flush runtime journal. vm-test-run-plv8> server # [ 29.979476] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-plv8> server # [ 30.010524] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-plv8> server # [ 30.060903] systemd-udevd[426]: Using default interface naming scheme 'v258'. vm-test-run-plv8> server # [ 30.071546] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-plv8> server # [ 30.096659] systemd[1]: Starting Create System Files and Directories... vm-test-run-plv8> server # [ 32.207955] systemd[1]: Finished Create System Files and Directories. vm-test-run-plv8> server # [ 32.349208] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-plv8> server # [ 32.441991] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-plv8> server # [ 32.486691] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-plv8> server # [ 33.697426] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-plv8> server # [ 34.497741] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-plv8> server # [ 34.547998] systemd[1]: Starting Update is Completed... vm-test-run-plv8> server # [ 35.494639] systemd[1]: Finished Update is Completed. vm-test-run-plv8> server # [ 39.611289] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-plv8> server # [ 39.619917] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-plv8> server # [ 39.628559] systemd[1]: suid-sgid-wrappers.service: Consumed 2.972s CPU time, 5.5M memory peak. vm-test-run-plv8> server # [ 42.423212] systemd[1]: Finished Firewall. vm-test-run-plv8> server # [ 43.814835] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-plv8> server # [ 43.830595] systemd[1]: Reached target System Initialization. vm-test-run-plv8> server # [ 43.838001] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-plv8> server # [ 43.846709] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-plv8> server # [ 43.862125] systemd[1]: Reached target Timer Units. vm-test-run-plv8> server # [ 43.869607] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-plv8> server # [ 43.871712] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-plv8> server # [ 43.879113] systemd[1]: Listening on Hostname Service Socket. vm-test-run-plv8> server # [ 43.881241] systemd[1]: Reached target Socket Units. vm-test-run-plv8> server # [ 43.885145] systemd[1]: Reached target Basic System. vm-test-run-plv8> server # [ 43.893193] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-plv8> server # [ 43.930901] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 43.971345] systemd[1]: Started Reset console on configuration changes. vm-test-run-plv8> server # [ 44.031530] systemd[1]: Starting resolvconf update... vm-test-run-plv8> server # [ 44.093568] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-plv8> server # [ 45.280614] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-plv8> server # [ 45.518153] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 45.523150] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 45.538718] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 45.587317] nsncd[631]: Oct 22 21:22:29.428 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 45.611151] systemd[1]: Starting User Login Management... vm-test-run-plv8> server # [ 45.867529] dbus-daemon[634]: dbus[634]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-plv8> server # [ 46.331050] systemd[1]: Started D-Bus System Message Bus. vm-test-run-plv8> server # [ 47.061463] systemd-logind[647]: New seat seat0. vm-test-run-plv8> server # [ 47.727822] systemd[1]: Started User Login Management. vm-test-run-plv8> server # [ 47.771238] systemd[1]: Starting linger-users.service... vm-test-run-plv8> server # [ 47.788573] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-plv8> server # [ 47.806802] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-plv8> server # [ 47.823152] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-plv8> server # [ 47.842935] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-plv8> server # [ 47.846210] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 47.853099] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-plv8> server # [ 47.858455] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 47.865271] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 47.882855] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-plv8> server # [ 47.891744] systemd[1]: Finished linger-users.service. vm-test-run-plv8> server # [ 48.463699] nsncd[693]: Oct 22 21:22:32.391 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 48.469922] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 48.471083] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 48.473322] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 49.007600] systemd[1]: Finished resolvconf update. vm-test-run-plv8> server # [ 49.025697] systemd[1]: Reached target Preparation for Network. vm-test-run-plv8> server # [ 49.085756] systemd[1]: Starting DHCP Client... vm-test-run-plv8> server # [ 50.602794] dhcpcd[743]: dhcpcd-10.2.4 starting vm-test-run-plv8> server # [ 50.785001] dhcpcd[762]: dev: loaded udev vm-test-run-plv8> server # [ 51.350409] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-plv8> server # [ 51.775880] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-plv8> server # [ 52.053121] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-plv8> server # [ 52.062273] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-plv8> server # [ 52.096091] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-plv8> server # [ 52.102259] cfg80211: failed to load regulatory.db vm-test-run-plv8> server # [ 52.396111] systemd[1]: Found device /dev/hvc0. vm-test-run-plv8> server # [ 52.963614] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-plv8> server # [ 52.787979] dhcpcd[762]: eth0: waiting for carrier vm-test-run-plv8> server # [ 52.829508] dhcpcd[762]: eth0: carrier acquired vm-test-run-plv8> server # [ 52.937580] dhcpcd[762]: DUID 00:01:00:01:32:6d:3b:1c:52:54:00:12:34:56 vm-test-run-plv8> server # [ 52.939193] dhcpcd[762]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 52.944810] dhcpcd[762]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-plv8> server # [ 54.231649] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-plv8> server # [ 54.272190] systemd[1]: Started backdoor.service. vm-test-run-plv8> server # [ 54.659378] dhcpcd[762]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 54.683165] (udev-worker)[784]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 54.712376] (udev-worker)[785]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-plv8> server # [ 54.716831] dhcpcd[762]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 54.722293] (udev-worker)[785]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 54.731530] dhcpcd[762]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # connecting to host... vm-test-run-plv8> server: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-plv8> server: connected to guest root shell vm-test-run-plv8> server: (connecting took 56.05 seconds) vm-test-run-plv8> server: (finished: waiting for the VM to finish booting, in 56.05 seconds) vm-test-run-plv8> server # [ 55.085438] dhcpcd[762]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 55.107998] dhcpcd[762]: eth0: Router Advertisement from fe80::2 vm-test-run-plv8> server # [ 55.109238] dhcpcd[762]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-plv8> server # [ 55.122973] dhcpcd[762]: eth0: adding route to fec0::/64 vm-test-run-plv8> server # [ 55.129445] dhcpcd[762]: eth0: adding default route via fe80::2 vm-test-run-plv8> server # [ 56.063176] dhcpcd[762]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 56.167206] systemd[1]: Found device Virtio network device. vm-test-run-plv8> server # [ 56.277581] systemd[1]: Starting Address configuration of eth1... vm-test-run-plv8> server # [ 57.380695] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-plv8> server # [ 57.451839] network-addresses-eth1-start[815]: adding address 192.168.1.1/24... done vm-test-run-plv8> server # [ 57.587613] dhcpcd[762]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 57.658226] network-addresses-eth1-start[815]: adding address 2001:db8:1::1/64... done vm-test-run-plv8> server # [ 57.988713] systemd[1]: Finished Address configuration of eth1. vm-test-run-plv8> server # [ 58.054794] systemd[1]: Starting Networking Setup... vm-test-run-plv8> server # [ 58.553948] dhcpcd[762]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 58.555941] dhcpcd[762]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 58.570045] dhcpcd[762]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 60.562505] dhcpcd[762]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-plv8> server # [ 60.564945] dhcpcd[762]: eth0: adding route to 10.0.2.0/24 vm-test-run-plv8> server # [ 60.566427] dhcpcd[762]: eth0: adding default route via 10.0.2.2 vm-test-run-plv8> server # [ 60.885269] systemd[1]: Finished Networking Setup. vm-test-run-plv8> server # [ 60.901569] systemd[1]: Reached target Network. vm-test-run-plv8> server # [ 60.941683] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-plv8> server # [ 60.996036] systemd[1]: Starting Permit User Sessions... vm-test-run-plv8> server # [ 61.762731] systemd[1]: Finished Permit User Sessions. vm-test-run-plv8> server # [ 61.862570] systemd[1]: Started Getty on tty1. vm-test-run-plv8> server # [ 61.875595] systemd[1]: Reached target Login Prompts. vm-test-run-plv8> server # [ 62.989192] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[939]: Initializing database at /var/lib/postgresql/data vm-test-run-plv8> server # [ 64.613940] systemd[1]: Started DHCP Client. vm-test-run-plv8> server # [ 65.227880] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: The files belonging to this database system will be owned by user "postgres". vm-test-run-plv8> server # [ 65.229697] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: This user must also own the server process. vm-test-run-plv8> server # [ 65.329222] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-plv8> server # [ 65.330460] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: The default database encoding has accordingly been set to "UTF8". vm-test-run-plv8> server # [ 65.332018] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: The default text search configuration will be set to "english". vm-test-run-plv8> server # [ 65.337037] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: Data page checksums are enabled. vm-test-run-plv8> server # [ 65.338224] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-plv8> server # [ 65.350216] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: creating subdirectories ... ok vm-test-run-plv8> server # [ 65.361253] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: selecting dynamic shared memory implementation ... posix vm-test-run-plv8> server # [ 66.622333] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: selecting default max_connections ... 100 vm-test-run-plv8> server # [ 67.604684] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: selecting default shared_buffers ... 128MB vm-test-run-plv8> server # [ 68.321587] systemd-logind[647]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-plv8> server # [ 78.200682] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: selecting default time zone ... UTC vm-test-run-plv8> server # [ 78.239630] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: creating configuration files ... ok vm-test-run-plv8> server # [ 80.378049] mousedev: PS/2 mouse device common for all mice vm-test-run-plv8> server # [ 81.126681] systemd-logind[647]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-plv8> server # [ 82.627903] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: running bootstrap script ... ok vm-test-run-plv8> server # [ 94.700024] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: performing post-bootstrap initialization ... ok vm-test-run-plv8> server # [ 97.949703] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: syncing data to disk ... ok vm-test-run-plv8> server # [ 97.967782] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-plv8> server # [ 97.975034] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: 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.998680] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: Success. You can now start the database server using: vm-test-run-plv8> server # [ 98.006820] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[964]: /nix/store/i45yhjwwac2d5ygyv0s5gbg2cgdjclf9-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-plv8> server # [ 99.964651] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[939]: Validating PostgreSQL configuration... vm-test-run-plv8> server # [ 100.541760] hc3ypq1zkd92a66rf3394zwff56vmm5m-postgresql-init[1357]: 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 # [ 101.925891] postgres[1359]: 2026-10-22 21:23:25.863 UTC [1359] LOG: pgaudit extension initialized vm-test-run-plv8> server # [ 102.837282] postgres[1359]: 2026-10-22 21:23:26.780 UTC [1359] LOG: pgsodium primary server secret key loaded vm-test-run-plv8> server # [ 103.372092] postgres[1359]: 2026-10-22 21:23:27.311 UTC [1359] LOG: vault primary server secret key loaded vm-test-run-plv8> server # [ 103.848728] postgres[1359]: 2026-10-22 21:23:27.794 UTC [1359] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-plv8> server # [ 103.865144] postgres[1359]: 2026-10-22 21:23:27.810 UTC [1359] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-plv8> server # [ 103.871588] postgres[1359]: 2026-10-22 21:23:27.814 UTC [1359] LOG: listening on IPv6 address "::", port 5432 vm-test-run-plv8> server # [ 103.891438] postgres[1359]: 2026-10-22 21:23:27.837 UTC [1359] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-plv8> server # [ 104.079815] postgres[1398]: 2026-10-22 21:23:28.001 UTC [1398] LOG: database system was shut down at 2026-10-22 21:23:18 UTC vm-test-run-plv8> server # [ 104.431581] postgres[1405]: 2026-10-22 21:23:28.360 UTC [1405] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-plv8> server # [ 104.463349] postgres[1359]: 2026-10-22 21:23:28.389 UTC [1359] LOG: database system is ready to accept connections vm-test-run-plv8> server # [ 104.482488] postgres[1406]: 2026-10-22 21:23:28.399 UTC [1406] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 104.519859] systemd[1]: Started PostgreSQL Database Server. vm-test-run-plv8> server # [ 104.582590] systemd[1]: Starting Supabase Database Initialization... vm-test-run-plv8> server # [ 104.774516] postgres[1359]: 2026-10-22 21:23:28.720 UTC [1359] LOG: background worker "pg_net 0.20.4 worker" (PID 1406) exited with exit code 1 vm-test-run-plv8> server # [ 104.851208] postgres[1408]: 2026-10-22 21:23:28.788 UTC [1408] LOG: pg_cron scheduler started vm-test-run-plv8> server # [ 104.997414] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Waiting for PostgreSQL to be ready... vm-test-run-plv8> server # [ 105.925936] postgres[1434]: 2026-10-22 21:23:29.834 UTC [1434] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 105.957295] postgres[1433]: ::1 2026-10-22 21:23:29.876 UTC [1433] root@root FATAL: role "root" does not exist vm-test-run-plv8> server # [ 106.031554] postgres[1359]: 2026-10-22 21:23:29.934 UTC [1359] LOG: background worker "pg_net 0.20.4 worker" (PID 1434) exited with exit code 1 vm-test-run-plv8> server # [ 106.071841] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: PostgreSQL is ready vm-test-run-plv8> server # [ 106.078688] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Creating postgres role... vm-test-run-plv8> server # [ 106.431909] postgres[1436]: ::1 2026-10-22 21:23:30.370 UTC [1436] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-plv8> server # [ 106.456245] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1435]: CREATE ROLE vm-test-run-plv8> server # [ 106.714748] postgres[1438]: ::1 2026-10-22 21:23:30.656 UTC [1438] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-plv8> server # [ 106.753232] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1437]: ALTER DATABASE vm-test-run-plv8> server # [ 106.783690] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-plv8> server # [ 107.021405] postgres[1440]: ::1 2026-10-22 21:23:30.956 UTC [1440] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-plv8> server # [ 107.078814] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: CREATE PUBLICATION vm-test-run-plv8> server # [ 107.085862] postgres[1440]: ::1 2026-10-22 21:23:31.017 UTC [1440] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-plv8> server # [ 107.089158] postgres[1440]: ::1 2026-10-22 21:23:31.030 UTC [1440] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-plv8> server # [ 107.091097] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: ALTER ROLE vm-test-run-plv8> server # [ 107.100517] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: CREATE ROLE vm-test-run-plv8> server # [ 107.101340] postgres[1440]: ::1 2026-10-22 21:23:31.047 UTC [1440] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-plv8> server # [ 107.111700] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: CREATE ROLE vm-test-run-plv8> server # [ 107.115996] postgres[1440]: ::1 2026-10-22 21:23:31.060 UTC [1440] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-plv8> server # [ 107.123360] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: GRANT ROLE vm-test-run-plv8> server # [ 107.124035] postgres[1440]: ::1 2026-10-22 21:23:31.070 UTC [1440] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-plv8> server # [ 107.132302] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: GRANT vm-test-run-plv8> server # [ 107.136833] postgres[1440]: ::1 2026-10-22 21:23:31.078 UTC [1440] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-plv8> server # [ 107.142364] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: CREATE ROLE vm-test-run-plv8> server # [ 107.143148] postgres[1440]: ::1 2026-10-22 21:23:31.088 UTC [1440] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-plv8> server # [ 107.154964] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: GRANT ROLE vm-test-run-plv8> server # [ 107.156127] postgres[1440]: ::1 2026-10-22 21:23:31.099 UTC [1440] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-plv8> server # [ 107.166400] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: CREATE SCHEMA vm-test-run-plv8> server # [ 107.167708] postgres[1440]: ::1 2026-10-22 21:23:31.114 UTC [1440] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-plv8> server # [ 109.940854] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: CREATE EXTENSION vm-test-run-plv8> server # [ 109.958608] postgres[1440]: ::1 2026-10-22 21:23:33.884 UTC [1440] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-plv8> server # [ 110.753576] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: CREATE EXTENSION vm-test-run-plv8> server # [ 110.758973] postgres[1440]: ::1 2026-10-22 21:23:34.703 UTC [1440] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-plv8> server # [ 110.769266] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: CREATE ROLE vm-test-run-plv8> server # [ 110.770989] postgres[1440]: ::1 2026-10-22 21:23:34.715 UTC [1440] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-plv8> server # [ 110.780559] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: CREATE ROLE vm-test-run-plv8> server # [ 110.789678] postgres[1440]: ::1 2026-10-22 21:23:34.730 UTC [1440] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-plv8> server # [ 110.801110] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: CREATE ROLE vm-test-run-plv8> server # [ 110.812999] postgres[1440]: ::1 2026-10-22 21:23:34.756 UTC [1440] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-plv8> server # [ 110.822649] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: CREATE ROLE vm-test-run-plv8> server # [ 110.823658] postgres[1440]: ::1 2026-10-22 21:23:34.769 UTC [1440] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-plv8> server # [ 110.834969] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: GRANT ROLE vm-test-run-plv8> server # [ 110.839133] postgres[1440]: ::1 2026-10-22 21:23:34.784 UTC [1440] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-plv8> server # [ 110.850207] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: GRANT ROLE vm-test-run-plv8> server # [ 110.851059] postgres[1440]: ::1 2026-10-22 21:23:34.796 UTC [1440] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-plv8> server # [ 110.861657] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: GRANT ROLE vm-test-run-plv8> server # [ 110.863927] postgres[1440]: ::1 2026-10-22 21:23:34.805 UTC [1440] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-plv8> server # [ 110.871061] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: GRANT ROLE vm-test-run-plv8> server # [ 110.873181] postgres[1440]: ::1 2026-10-22 21:23:34.817 UTC [1440] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 110.885494] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: GRANT vm-test-run-plv8> server # [ 110.898833] postgres[1440]: ::1 2026-10-22 21:23:34.837 UTC [1440] 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 # [ 110.928987] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 110.938515] postgres[1440]: ::1 2026-10-22 21:23:34.879 UTC [1440] 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 # [ 110.970948] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 110.995620] postgres[1440]: ::1 2026-10-22 21:23:34.909 UTC [1440] 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 # [ 110.998444] postgres[1440]: ::1 2026-10-22 21:23:34.928 UTC [1440] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 111.001919] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 111.003030] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: GRANT vm-test-run-plv8> server # [ 111.005703] postgres[1440]: ::1 2026-10-22 21:23:34.947 UTC [1440] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-plv8> server # [ 111.026845] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: ALTER ROLE vm-test-run-plv8> server # [ 111.037647] postgres[1440]: ::1 2026-10-22 21:23:34.980 UTC [1440] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 111.039107] postgres[1440]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 111.051887] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 111.061968] postgres[1440]: ::1 2026-10-22 21:23:35.007 UTC [1440] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 111.063605] postgres[1440]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 111.077063] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 111.077992] postgres[1440]: ::1 2026-10-22 21:23:35.022 UTC [1440] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 111.079434] postgres[1440]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 111.089067] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 111.102787] postgres[1440]: ::1 2026-10-22 21:23:35.041 UTC [1440] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-plv8> server # [ 111.126557] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: ALTER ROLE vm-test-run-plv8> server # [ 111.131435] postgres[1440]: ::1 2026-10-22 21:23:35.076 UTC [1440] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-plv8> server # [ 111.153036] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1439]: ALTER ROLE vm-test-run-plv8> server # [ 111.247727] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-plv8> server # [ 111.678101] postgres[1487]: ::1 2026-10-22 21:23:35.609 UTC [1487] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 111.718198] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE SCHEMA vm-test-run-plv8> server # [ 111.725858] postgres[1487]: ::1 2026-10-22 21:23:35.644 UTC [1487] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-plv8> server # [ 111.734952] postgres[1487]: instance_id uuid NULL, vm-test-run-plv8> server # [ 111.738267] postgres[1487]: id uuid NOT NULL UNIQUE, vm-test-run-plv8> server # [ 111.740101] postgres[1487]: aud varchar(255) NULL, vm-test-run-plv8> server # [ 111.746824] postgres[1487]: "role" varchar(255) NULL, vm-test-run-plv8> server # [ 111.747598] postgres[1487]: email varchar(255) NULL UNIQUE, vm-test-run-plv8> server # [ 111.753566] postgres[1487]: encrypted_password varchar(255) NULL, vm-test-run-plv8> server # [ 111.761675] postgres[1487]: confirmed_at timestamptz NULL, vm-test-run-plv8> server # [ 111.763381] postgres[1487]: invited_at timestamptz NULL, vm-test-run-plv8> server # [ 111.769472] postgres[1487]: confirmation_token varchar(255) NULL, vm-test-run-plv8> server # [ 111.771267] postgres[1487]: confirmation_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 111.781436] postgres[1487]: recovery_token varchar(255) NULL, vm-test-run-plv8> server # [ 111.783577] postgres[1487]: recovery_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 111.785139] postgres[1487]: email_change_token varchar(255) NULL, vm-test-run-plv8> server # [ 111.785863] postgres[1487]: email_change varchar(255) NULL, vm-test-run-plv8> server # [ 111.786739] postgres[1487]: email_change_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 111.787456] postgres[1487]: last_sign_in_at timestamptz NULL, vm-test-run-plv8> server # [ 111.787759] postgres[1487]: raw_app_meta_data jsonb NULL, vm-test-run-plv8> server # [ 111.794356] postgres[1487]: raw_user_meta_data jsonb NULL, vm-test-run-plv8> server # [ 111.795765] postgres[1487]: is_super_admin bool NULL, vm-test-run-plv8> server # [ 111.802870] postgres[1487]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 111.803382] postgres[1487]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 111.803882] postgres[1487]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 111.805939] postgres[1487]: ); vm-test-run-plv8> server # [ 112.023321] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE TABLE vm-test-run-plv8> server # [ 112.031401] postgres[1487]: ::1 2026-10-22 21:23:35.964 UTC [1487] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-plv8> server # [ 112.115159] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE INDEX vm-test-run-plv8> server # [ 112.127202] postgres[1487]: ::1 2026-10-22 21:23:36.057 UTC [1487] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-plv8> server # [ 112.206512] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE INDEX vm-test-run-plv8> server # [ 112.207827] postgres[1487]: ::1 2026-10-22 21:23:36.147 UTC [1487] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-plv8> server # [ 112.218799] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: COMMENT vm-test-run-plv8> server # [ 112.229889] postgres[1487]: ::1 2026-10-22 21:23:36.168 UTC [1487] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-plv8> server # [ 112.245336] postgres[1487]: instance_id uuid NULL, vm-test-run-plv8> server # [ 112.246494] postgres[1487]: id bigserial NOT NULL, vm-test-run-plv8> server # [ 112.247974] postgres[1487]: "token" varchar(255) NULL, vm-test-run-plv8> server # [ 112.258255] postgres[1487]: user_id varchar(255) NULL, vm-test-run-plv8> server # [ 112.258912] postgres[1487]: revoked bool NULL, vm-test-run-plv8> server # [ 112.259542] postgres[1487]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 112.270407] postgres[1487]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 112.271460] postgres[1487]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 112.278784] postgres[1487]: ); vm-test-run-plv8> server # [ 112.374618] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE TABLE vm-test-run-plv8> server # [ 112.381449] postgres[1487]: ::1 2026-10-22 21:23:36.324 UTC [1487] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-plv8> server # [ 112.410678] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE INDEX vm-test-run-plv8> server # [ 112.411856] postgres[1487]: ::1 2026-10-22 21:23:36.353 UTC [1487] 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 # [ 112.443552] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE INDEX vm-test-run-plv8> server # [ 112.453510] postgres[1487]: ::1 2026-10-22 21:23:36.397 UTC [1487] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-plv8> server # [ 112.477544] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE INDEX vm-test-run-plv8> server # [ 112.479249] postgres[1487]: ::1 2026-10-22 21:23:36.424 UTC [1487] 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 # [ 112.490301] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: COMMENT vm-test-run-plv8> server # [ 112.493445] postgres[1487]: ::1 2026-10-22 21:23:36.438 UTC [1487] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-plv8> server # [ 112.495625] postgres[1487]: id uuid NOT NULL, vm-test-run-plv8> server # [ 112.502353] postgres[1487]: uuid uuid NULL, vm-test-run-plv8> server # [ 112.503209] postgres[1487]: raw_base_config text NULL, vm-test-run-plv8> server # [ 112.506244] postgres[1487]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 112.507376] postgres[1487]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 112.510869] postgres[1487]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 112.514565] postgres[1487]: ); vm-test-run-plv8> server # [ 112.559464] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE TABLE vm-test-run-plv8> server # [ 112.563869] postgres[1487]: ::1 2026-10-22 21:23:36.509 UTC [1487] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-plv8> server # [ 112.579745] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: COMMENT vm-test-run-plv8> server # [ 112.581488] postgres[1487]: ::1 2026-10-22 21:23:36.527 UTC [1487] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-plv8> server # [ 112.584011] postgres[1487]: instance_id uuid NULL, vm-test-run-plv8> server # [ 112.586705] postgres[1487]: id uuid NOT NULL, vm-test-run-plv8> server # [ 112.587108] postgres[1487]: payload json NULL, vm-test-run-plv8> server # [ 112.587573] postgres[1487]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 112.588064] postgres[1487]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 112.591789] postgres[1487]: ); vm-test-run-plv8> server # [ 112.650718] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE TABLE vm-test-run-plv8> server # [ 112.651613] postgres[1487]: ::1 2026-10-22 21:23:36.592 UTC [1487] 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 # [ 112.676630] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE INDEX vm-test-run-plv8> server # [ 112.690321] postgres[1487]: ::1 2026-10-22 21:23:36.625 UTC [1487] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-plv8> server # [ 112.691173] postgres[1487]: ::1 2026-10-22 21:23:36.634 UTC [1487] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-plv8> server # [ 112.691512] postgres[1487]: "version" varchar(255) NOT NULL, vm-test-run-plv8> server # [ 112.691888] postgres[1487]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-plv8> server # [ 112.692164] postgres[1487]: ); vm-test-run-plv8> server # [ 112.705367] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: COMMENT vm-test-run-plv8> server # [ 112.724065] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE TABLE vm-test-run-plv8> server # [ 112.726006] postgres[1487]: ::1 2026-10-22 21:23:36.672 UTC [1487] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-plv8> server # [ 112.737268] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: COMMENT vm-test-run-plv8> server # [ 112.754703] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: INSERT 0 7 vm-test-run-plv8> server # [ 112.761764] postgres[1487]: ::1 2026-10-22 21:23:36.702 UTC [1487] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-plv8> server # [ 112.765529] postgres[1487]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-plv8> server # [ 112.773250] postgres[1487]: $$ language sql stable; vm-test-run-plv8> server # [ 112.774348] postgres[1487]: ::1 2026-10-22 21:23:36.716 UTC [1487] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-plv8> server # [ 112.775592] postgres[1487]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-plv8> server # [ 112.779667] postgres[1487]: $$ language sql stable; vm-test-run-plv8> server # [ 112.786535] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE FUNCTION vm-test-run-plv8> server # [ 112.787666] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE FUNCTION vm-test-run-plv8> server # [ 112.788122] postgres[1487]: ::1 2026-10-22 21:23:36.728 UTC [1487] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-plv8> server # [ 112.797558] postgres[1487]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-plv8> server # [ 112.798165] postgres[1487]: $$ language sql stable; vm-test-run-plv8> server # [ 112.799162] postgres[1487]: ::1 2026-10-22 21:23:36.740 UTC [1487] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-plv8> server # [ 112.801292] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE FUNCTION vm-test-run-plv8> server # [ 112.806221] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.807610] postgres[1487]: ::1 2026-10-22 21:23:36.753 UTC [1487] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 112.815245] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: CREATE ROLE vm-test-run-plv8> server # [ 112.818897] postgres[1487]: ::1 2026-10-22 21:23:36.763 UTC [1487] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 112.825756] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.828861] postgres[1487]: ::1 2026-10-22 21:23:36.773 UTC [1487] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 112.840017] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.845753] postgres[1487]: ::1 2026-10-22 21:23:36.788 UTC [1487] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 112.853264] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: GRANT vm-test-run-plv8> server # [ 112.854355] postgres[1487]: ::1 2026-10-22 21:23:36.797 UTC [1487] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-plv8> server # [ 112.862177] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: ALTER ROLE vm-test-run-plv8> server # [ 112.867147] postgres[1487]: ::1 2026-10-22 21:23:36.811 UTC [1487] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 112.881717] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: ALTER TABLE vm-test-run-plv8> server # [ 112.888871] postgres[1487]: ::1 2026-10-22 21:23:36.830 UTC [1487] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 112.896773] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: ALTER TABLE vm-test-run-plv8> server # [ 112.899260] postgres[1487]: ::1 2026-10-22 21:23:36.845 UTC [1487] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 112.913226] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: ALTER TABLE vm-test-run-plv8> server # [ 112.914458] postgres[1487]: ::1 2026-10-22 21:23:36.859 UTC [1487] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 112.924968] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: ALTER TABLE vm-test-run-plv8> server # [ 112.925808] postgres[1487]: ::1 2026-10-22 21:23:36.871 UTC [1487] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 112.936090] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1481]: ALTER TABLE vm-test-run-plv8> server # [ 112.980634] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-plv8> server # [ 113.247749] postgres[1497]: ::1 2026-10-22 21:23:37.172 UTC [1497] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 113.287278] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1496]: CREATE SCHEMA vm-test-run-plv8> server # [ 113.294560] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1496]: CREATE ROLE vm-test-run-plv8> server # [ 113.311238] postgres[1497]: ::1 2026-10-22 21:23:37.211 UTC [1497] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 113.320429] postgres[1497]: ::1 2026-10-22 21:23:37.223 UTC [1497] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-plv8> server # [ 113.323091] postgres[1497]: ::1 2026-10-22 21:23:37.248 UTC [1497] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-plv8> server # [ 113.332880] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1496]: ALTER ROLE vm-test-run-plv8> server # [ 113.333780] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1496]: GRANT vm-test-run-plv8> server # [ 113.409188] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1496]: DO vm-test-run-plv8> server # [ 113.473405] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-plv8> server # [ 114.095062] postgres[1507]: ::1 2026-10-22 21:23:38.032 UTC [1507] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-plv8> server # [ 114.177800] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: ALTER ROLE vm-test-run-plv8> server # [ 114.181628] postgres[1507]: ::1 2026-10-22 21:23:38.067 UTC [1507] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-plv8> server # [ 114.183326] postgres[1507]: ::1 2026-10-22 21:23:38.112 UTC [1507] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-plv8> server # [ 114.195283] postgres[1507]: RETURNS event_trigger vm-test-run-plv8> server # [ 114.205779] postgres[1507]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 114.207654] postgres[1507]: AS $$ vm-test-run-plv8> server # [ 114.214551] postgres[1507]: DECLARE vm-test-run-plv8> server # [ 114.220829] postgres[1507]: schema_is_cron bool; vm-test-run-plv8> server # [ 114.221894] postgres[1507]: BEGIN vm-test-run-plv8> server # [ 114.222556] postgres[1507]: schema_is_cron = ( vm-test-run-plv8> server # [ 114.223367] postgres[1507]: SELECT n.nspname = 'cron' vm-test-run-plv8> server # [ 114.225103] postgres[1507]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 114.226960] postgres[1507]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-plv8> server # [ 114.227521] postgres[1507]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 114.227816] postgres[1507]: ); vm-test-run-plv8> server # [ 114.235754] postgres[1507]: vm-test-run-plv8> server # [ 114.237333] postgres[1507]: IF schema_is_cron vm-test-run-plv8> server # [ 114.238322] postgres[1507]: THEN vm-test-run-plv8> server # [ 114.239726] postgres[1507]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 114.245527] postgres[1507]: vm-test-run-plv8> server # [ 114.247127] postgres[1507]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 114.247594] postgres[1507]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 114.257470] postgres[1507]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 114.258613] postgres[1507]: vm-test-run-plv8> server # [ 114.259131] postgres[1507]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 114.263427] postgres[1507]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 114.264146] postgres[1507]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 114.265022] postgres[1507]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 114.266431] postgres[1507]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 114.266906] postgres[1507]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 114.267250] postgres[1507]: vm-test-run-plv8> server # [ 114.267703] postgres[1507]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 114.273302] postgres[1507]: vm-test-run-plv8> server # [ 114.273846] postgres[1507]: END IF; vm-test-run-plv8> server # [ 114.274709] postgres[1507]: vm-test-run-plv8> server # [ 114.275058] postgres[1507]: END; vm-test-run-plv8> server # [ 114.275778] postgres[1507]: $$; vm-test-run-plv8> server # [ 114.281717] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: ALTER ROLE vm-test-run-plv8> server # [ 114.283195] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: CREATE FUNCTION vm-test-run-plv8> server # [ 114.289976] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 114.291627] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: COMMENT vm-test-run-plv8> server # [ 114.301541] postgres[1507]: ::1 2026-10-22 21:23:38.160 UTC [1507] 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 # [ 114.302519] postgres[1507]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 114.302910] postgres[1507]: ::1 2026-10-22 21:23:38.182 UTC [1507] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-plv8> server # [ 114.303383] postgres[1507]: ::1 2026-10-22 21:23:38.210 UTC [1507] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-plv8> server # [ 114.315971] postgres[1507]: RETURNS event_trigger vm-test-run-plv8> server # [ 114.317478] postgres[1507]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 114.318147] postgres[1507]: AS $$ vm-test-run-plv8> server # [ 114.318467] postgres[1507]: BEGIN vm-test-run-plv8> server # [ 114.318688] postgres[1507]: IF EXISTS ( vm-test-run-plv8> server # [ 114.319014] postgres[1507]: SELECT 1 vm-test-run-plv8> server # [ 114.320073] postgres[1507]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 114.337747] postgres[1507]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 114.351439] postgres[1507]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 114.365066] postgres[1507]: WHERE ext.extname = 'pg_net' vm-test-run-plv8> server # [ 114.377259] postgres[1507]: ) vm-test-run-plv8> server # [ 114.377824] postgres[1507]: THEN vm-test-run-plv8> server # [ 114.378094] postgres[1507]: IF NOT EXISTS ( vm-test-run-plv8> server # [ 114.378454] postgres[1507]: SELECT 1 vm-test-run-plv8> server # [ 114.379251] postgres[1507]: FROM pg_roles vm-test-run-plv8> server # [ 114.379560] postgres[1507]: WHERE rolname = 'supabase_functions_admin' vm-test-run-plv8> server # [ 114.380162] postgres[1507]: ) vm-test-run-plv8> server # [ 114.385882] postgres[1507]: THEN vm-test-run-plv8> server # [ 114.386632] postgres[1507]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 114.387243] postgres[1507]: END IF; vm-test-run-plv8> server # [ 114.387553] postgres[1507]: vm-test-run-plv8> server # [ 114.394251] postgres[1507]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 114.409268] postgres[1507]: vm-test-run-plv8> server # [ 114.415617] postgres[1507]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 114.421041] postgres[1507]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 114.424256] postgres[1507]: vm-test-run-plv8> server # [ 114.433732] postgres[1507]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plv8> server # [ 114.434776] postgres[1507]: 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 # [ 114.435783] postgres[1507]: vm-test-run-plv8> server # [ 114.441176] postgres[1507]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plv8> server # [ 114.443603] postgres[1507]: 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 # [ 114.445036] postgres[1507]: vm-test-run-plv8> server # [ 114.445873] postgres[1507]: 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 # [ 114.449416] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: CREATE FUNCTION vm-test-run-plv8> server # [ 114.450579] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: COMMENT vm-test-run-plv8> server # [ 114.451239] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: DO vm-test-run-plv8> server # [ 114.451533] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: CREATE ROLE vm-test-run-plv8> server # [ 114.452003] postgres[1507]: 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 # [ 114.454644] postgres[1507]: END IF; vm-test-run-plv8> server # [ 114.455916] postgres[1507]: END; vm-test-run-plv8> server # [ 114.457182] postgres[1507]: $$; vm-test-run-plv8> server # [ 114.458230] postgres[1507]: ::1 2026-10-22 21:23:38.232 UTC [1507] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-plv8> server # [ 114.458925] postgres[1507]: ::1 2026-10-22 21:23:38.351 UTC [1507] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-plv8> server # [ 114.459466] postgres[1507]: ::1 2026-10-22 21:23:38.377 UTC [1507] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-plv8> server # [ 114.460188] postgres[1507]: ::1 2026-10-22 21:23:38.397 UTC [1507] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 114.461723] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: GRANT vm-test-run-plv8> server # [ 114.482031] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: GRANT vm-test-run-plv8> server # [ 114.489185] postgres[1507]: ::1 2026-10-22 21:23:38.432 UTC [1507] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 114.497656] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: GRANT vm-test-run-plv8> server # [ 114.505183] postgres[1507]: ::1 2026-10-22 21:23:38.450 UTC [1507] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 114.529582] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: GRANT vm-test-run-plv8> server # [ 114.530621] postgres[1507]: ::1 2026-10-22 21:23:38.474 UTC [1507] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 114.533372] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: GRANT vm-test-run-plv8> server # [ 114.537173] postgres[1507]: ::1 2026-10-22 21:23:38.482 UTC [1507] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 114.543875] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: GRANT vm-test-run-plv8> server # [ 114.549237] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: GRANT vm-test-run-plv8> server # [ 114.551221] postgres[1507]: ::1 2026-10-22 21:23:38.492 UTC [1507] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 114.557253] postgres[1507]: ::1 2026-10-22 21:23:38.495 UTC [1507] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 114.576870] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: GRANT vm-test-run-plv8> server # [ 114.579240] postgres[1507]: ::1 2026-10-22 21:23:38.524 UTC [1507] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 114.706397] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: GRANT vm-test-run-plv8> server # [ 114.730299] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1502]: DO vm-test-run-plv8> server # [ 114.781530] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running pgbouncer auth schema... vm-test-run-plv8> server # [ 115.045970] postgres[1525]: ::1 2026-10-22 21:23:38.986 UTC [1525] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-plv8> server # [ 115.061181] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1524]: CREATE ROLE vm-test-run-plv8> server # [ 115.062131] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1524]: REVOKE vm-test-run-plv8> server # [ 115.062826] postgres[1525]: ::1 2026-10-22 21:23:38.999 UTC [1525] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-plv8> server # [ 115.063679] postgres[1525]: ::1 2026-10-22 21:23:39.009 UTC [1525] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-plv8> server # [ 115.108427] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1524]: CREATE SCHEMA vm-test-run-plv8> server # [ 115.110262] postgres[1525]: ::1 2026-10-22 21:23:39.056 UTC [1525] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-plv8> server # [ 115.110876] postgres[1525]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-plv8> server # [ 115.111636] postgres[1525]: $$ vm-test-run-plv8> server # [ 115.112081] postgres[1525]: BEGIN vm-test-run-plv8> server # [ 115.112333] postgres[1525]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-plv8> server # [ 115.118243] postgres[1525]: vm-test-run-plv8> server # [ 115.120902] postgres[1525]: RETURN QUERY vm-test-run-plv8> server # [ 115.121469] postgres[1525]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-plv8> server # [ 115.122989] postgres[1525]: WHERE usename = p_usename; vm-test-run-plv8> server # [ 115.123347] postgres[1525]: END; vm-test-run-plv8> server # [ 115.123580] postgres[1525]: $$ LANGUAGE plpgsql vm-test-run-plv8> server # [ 115.123790] postgres[1525]: SET search_path = '' vm-test-run-plv8> server # [ 115.123988] postgres[1525]: SECURITY DEFINER; vm-test-run-plv8> server # [ 115.136717] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1524]: CREATE FUNCTION vm-test-run-plv8> server # [ 115.137624] postgres[1525]: ::1 2026-10-22 21:23:39.080 UTC [1525] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-plv8> server # [ 115.143714] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1524]: REVOKE vm-test-run-plv8> server # [ 115.146662] postgres[1525]: ::1 2026-10-22 21:23:39.092 UTC [1525] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-plv8> server # [ 115.154604] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1524]: GRANT vm-test-run-plv8> server # [ 115.193083] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running stat extension... vm-test-run-plv8> server # [ 115.598192] postgres[1531]: ::1 2026-10-22 21:23:39.535 UTC [1531] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-plv8> server # [ 115.621879] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-plv8> server # [ 115.649469] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: CREATE SCHEMA vm-test-run-plv8> server # [ 115.655445] postgres[1531]: ::1 2026-10-22 21:23:39.597 UTC [1531] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-plv8> server # [ 116.714247] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1526]: CREATE EXTENSION vm-test-run-plv8> server # [ 116.784602] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-plv8> server # [ 117.179340] postgres[1540]: ::1 2026-10-22 21:23:41.089 UTC [1540] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-plv8> server # [ 117.198721] postgres[1540]: ::1 2026-10-22 21:23:41.138 UTC [1540] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 117.233825] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1534]: GRANT vm-test-run-plv8> server # [ 117.245522] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1534]: GRANT vm-test-run-plv8> server # [ 117.247421] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1534]: GRANT vm-test-run-plv8> server # [ 117.254748] postgres[1540]: ::1 2026-10-22 21:23:41.166 UTC [1540] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 117.263920] postgres[1540]: ::1 2026-10-22 21:23:41.185 UTC [1540] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 117.281974] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1534]: GRANT vm-test-run-plv8> server # [ 117.284514] postgres[1540]: ::1 2026-10-22 21:23:41.224 UTC [1540] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 117.312937] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1534]: GRANT vm-test-run-plv8> server # [ 117.313745] postgres[1540]: ::1 2026-10-22 21:23:41.257 UTC [1540] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 117.337640] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1534]: GRANT vm-test-run-plv8> server # [ 117.339065] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1534]: GRANT vm-test-run-plv8> server # [ 117.346556] postgres[1540]: ::1 2026-10-22 21:23:41.280 UTC [1540] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 117.347372] postgres[1540]: ::1 2026-10-22 21:23:41.287 UTC [1540] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 117.359065] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1534]: GRANT vm-test-run-plv8> server # [ 117.365992] postgres[1540]: ::1 2026-10-22 21:23:41.308 UTC [1540] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 117.545455] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1534]: GRANT vm-test-run-plv8> server # [ 117.625497] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1534]: DO vm-test-run-plv8> server # [ 117.629340] postgres[1540]: ::1 2026-10-22 21:23:41.575 UTC [1540] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-plv8> server # [ 117.641263] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1534]: ALTER ROLE vm-test-run-plv8> server # [ 117.698279] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-plv8> server # [ 118.193295] postgres[1557]: ::1 2026-10-22 21:23:42.109 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.217501] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: GRANT vm-test-run-plv8> server # [ 118.218745] postgres[1557]: ::1 2026-10-22 21:23:42.163 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.244766] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: GRANT vm-test-run-plv8> server # [ 118.246623] postgres[1557]: ::1 2026-10-22 21:23:42.191 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.261614] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: GRANT vm-test-run-plv8> server # [ 118.263515] postgres[1557]: ::1 2026-10-22 21:23:42.206 UTC [1557] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.287161] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: ALTER TABLE vm-test-run-plv8> server # [ 118.288013] postgres[1557]: ::1 2026-10-22 21:23:42.231 UTC [1557] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.297183] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: ALTER TABLE vm-test-run-plv8> server # [ 118.301922] postgres[1557]: ::1 2026-10-22 21:23:42.245 UTC [1557] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.312250] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: ALTER TABLE vm-test-run-plv8> server # [ 118.314173] postgres[1557]: ::1 2026-10-22 21:23:42.254 UTC [1557] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.320038] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: ALTER TABLE vm-test-run-plv8> server # [ 118.324912] postgres[1557]: ::1 2026-10-22 21:23:42.268 UTC [1557] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 118.330596] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: ALTER TABLE vm-test-run-plv8> server # [ 118.331904] postgres[1557]: ::1 2026-10-22 21:23:42.277 UTC [1557] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 118.343172] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: GRANT vm-test-run-plv8> server # [ 118.344162] postgres[1557]: ::1 2026-10-22 21:23:42.287 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 118.354588] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: GRANT vm-test-run-plv8> server # [ 118.358170] postgres[1557]: ::1 2026-10-22 21:23:42.302 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 118.369395] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: GRANT vm-test-run-plv8> server # [ 118.370843] postgres[1557]: ::1 2026-10-22 21:23:42.313 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 118.380951] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: GRANT vm-test-run-plv8> server # [ 118.381970] postgres[1557]: ::1 2026-10-22 21:23:42.325 UTC [1557] 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 # [ 118.393075] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 118.394743] postgres[1557]: ::1 2026-10-22 21:23:42.340 UTC [1557] 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 # [ 118.403124] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 118.415506] postgres[1557]: ::1 2026-10-22 21:23:42.350 UTC [1557] 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 # [ 118.437190] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1555]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 118.486751] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-plv8> server # [ 118.727748] postgres[1561]: ::1 2026-10-22 21:23:42.669 UTC [1561] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-plv8> server # [ 118.751832] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1560]: CREATE SCHEMA vm-test-run-plv8> server # [ 118.779905] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-plv8> server # [ 119.052518] postgres[1563]: ::1 2026-10-22 21:23:42.994 UTC [1563] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-plv8> server # [ 119.070379] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 119.079706] postgres[1563]: ::1 2026-10-22 21:23:43.019 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 119.081499] postgres[1563]: ::1 2026-10-22 21:23:43.024 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 119.084206] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 119.090003] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 119.092992] postgres[1563]: ::1 2026-10-22 21:23:43.031 UTC [1563] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 119.098874] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1562]: GRANT vm-test-run-plv8> server # [ 119.129735] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-plv8> server # [ 119.539568] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: DO vm-test-run-plv8> server # [ 119.551869] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: DO vm-test-run-plv8> server # [ 119.580649] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1564]: DO vm-test-run-plv8> server # [ 119.648173] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-plv8> server # [ 120.170604] postgres[1574]: ::1 2026-10-22 21:23:44.101 UTC [1574] 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 # [ 120.209576] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1570]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 120.210965] postgres[1574]: ::1 2026-10-22 21:23:44.152 UTC [1574] 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 # [ 120.233009] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1570]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 120.234354] postgres[1574]: ::1 2026-10-22 21:23:44.179 UTC [1574] 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 # [ 120.245597] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1570]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 120.310019] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-plv8> server # [ 120.798819] postgres[1587]: ::1 2026-10-22 21:23:44.724 UTC [1587] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-plv8> server # [ 120.813036] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1581]: ALTER ROLE vm-test-run-plv8> server # [ 120.867258] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-plv8> server # [ 121.351654] postgres[1597]: ::1 2026-10-22 21:23:45.284 UTC [1597] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 121.365925] postgres[1597]: ::1 2026-10-22 21:23:45.308 UTC [1597] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 121.375577] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-plv8> server # [ 121.385896] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 121.389438] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-plv8> server # [ 121.393959] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: DROP FUNCTION vm-test-run-plv8> server # [ 121.395041] postgres[1597]: ::1 2026-10-22 21:23:45.330 UTC [1597] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 121.395948] postgres[1597]: DECLARE vm-test-run-plv8> server # [ 121.396246] postgres[1597]: cmd record; vm-test-run-plv8> server # [ 121.401299] postgres[1597]: BEGIN vm-test-run-plv8> server # [ 121.404141] postgres[1597]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 121.410562] postgres[1597]: LOOP vm-test-run-plv8> server # [ 121.411101] postgres[1597]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 121.416286] postgres[1597]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 121.422397] postgres[1597]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 121.423291] postgres[1597]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 121.426595] postgres[1597]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 121.434399] postgres[1597]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 121.435549] postgres[1597]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 121.435929] postgres[1597]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 121.436402] postgres[1597]: , 'CREATE TYPE' vm-test-run-plv8> server # [ 121.437958] postgres[1597]: , 'CREATE RULE' vm-test-run-plv8> server # [ 121.440065] postgres[1597]: , 'COMMENT' vm-test-run-plv8> server # [ 121.441982] postgres[1597]: ) vm-test-run-plv8> server # [ 121.442718] postgres[1597]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 121.444141] postgres[1597]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 121.448989] postgres[1597]: THEN vm-test-run-plv8> server # [ 121.451886] postgres[1597]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 121.457920] postgres[1597]: END IF; vm-test-run-plv8> server # [ 121.459083] postgres[1597]: END LOOP; vm-test-run-plv8> server # [ 121.459681] postgres[1597]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 121.460163] postgres[1597]: ::1 2026-10-22 21:23:45.378 UTC [1597] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 121.460505] postgres[1597]: DECLARE vm-test-run-plv8> server # [ 121.460723] postgres[1597]: obj record; vm-test-run-plv8> server # [ 121.465870] postgres[1597]: BEGIN vm-test-run-plv8> server # [ 121.466908] postgres[1597]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 121.467456] postgres[1597]: LOOP vm-test-run-plv8> server # [ 121.468063] postgres[1597]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 121.477769] postgres[1597]: 'schema' vm-test-run-plv8> server # [ 121.478797] postgres[1597]: , 'table' vm-test-run-plv8> server # [ 121.479304] postgres[1597]: , 'foreign table' vm-test-run-plv8> server # [ 121.488422] postgres[1597]: , 'view' vm-test-run-plv8> server # [ 121.495309] postgres[1597]: , 'materialized view' vm-test-run-plv8> server # [ 121.495711] postgres[1597]: , 'function' vm-test-run-plv8> server # [ 121.496047] postgres[1597]: , 'trigger' vm-test-run-plv8> server # [ 121.497995] postgres[1597]: , 'type' vm-test-run-plv8> server # [ 121.507416] postgres[1597]: , 'rule' vm-test-run-plv8> server # [ 121.526492] postgres[1597]: ) vm-test-run-plv8> server # [ 121.527197] postgres[1597]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 121.528687] postgres[1597]: THEN vm-test-run-plv8> server # [ 121.567334] postgres[1597]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 121.582293] postgres[1597]: END IF; vm-test-run-plv8> server # [ 121.595590] postgres[1597]: END LOOP; vm-test-run-plv8> server # [ 121.596562] postgres[1597]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 121.605293] postgres[1597]: ::1 2026-10-22 21:23:45.400 UTC [1597] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 121.609776] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: CREATE FUNCTION vm-test-run-plv8> server # [ 121.626200] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: CREATE FUNCTION vm-test-run-plv8> server # [ 121.627669] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-plv8> server # [ 121.635938] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 121.645160] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 121.655444] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-plv8> server # [ 121.660550] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 121.661987] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1593]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 121.668533] postgres[1597]: ::1 2026-10-22 21:23:45.409 UTC [1597] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 121.678660] postgres[1597]: ON ddl_command_end vm-test-run-plv8> server # [ 121.683216] postgres[1597]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 121.693121] postgres[1597]: ::1 2026-10-22 21:23:45.423 UTC [1597] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 121.695056] postgres[1597]: ::1 2026-10-22 21:23:45.433 UTC [1597] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 121.696733] postgres[1597]: ON sql_drop vm-test-run-plv8> server # [ 121.697081] postgres[1597]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 121.703411] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-plv8> server # [ 122.745787] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1600]: DO vm-test-run-plv8> server # [ 122.777110] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-plv8> server # [ 123.067552] postgres[1603]: ::1 2026-10-22 21:23:46.995 UTC [1603] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-plv8> server # [ 123.130465] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: CREATE SCHEMA vm-test-run-plv8> server # [ 123.145171] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: 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 # [ 123.146998] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: DROP FUNCTION vm-test-run-plv8> server # [ 123.147924] postgres[1603]: ::1 2026-10-22 21:23:47.052 UTC [1603] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-plv8> server # [ 123.159798] postgres[1603]: ::1 2026-10-22 21:23:47.068 UTC [1603] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 123.168144] postgres[1603]: "operationName" text default null, vm-test-run-plv8> server # [ 123.182365] postgres[1603]: query text default null, vm-test-run-plv8> server # [ 123.183199] postgres[1603]: variables jsonb default null, vm-test-run-plv8> server # [ 123.192788] postgres[1603]: extensions jsonb default null vm-test-run-plv8> server # [ 123.193807] postgres[1603]: ) vm-test-run-plv8> server # [ 123.194851] postgres[1603]: returns jsonb vm-test-run-plv8> server # [ 123.195643] postgres[1603]: language plpgsql vm-test-run-plv8> server # [ 123.195942] postgres[1603]: as $$ vm-test-run-plv8> server # [ 123.205122] postgres[1603]: DECLARE vm-test-run-plv8> server # [ 123.210259] postgres[1603]: server_version float; vm-test-run-plv8> server # [ 123.211179] postgres[1603]: BEGIN vm-test-run-plv8> server # [ 123.215783] postgres[1603]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 123.222410] postgres[1603]: vm-test-run-plv8> server # [ 123.223168] postgres[1603]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 123.224113] postgres[1603]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 123.235438] postgres[1603]: 'data', null::jsonb, vm-test-run-plv8> server # [ 123.241600] postgres[1603]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 123.242802] postgres[1603]: ); vm-test-run-plv8> server # [ 123.243165] postgres[1603]: ELSE vm-test-run-plv8> server # [ 123.243406] postgres[1603]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 123.244019] postgres[1603]: 'data', null::jsonb, vm-test-run-plv8> server # [ 123.244318] postgres[1603]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 123.258700] postgres[1603]: ); vm-test-run-plv8> server # [ 123.268960] postgres[1603]: END IF; vm-test-run-plv8> server # [ 123.270190] postgres[1603]: END; vm-test-run-plv8> server # [ 123.271330] postgres[1603]: $$; vm-test-run-plv8> server # [ 123.280739] postgres[1603]: ::1 2026-10-22 21:23:47.112 UTC [1603] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 123.282353] postgres[1603]: ::1 2026-10-22 21:23:47.141 UTC [1603] 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 # [ 123.283846] postgres[1603]: ::1 2026-10-22 21:23:47.176 UTC [1603] 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 # [ 123.295399] postgres[1603]: ::1 2026-10-22 21:23:47.196 UTC [1603] 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 # [ 123.301993] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: CREATE FUNCTION vm-test-run-plv8> server # [ 123.302718] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: GRANT vm-test-run-plv8> server # [ 123.303044] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 123.303300] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 123.303545] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 123.303982] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 123.320873] postgres[1603]: ::1 2026-10-22 21:23:47.236 UTC [1603] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 123.322623] postgres[1603]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 123.323118] postgres[1603]: ::1 2026-10-22 21:23:47.248 UTC [1603] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 123.323757] postgres[1603]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 123.333514] postgres[1603]: ::1 2026-10-22 21:23:47.267 UTC [1603] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 123.335345] postgres[1603]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 123.348970] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 123.349514] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 123.350891] postgres[1603]: ::1 2026-10-22 21:23:47.289 UTC [1603] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 123.369697] postgres[1603]: RETURNS event_trigger vm-test-run-plv8> server # [ 123.370670] postgres[1603]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 123.371330] postgres[1603]: AS $func$ vm-test-run-plv8> server # [ 123.371601] postgres[1603]: DECLARE vm-test-run-plv8> server # [ 123.382782] postgres[1603]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 123.383682] postgres[1603]: BEGIN vm-test-run-plv8> server # [ 123.407197] postgres[1603]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 123.419659] postgres[1603]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 123.420089] postgres[1603]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 123.421663] postgres[1603]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 123.422449] postgres[1603]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 123.423257] postgres[1603]: ); vm-test-run-plv8> server # [ 123.424073] postgres[1603]: vm-test-run-plv8> server # [ 123.426811] postgres[1603]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 123.428593] postgres[1603]: THEN vm-test-run-plv8> server # [ 123.434691] postgres[1603]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 123.435302] postgres[1603]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 123.435984] postgres[1603]: vm-test-run-plv8> server # [ 123.442452] postgres[1603]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 123.443990] postgres[1603]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 123.445291] postgres[1603]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 123.446546] postgres[1603]: vm-test-run-plv8> server # [ 123.447892] postgres[1603]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 123.453809] postgres[1603]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 123.457594] postgres[1603]: "operationName" text default null, vm-test-run-plv8> server # [ 123.459038] postgres[1603]: query text default null, vm-test-run-plv8> server # [ 123.459406] postgres[1603]: variables jsonb default null, vm-test-run-plv8> server # [ 123.459682] postgres[1603]: extensions jsonb default null vm-test-run-plv8> server # [ 123.460026] postgres[1603]: ) vm-test-run-plv8> server # [ 123.465503] postgres[1603]: returns jsonb vm-test-run-plv8> server # [ 123.468015] postgres[1603]: language sql vm-test-run-plv8> server # [ 123.471164] postgres[1603]: as $$ vm-test-run-plv8> server # [ 123.481331] postgres[1603]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-plv8> server # [ 123.482472] postgres[1603]: $$; vm-test-run-plv8> server # [ 123.491110] postgres[1603]: vm-test-run-plv8> server # [ 123.491983] postgres[1603]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 123.493719] postgres[1603]: END IF; vm-test-run-plv8> server # [ 123.494041] postgres[1603]: vm-test-run-plv8> server # [ 123.494534] postgres[1603]: END; vm-test-run-plv8> server # [ 123.494760] postgres[1603]: $func$; vm-test-run-plv8> server # [ 123.498341] postgres[1603]: ::1 2026-10-22 21:23:47.367 UTC [1603] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-plv8> server # [ 123.498877] postgres[1603]: ::1 2026-10-22 21:23:47.379 UTC [1603] 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 # [ 123.499676] postgres[1603]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-plv8> server # [ 123.501128] postgres[1603]: ::1 2026-10-22 21:23:47.406 UTC [1603] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-plv8> server # [ 123.502544] postgres[1603]: ::1 2026-10-22 21:23:47.444 UTC [1603] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 123.503104] postgres[1603]: RETURNS event_trigger vm-test-run-plv8> server # [ 123.505038] postgres[1603]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 123.505516] postgres[1603]: AS $func$ vm-test-run-plv8> server # [ 123.505748] postgres[1603]: DECLARE vm-test-run-plv8> server # [ 123.505957] postgres[1603]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 123.506374] postgres[1603]: BEGIN vm-test-run-plv8> server # [ 123.506641] postgres[1603]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 123.506893] postgres[1603]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 123.507265] postgres[1603]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 123.507563] postgres[1603]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 123.508404] postgres[1603]: ); vm-test-run-plv8> server # [ 123.508707] postgres[1603]: vm-test-run-plv8> server # [ 123.508949] postgres[1603]: IF graphql_is_dropped vm-test-run-plv8> server # [ 123.510796] postgres[1603]: THEN vm-test-run-plv8> server # [ 123.511458] postgres[1603]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 123.514571] postgres[1603]: "operationName" text default null, vm-test-run-plv8> server # [ 123.516327] postgres[1603]: query text default null, vm-test-run-plv8> server # [ 123.518409] postgres[1603]: variables jsonb default null, vm-test-run-plv8> server # [ 123.519818] postgres[1603]: extensions jsonb default null vm-test-run-plv8> server # [ 123.523344] postgres[1603]: ) vm-test-run-plv8> server # [ 123.525027] postgres[1603]: returns jsonb vm-test-run-plv8> server # [ 123.526228] postgres[1603]: language plpgsql vm-test-run-plv8> server # [ 123.527954] postgres[1603]: as $$ vm-test-run-plv8> server # [ 123.533773] postgres[1603]: DECLARE vm-test-run-plv8> server # [ 123.535636] postgres[1603]: server_version float; vm-test-run-plv8> server # [ 123.537989] postgres[1603]: BEGIN vm-test-run-plv8> server # [ 123.538368] postgres[1603]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 123.539608] postgres[1603]: vm-test-run-plv8> server # [ 123.539968] postgres[1603]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 123.546483] postgres[1603]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 123.550292] postgres[1603]: 'data', null::jsonb, vm-test-run-plv8> server # [ 123.551218] postgres[1603]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 123.551845] postgres[1603]: ); vm-test-run-plv8> server # [ 123.556835] postgres[1603]: ELSE vm-test-run-plv8> server # [ 123.557846] postgres[1603]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 123.558461] postgres[1603]: 'data', null::jsonb, vm-test-run-plv8> server # [ 123.559070] postgres[1603]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 123.560561] postgres[1603]: ); vm-test-run-plv8> server # [ 123.560848] postgres[1603]: END IF; vm-test-run-plv8> server # [ 123.562350] postgres[1603]: END; vm-test-run-plv8> server # [ 123.568296] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: CREATE FUNCTION vm-test-run-plv8> server # [ 123.574539] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: 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 # [ 123.576526] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 123.577923] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 123.578758] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: COMMENT vm-test-run-plv8> server # [ 123.579285] postgres[1603]: $$; vm-test-run-plv8> server # [ 123.579593] postgres[1603]: END IF; vm-test-run-plv8> server # [ 123.579822] postgres[1603]: vm-test-run-plv8> server # [ 123.580026] postgres[1603]: END; vm-test-run-plv8> server # [ 123.580228] postgres[1603]: $func$; vm-test-run-plv8> server # [ 123.630785] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: CREATE FUNCTION vm-test-run-plv8> server # [ 123.637574] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: 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 # [ 123.638403] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 123.638791] postgres[1603]: ::1 2026-10-22 21:23:47.580 UTC [1603] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-plv8> server # [ 123.643562] postgres[1603]: ::1 2026-10-22 21:23:47.588 UTC [1603] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-plv8> server # [ 123.645074] postgres[1603]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-plv8> server # [ 123.657460] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 123.659957] postgres[1603]: ::1 2026-10-22 21:23:47.605 UTC [1603] 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 # [ 123.685176] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1602]: COMMENT vm-test-run-plv8> server # [ 123.749039] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-plv8> server # [ 124.371832] postgres[1622]: ::1 2026-10-22 21:23:48.290 UTC [1622] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 124.377987] postgres[1622]: ::1 2026-10-22 21:23:48.318 UTC [1622] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 124.399494] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1616]: 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 # [ 124.405424] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1616]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 124.408664] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1616]: 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 # [ 124.409826] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1616]: DROP FUNCTION vm-test-run-plv8> server # [ 124.410824] postgres[1622]: ::1 2026-10-22 21:23:48.345 UTC [1622] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 124.411956] postgres[1622]: DECLARE vm-test-run-plv8> server # [ 124.417619] postgres[1622]: cmd record; vm-test-run-plv8> server # [ 124.418969] postgres[1622]: BEGIN vm-test-run-plv8> server # [ 124.419326] postgres[1622]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 124.419815] postgres[1622]: LOOP vm-test-run-plv8> server # [ 124.425949] postgres[1622]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 124.426885] postgres[1622]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 124.434665] postgres[1622]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 124.436024] postgres[1622]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 124.437131] postgres[1622]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 124.437960] postgres[1622]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 124.438743] postgres[1622]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 124.439464] postgres[1622]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 124.439819] postgres[1622]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-plv8> server # [ 124.440093] postgres[1622]: , 'CREATE RULE' vm-test-run-plv8> server # [ 124.446932] postgres[1622]: , 'COMMENT' vm-test-run-plv8> server # [ 124.447412] postgres[1622]: ) vm-test-run-plv8> server # [ 124.447661] postgres[1622]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 124.447924] postgres[1622]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 124.448146] postgres[1622]: THEN vm-test-run-plv8> server # [ 124.449458] postgres[1622]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 124.449759] postgres[1622]: END IF; vm-test-run-plv8> server # [ 124.449975] postgres[1622]: END LOOP; vm-test-run-plv8> server # [ 124.450816] postgres[1622]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 124.485193] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1616]: CREATE FUNCTION vm-test-run-plv8> server # [ 124.487196] postgres[1622]: ::1 2026-10-22 21:23:48.432 UTC [1622] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 124.487827] postgres[1622]: DECLARE vm-test-run-plv8> server # [ 124.493838] postgres[1622]: obj record; vm-test-run-plv8> server # [ 124.494534] postgres[1622]: BEGIN vm-test-run-plv8> server # [ 124.494964] postgres[1622]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 124.495317] postgres[1622]: LOOP vm-test-run-plv8> server # [ 124.495555] postgres[1622]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 124.495765] postgres[1622]: 'schema' vm-test-run-plv8> server # [ 124.495968] postgres[1622]: , 'table' vm-test-run-plv8> server # [ 124.501298] postgres[1622]: , 'foreign table' vm-test-run-plv8> server # [ 124.501644] postgres[1622]: , 'view' vm-test-run-plv8> server # [ 124.501853] postgres[1622]: , 'materialized view' vm-test-run-plv8> server # [ 124.502097] postgres[1622]: , 'function' vm-test-run-plv8> server # [ 124.502455] postgres[1622]: , 'trigger' vm-test-run-plv8> server # [ 124.503662] postgres[1622]: , 'type' vm-test-run-plv8> server # [ 124.504095] postgres[1622]: , 'rule' vm-test-run-plv8> server # [ 124.508773] postgres[1622]: ) vm-test-run-plv8> server # [ 124.510788] postgres[1622]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 124.511283] postgres[1622]: THEN vm-test-run-plv8> server # [ 124.511537] postgres[1622]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 124.511750] postgres[1622]: END IF; vm-test-run-plv8> server # [ 124.511948] postgres[1622]: END LOOP; vm-test-run-plv8> server # [ 124.512133] postgres[1622]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 124.517596] postgres[1622]: ::1 2026-10-22 21:23:48.458 UTC [1622] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 124.526335] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1616]: CREATE FUNCTION vm-test-run-plv8> server # [ 124.532693] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1616]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 124.533751] postgres[1622]: ::1 2026-10-22 21:23:48.479 UTC [1622] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 124.534879] postgres[1622]: ON ddl_command_end vm-test-run-plv8> server # [ 124.535245] postgres[1622]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 124.547800] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1616]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 124.551626] postgres[1622]: ::1 2026-10-22 21:23:48.496 UTC [1622] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 124.578806] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1616]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 124.593078] postgres[1622]: ::1 2026-10-22 21:23:48.529 UTC [1622] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 124.594004] postgres[1622]: ON sql_drop vm-test-run-plv8> server # [ 124.594731] postgres[1622]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 124.604820] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1616]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 124.682610] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-plv8> server # [ 124.993975] postgres[1631]: ::1 2026-10-22 21:23:48.930 UTC [1631] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-plv8> server # [ 125.015740] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1629]: ALTER ROLE vm-test-run-plv8> server # [ 125.072666] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-plv8> server # [ 125.316044] postgres[1633]: ::1 2026-10-22 21:23:49.255 UTC [1633] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 125.322922] postgres[1633]: returns event_trigger vm-test-run-plv8> server # [ 125.323396] postgres[1633]: language plpgsql vm-test-run-plv8> server # [ 125.323805] postgres[1633]: AS $func$ vm-test-run-plv8> server # [ 125.324053] postgres[1633]: DECLARE vm-test-run-plv8> server # [ 125.327951] postgres[1633]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 125.333640] postgres[1633]: BEGIN vm-test-run-plv8> server # [ 125.334401] postgres[1633]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 125.335303] postgres[1633]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 125.335957] postgres[1633]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 125.341127] postgres[1633]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 125.341880] postgres[1633]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 125.342266] postgres[1633]: ); vm-test-run-plv8> server # [ 125.342550] postgres[1633]: vm-test-run-plv8> server # [ 125.342772] postgres[1633]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 125.343003] postgres[1633]: THEN vm-test-run-plv8> server # [ 125.343226] postgres[1633]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 125.348873] postgres[1633]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 125.350046] postgres[1633]: vm-test-run-plv8> server # [ 125.350597] postgres[1633]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 125.351044] postgres[1633]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 125.359591] postgres[1633]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 125.360116] postgres[1633]: vm-test-run-plv8> server # [ 125.361428] postgres[1633]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 125.361904] postgres[1633]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 125.362411] postgres[1633]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 125.363905] postgres[1633]: "operationName" text default null, vm-test-run-plv8> server # [ 125.365164] postgres[1633]: query text default null, vm-test-run-plv8> server # [ 125.365824] postgres[1633]: variables jsonb default null, vm-test-run-plv8> server # [ 125.366316] postgres[1633]: extensions jsonb default null vm-test-run-plv8> server # [ 125.366795] postgres[1633]: ) vm-test-run-plv8> server # [ 125.367071] postgres[1633]: returns jsonb vm-test-run-plv8> server # [ 125.367499] postgres[1633]: language sql vm-test-run-plv8> server # [ 125.367804] postgres[1633]: as $$ vm-test-run-plv8> server # [ 125.370042] postgres[1633]: -- This changed vm-test-run-plv8> server # [ 125.370740] postgres[1633]: select graphql.resolve( vm-test-run-plv8> server # [ 125.371597] postgres[1633]: query := query, vm-test-run-plv8> server # [ 125.373375] postgres[1633]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 125.373963] postgres[1633]: "operationName" := "operationName", vm-test-run-plv8> server # [ 125.374982] postgres[1633]: extensions := extensions vm-test-run-plv8> server # [ 125.375708] postgres[1633]: ); vm-test-run-plv8> server # [ 125.378051] postgres[1633]: $$; vm-test-run-plv8> server # [ 125.378496] postgres[1633]: vm-test-run-plv8> server # [ 125.379040] postgres[1633]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 125.379366] postgres[1633]: END IF; vm-test-run-plv8> server # [ 125.379580] postgres[1633]: vm-test-run-plv8> server # [ 125.379788] postgres[1633]: END; vm-test-run-plv8> server # [ 125.381277] postgres[1633]: $func$; vm-test-run-plv8> server # [ 125.478608] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1632]: CREATE FUNCTION vm-test-run-plv8> server # [ 125.496841] postgres[1633]: ::1 2026-10-22 21:23:49.416 UTC [1633] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 125.497716] postgres[1633]: RETURNS event_trigger vm-test-run-plv8> server # [ 125.498733] postgres[1633]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 125.499905] postgres[1633]: AS $func$ vm-test-run-plv8> server # [ 125.502832] postgres[1633]: DECLARE vm-test-run-plv8> server # [ 125.505797] postgres[1633]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 125.507285] postgres[1633]: BEGIN vm-test-run-plv8> server # [ 125.512924] postgres[1633]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 125.513690] postgres[1633]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 125.514481] postgres[1633]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 125.515226] postgres[1633]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 125.515599] postgres[1633]: ); vm-test-run-plv8> server # [ 125.515833] postgres[1633]: vm-test-run-plv8> server # [ 125.517072] postgres[1633]: IF graphql_is_dropped vm-test-run-plv8> server # [ 125.517380] postgres[1633]: THEN vm-test-run-plv8> server # [ 125.517728] postgres[1633]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 125.518625] postgres[1633]: "operationName" text default null, vm-test-run-plv8> server # [ 125.519236] postgres[1633]: query text default null, vm-test-run-plv8> server # [ 125.523325] postgres[1633]: variables jsonb default null, vm-test-run-plv8> server # [ 125.526951] postgres[1633]: extensions jsonb default null vm-test-run-plv8> server # [ 125.527423] postgres[1633]: ) vm-test-run-plv8> server # [ 125.528301] postgres[1633]: returns jsonb vm-test-run-plv8> server # [ 125.529704] postgres[1633]: language plpgsql vm-test-run-plv8> server # [ 125.530684] postgres[1633]: as $$ vm-test-run-plv8> server # [ 125.531016] postgres[1633]: DECLARE vm-test-run-plv8> server # [ 125.531242] postgres[1633]: server_version float; vm-test-run-plv8> server # [ 125.531655] postgres[1633]: BEGIN vm-test-run-plv8> server # [ 125.531899] postgres[1633]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 125.533677] postgres[1633]: vm-test-run-plv8> server # [ 125.534900] postgres[1633]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 125.535635] postgres[1633]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 125.536951] postgres[1633]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 125.537808] postgres[1633]: jsonb_build_object( vm-test-run-plv8> server # [ 125.538424] postgres[1633]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 125.539318] postgres[1633]: ) vm-test-run-plv8> server # [ 125.539854] postgres[1633]: ) vm-test-run-plv8> server # [ 125.541126] postgres[1633]: ); vm-test-run-plv8> server # [ 125.541444] postgres[1633]: ELSE vm-test-run-plv8> server # [ 125.542517] postgres[1633]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 125.543015] postgres[1633]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 125.543310] postgres[1633]: jsonb_build_object( vm-test-run-plv8> server # [ 125.543551] postgres[1633]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 125.544277] postgres[1633]: ) vm-test-run-plv8> server # [ 125.545053] postgres[1633]: ) vm-test-run-plv8> server # [ 125.545680] postgres[1633]: ); vm-test-run-plv8> server # [ 125.547277] postgres[1633]: END IF; vm-test-run-plv8> server # [ 125.549129] postgres[1633]: END; vm-test-run-plv8> server # [ 125.549599] postgres[1633]: $$; vm-test-run-plv8> server # [ 125.550299] postgres[1633]: END IF; vm-test-run-plv8> server # [ 125.550556] postgres[1633]: vm-test-run-plv8> server # [ 125.550780] postgres[1633]: END; vm-test-run-plv8> server # [ 125.550993] postgres[1633]: $func$; vm-test-run-plv8> server # [ 125.551393] postgres[1633]: ::1 2026-10-22 21:23:49.459 UTC [1633] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 125.553671] postgres[1633]: "operationName" text default null, vm-test-run-plv8> server # [ 125.554151] postgres[1633]: query text default null, vm-test-run-plv8> server # [ 125.554604] postgres[1633]: variables jsonb default null, vm-test-run-plv8> server # [ 125.554883] postgres[1633]: extensions jsonb default null vm-test-run-plv8> server # [ 125.555319] postgres[1633]: ) vm-test-run-plv8> server # [ 125.555564] postgres[1633]: returns jsonb vm-test-run-plv8> server # [ 125.555874] postgres[1633]: language plpgsql vm-test-run-plv8> server # [ 125.556975] postgres[1633]: as $$ vm-test-run-plv8> server # [ 125.557275] postgres[1633]: DECLARE vm-test-run-plv8> server # [ 125.557514] postgres[1633]: server_version float; vm-test-run-plv8> server # [ 125.557912] postgres[1633]: BEGIN vm-test-run-plv8> server # [ 125.558511] postgres[1633]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 125.559249] postgres[1633]: vm-test-run-plv8> server # [ 125.562571] postgres[1633]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 125.570812] postgres[1633]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 125.576998] postgres[1633]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 125.578010] postgres[1633]: jsonb_build_object( vm-test-run-plv8> server # [ 125.589713] postgres[1633]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 125.591397] postgres[1633]: ) vm-test-run-plv8> server # [ 125.602922] postgres[1633]: ) vm-test-run-plv8> server # [ 125.603630] postgres[1633]: ); vm-test-run-plv8> server # [ 125.603895] postgres[1633]: ELSE vm-test-run-plv8> server # [ 125.612841] postgres[1633]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 125.614235] postgres[1633]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 125.614620] postgres[1633]: jsonb_build_object( vm-test-run-plv8> server # [ 125.614862] postgres[1633]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 125.615572] postgres[1633]: ) vm-test-run-plv8> server # [ 125.615937] postgres[1633]: ) vm-test-run-plv8> server # [ 125.616208] postgres[1633]: ); vm-test-run-plv8> server # [ 125.621196] postgres[1633]: END IF; vm-test-run-plv8> server # [ 125.621720] postgres[1633]: END; vm-test-run-plv8> server # [ 125.624140] postgres[1633]: $$; vm-test-run-plv8> server # [ 125.635110] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1632]: CREATE FUNCTION vm-test-run-plv8> server # [ 125.635911] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1632]: CREATE FUNCTION vm-test-run-plv8> server # [ 125.639557] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1632]: 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 # [ 125.642627] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1632]: DROP EXTENSION vm-test-run-plv8> server # [ 125.651117] postgres[1633]: ::1 2026-10-22 21:23:49.529 UTC [1633] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 127.759455] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1632]: DO vm-test-run-plv8> server # [ 127.831173] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: 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 # [ 128.177078] postgres[1663]: ::1 2026-10-22 21:23:52.113 UTC [1663] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-plv8> server # [ 128.205644] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1662]: GRANT ROLE vm-test-run-plv8> server # [ 128.264879] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-plv8> server # [ 128.537120] postgres[1665]: ::1 2026-10-22 21:23:52.475 UTC [1665] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 128.538517] postgres[1665]: returns event_trigger vm-test-run-plv8> server # [ 128.538995] postgres[1665]: language plpgsql vm-test-run-plv8> server # [ 128.539265] postgres[1665]: AS $func$ vm-test-run-plv8> server # [ 128.540125] postgres[1665]: DECLARE vm-test-run-plv8> server # [ 128.542546] postgres[1665]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 128.543381] postgres[1665]: BEGIN vm-test-run-plv8> server # [ 128.543800] postgres[1665]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 128.546672] postgres[1665]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 128.548954] postgres[1665]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 128.549394] postgres[1665]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 128.549962] postgres[1665]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 128.553218] postgres[1665]: ); vm-test-run-plv8> server # [ 128.553713] postgres[1665]: vm-test-run-plv8> server # [ 128.553980] postgres[1665]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 128.554945] postgres[1665]: THEN vm-test-run-plv8> server # [ 128.555691] postgres[1665]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 128.559719] postgres[1665]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 128.560711] postgres[1665]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 128.561520] postgres[1665]: "operationName" text default null, vm-test-run-plv8> server # [ 128.561913] postgres[1665]: query text default null, vm-test-run-plv8> server # [ 128.562294] postgres[1665]: variables jsonb default null, vm-test-run-plv8> server # [ 128.563090] postgres[1665]: extensions jsonb default null vm-test-run-plv8> server # [ 128.564461] postgres[1665]: ) vm-test-run-plv8> server # [ 128.565547] postgres[1665]: returns jsonb vm-test-run-plv8> server # [ 128.565920] postgres[1665]: language sql vm-test-run-plv8> server # [ 128.566308] postgres[1665]: as $$ vm-test-run-plv8> server # [ 128.566559] postgres[1665]: select graphql.resolve( vm-test-run-plv8> server # [ 128.566819] postgres[1665]: query := query, vm-test-run-plv8> server # [ 128.567046] postgres[1665]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 128.568980] postgres[1665]: "operationName" := "operationName", vm-test-run-plv8> server # [ 128.569472] postgres[1665]: extensions := extensions vm-test-run-plv8> server # [ 128.570254] postgres[1665]: ); vm-test-run-plv8> server # [ 128.570567] postgres[1665]: $$; vm-test-run-plv8> server # [ 128.571322] postgres[1665]: vm-test-run-plv8> server # [ 128.571726] postgres[1665]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 128.572816] postgres[1665]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 128.573235] postgres[1665]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 128.573579] postgres[1665]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 128.574730] postgres[1665]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 128.575348] postgres[1665]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 128.575727] postgres[1665]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 128.577619] postgres[1665]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 128.578525] postgres[1665]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 128.579125] postgres[1665]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 128.579547] postgres[1665]: END IF; vm-test-run-plv8> server # [ 128.579823] postgres[1665]: vm-test-run-plv8> server # [ 128.580049] postgres[1665]: END; vm-test-run-plv8> server # [ 128.580846] postgres[1665]: $func$; vm-test-run-plv8> server # [ 128.626800] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1664]: CREATE FUNCTION vm-test-run-plv8> server # [ 128.627841] postgres[1665]: ::1 2026-10-22 21:23:52.568 UTC [1665] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 128.680116] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1664]: DROP EXTENSION vm-test-run-plv8> server # [ 130.859433] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1664]: DO vm-test-run-plv8> server # [ 130.918416] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-plv8> server # [ 131.890197] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1690]: DO vm-test-run-plv8> server # [ 132.617285] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1690]: DO vm-test-run-plv8> server # [ 132.675822] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-plv8> server # [ 133.046719] postgres[1699]: ::1 2026-10-22 21:23:56.980 UTC [1699] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-plv8> server # [ 133.067242] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1696]: ALTER ROLE vm-test-run-plv8> server # [ 133.102397] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-plv8> server # [ 133.627452] postgres[1710]: ::1 2026-10-22 21:23:57.568 UTC [1710] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-plv8> server # [ 133.659214] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1704]: REVOKE ROLE vm-test-run-plv8> server # [ 133.727017] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-plv8> server # [ 136.693939] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1717]: DO vm-test-run-plv8> server # [ 136.732177] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-plv8> server # [ 137.141288] postgres[1751]: ::1 2026-10-22 21:24:01.076 UTC [1751] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-plv8> server # [ 137.159393] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1747]: GRANT ROLE vm-test-run-plv8> server # [ 137.193448] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-plv8> server # [ 137.451727] postgres[1753]: ::1 2026-10-22 21:24:01.385 UTC [1753] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 137.480333] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1752]: GRANT vm-test-run-plv8> server # [ 137.485106] postgres[1753]: ::1 2026-10-22 21:24:01.424 UTC [1753] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 137.515806] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1752]: GRANT vm-test-run-plv8> server # [ 137.532020] postgres[1753]: ::1 2026-10-22 21:24:01.466 UTC [1753] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 137.535188] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1752]: GRANT vm-test-run-plv8> server # [ 137.547219] postgres[1753]: ::1 2026-10-22 21:24:01.491 UTC [1753] 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 # [ 137.567921] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1752]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 137.572494] postgres[1753]: ::1 2026-10-22 21:24:01.518 UTC [1753] 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 # [ 137.597157] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1752]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 137.599248] postgres[1753]: ::1 2026-10-22 21:24:01.539 UTC [1753] 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 # [ 137.611619] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1752]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 137.669421] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-plv8> server # [ 138.036402] postgres[1759]: ::1 2026-10-22 21:24:01.980 UTC [1759] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-plv8> server # [ 138.083541] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1757]: GRANT ROLE vm-test-run-plv8> server # [ 138.144969] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 138.422541] postgres[1761]: ::1 2026-10-22 21:24:02.361 UTC [1761] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-plv8> server # [ 138.434348] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1760]: GRANT ROLE vm-test-run-plv8> server # [ 138.477330] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-plv8> server # [ 138.728203] postgres[1763]: ::1 2026-10-22 21:24:02.668 UTC [1763] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-plv8> server # [ 138.747714] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1762]: ALTER ROLE vm-test-run-plv8> server # [ 138.749108] postgres[1763]: ::1 2026-10-22 21:24:02.685 UTC [1763] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-plv8> server # [ 138.751716] postgres[1763]: ::1 2026-10-22 21:24:02.697 UTC [1763] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-plv8> server # [ 138.753266] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1762]: ALTER ROLE vm-test-run-plv8> server # [ 138.770255] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1762]: ALTER ROLE vm-test-run-plv8> server # [ 138.804041] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1762]: DO vm-test-run-plv8> server # [ 138.835383] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 139.145841] postgres[1765]: ::1 2026-10-22 21:24:03.063 UTC [1765] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-plv8> server # [ 139.148776] postgres[1765]: ::1 2026-10-22 21:24:03.085 UTC [1765] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-plv8> server # [ 139.167661] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1764]: GRANT ROLE vm-test-run-plv8> server # [ 139.194141] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1764]: REVOKE ROLE vm-test-run-plv8> server # [ 139.235260] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-plv8> server # [ 139.721614] postgres[1779]: ::1 2026-10-22 21:24:03.645 UTC [1779] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 139.729202] postgres[1779]: returns event_trigger vm-test-run-plv8> server # [ 139.730775] postgres[1779]: language plpgsql vm-test-run-plv8> server # [ 139.732191] postgres[1779]: AS $func$ vm-test-run-plv8> server # [ 139.737306] postgres[1779]: DECLARE vm-test-run-plv8> server # [ 139.737925] postgres[1779]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 139.747220] postgres[1779]: BEGIN vm-test-run-plv8> server # [ 139.755805] postgres[1779]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 139.769687] postgres[1779]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 139.771762] postgres[1779]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 139.779803] postgres[1779]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 139.789550] postgres[1779]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 139.797722] postgres[1779]: ); vm-test-run-plv8> server # [ 139.800022] postgres[1779]: vm-test-run-plv8> server # [ 139.804939] postgres[1779]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 139.806280] postgres[1779]: THEN vm-test-run-plv8> server # [ 139.806992] postgres[1779]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 139.813986] postgres[1779]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 139.816066] postgres[1779]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 139.823433] postgres[1779]: "operationName" text default null, vm-test-run-plv8> server # [ 139.832896] postgres[1779]: query text default null, vm-test-run-plv8> server # [ 139.835205] postgres[1779]: variables jsonb default null, vm-test-run-plv8> server # [ 139.835744] postgres[1779]: extensions jsonb default null vm-test-run-plv8> server # [ 139.836043] postgres[1779]: ) vm-test-run-plv8> server # [ 139.845667] postgres[1779]: returns jsonb vm-test-run-plv8> server # [ 139.846404] postgres[1779]: language sql vm-test-run-plv8> server # [ 139.847242] postgres[1779]: as $$ vm-test-run-plv8> server # [ 139.847933] postgres[1779]: select graphql.resolve( vm-test-run-plv8> server # [ 139.858269] postgres[1779]: query := query, vm-test-run-plv8> server # [ 139.859962] postgres[1779]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 139.867540] postgres[1779]: "operationName" := "operationName", vm-test-run-plv8> server # [ 139.873750] postgres[1779]: extensions := extensions vm-test-run-plv8> server # [ 139.875396] postgres[1779]: ); vm-test-run-plv8> server # [ 139.882432] postgres[1779]: $$; vm-test-run-plv8> server # [ 139.883175] postgres[1779]: vm-test-run-plv8> server # [ 139.883517] postgres[1779]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 139.883830] postgres[1779]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 139.889760] postgres[1779]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 139.891784] postgres[1779]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 139.897659] postgres[1779]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 139.898788] postgres[1779]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 139.899386] postgres[1779]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 139.900221] postgres[1779]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 139.914595] postgres[1779]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 139.920896] postgres[1779]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 139.922361] postgres[1779]: vm-test-run-plv8> server # [ 139.932374] postgres[1779]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-plv8> server # [ 139.934796] postgres[1779]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-plv8> server # [ 139.935881] postgres[1779]: grant usage on schema graphql to postgres with grant option; vm-test-run-plv8> server # [ 139.945531] postgres[1779]: END IF; vm-test-run-plv8> server # [ 139.945946] postgres[1779]: vm-test-run-plv8> server # [ 139.955482] postgres[1779]: END; vm-test-run-plv8> server # [ 139.955972] postgres[1779]: $func$; vm-test-run-plv8> server # [ 139.956414] postgres[1779]: ::1 2026-10-22 21:24:03.852 UTC [1779] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 140.029316] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1770]: CREATE FUNCTION vm-test-run-plv8> server # [ 140.031675] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1770]: DROP EXTENSION vm-test-run-plv8> server # [ 141.805665] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1770]: DO vm-test-run-plv8> server # [ 141.874283] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-plv8> server # [ 142.223229] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1796]: DO vm-test-run-plv8> server # [ 142.288557] postgres[1797]: ::1 2026-10-22 21:24:06.185 UTC [1797] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-plv8> server # [ 142.290380] postgres[1797]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 142.308804] postgres[1797]: AS $$ vm-test-run-plv8> server # [ 142.310331] postgres[1797]: BEGIN vm-test-run-plv8> server # [ 142.310765] postgres[1797]: IF EXISTS ( vm-test-run-plv8> server # [ 142.311289] postgres[1797]: SELECT vm-test-run-plv8> server # [ 142.311735] postgres[1797]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 142.312011] postgres[1797]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 142.329362] postgres[1797]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 142.329781] postgres[1797]: WHERE ext.extname = 'pg_cron' vm-test-run-plv8> server # [ 142.330038] postgres[1797]: ) vm-test-run-plv8> server # [ 142.330780] postgres[1797]: THEN vm-test-run-plv8> server # [ 142.331070] postgres[1797]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 142.331343] postgres[1797]: vm-test-run-plv8> server # [ 142.331701] postgres[1797]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 142.332565] postgres[1797]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 142.337486] postgres[1797]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 142.339620] postgres[1797]: vm-test-run-plv8> server # [ 142.339971] postgres[1797]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 142.340249] postgres[1797]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 142.340479] postgres[1797]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 142.340723] postgres[1797]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 142.340951] postgres[1797]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 142.341203] postgres[1797]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 142.341590] postgres[1797]: vm-test-run-plv8> server # [ 142.341855] postgres[1797]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 142.342378] postgres[1797]: revoke all on table cron.job from postgres; vm-test-run-plv8> server # [ 142.349423] postgres[1797]: grant select on table cron.job to postgres with grant option; vm-test-run-plv8> server # [ 142.350532] postgres[1797]: END IF; vm-test-run-plv8> server # [ 142.351846] postgres[1797]: END; vm-test-run-plv8> server # [ 142.362948] postgres[1797]: $$; vm-test-run-plv8> server # [ 142.379355] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1796]: CREATE FUNCTION vm-test-run-plv8> server # [ 142.385900] postgres[1797]: ::1 2026-10-22 21:24:06.327 UTC [1797] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-plv8> server # [ 142.417714] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1796]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 142.419226] postgres[1797]: ::1 2026-10-22 21:24:06.365 UTC [1797] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-plv8> server # [ 142.445046] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1796]: ALTER FUNCTION vm-test-run-plv8> server # [ 142.446128] postgres[1797]: ::1 2026-10-22 21:24:06.392 UTC [1797] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-plv8> server # [ 142.446775] postgres[1797]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-plv8> server # [ 142.447647] postgres[1797]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 142.468147] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1796]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 142.513948] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-plv8> server # [ 142.948137] postgres[1808]: ::1 2026-10-22 21:24:06.873 UTC [1808] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-plv8> server # [ 142.981792] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1803]: ALTER ROLE vm-test-run-plv8> server # [ 143.006668] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-plv8> server # [ 143.431958] postgres[1818]: ::1 2026-10-22 21:24:07.368 UTC [1818] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-plv8> server # [ 143.491768] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1813]: ALTER FUNCTION vm-test-run-plv8> server # [ 143.503033] postgres[1818]: ::1 2026-10-22 21:24:07.435 UTC [1818] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-plv8> server # [ 143.503778] postgres[1818]: ::1 2026-10-22 21:24:07.443 UTC [1818] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-plv8> server # [ 143.512152] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1813]: ALTER FUNCTION vm-test-run-plv8> server # [ 143.518771] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1813]: ALTER FUNCTION vm-test-run-plv8> server # [ 143.557694] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-plv8> server # [ 143.912211] postgres[1827]: ::1 2026-10-22 21:24:07.847 UTC [1827] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-plv8> server # [ 143.943575] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1825]: GRANT ROLE vm-test-run-plv8> server # [ 143.958428] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-plv8> server # [ 145.036729] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1828]: DO vm-test-run-plv8> server # [ 145.086995] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-plv8> server # [ 145.399154] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1830]: DO vm-test-run-plv8> server # [ 145.402527] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1830]: DO vm-test-run-plv8> server # [ 145.450028] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-plv8> server # [ 145.930931] postgres[1841]: ::1 2026-10-22 21:24:09.865 UTC [1841] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-plv8> server # [ 145.976388] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1834]: ALTER ROLE vm-test-run-plv8> server # [ 145.983279] postgres[1841]: ::1 2026-10-22 21:24:09.895 UTC [1841] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-plv8> server # [ 145.993441] postgres[1841]: ::1 2026-10-22 21:24:09.917 UTC [1841] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-plv8> server # [ 145.997133] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1834]: ALTER ROLE vm-test-run-plv8> server # [ 145.998211] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1834]: ALTER ROLE vm-test-run-plv8> server # [ 146.074448] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-plv8> server # [ 146.633858] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1845]: DO vm-test-run-plv8> server # [ 146.702751] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-plv8> server # [ 147.191306] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1855]: DO vm-test-run-plv8> server # [ 147.230843] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-plv8> server # [ 147.663551] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1862]: CREATE FUNCTION vm-test-run-plv8> server # [ 147.683878] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1862]: DO vm-test-run-plv8> server # [ 147.760017] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-plv8> server # [ 148.176414] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1868]: ALTER FUNCTION vm-test-run-plv8> server # [ 148.194213] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1868]: GRANT vm-test-run-plv8> server # [ 148.213402] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-plv8> server # [ 148.511059] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1870]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 148.543828] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1870]: ALTER FUNCTION vm-test-run-plv8> server # [ 148.557564] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1870]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 148.594259] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 148.942335] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1872]: DO vm-test-run-plv8> server # [ 148.998647] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-plv8> server # [ 149.562185] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1878]: CREATE FUNCTION vm-test-run-plv8> server # [ 149.569661] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1878]: GRANT vm-test-run-plv8> server # [ 149.626396] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-plv8> server # [ 150.209409] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1892]: REVOKE ROLE vm-test-run-plv8> server # [ 150.261845] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1892]: DO vm-test-run-plv8> server # [ 150.310746] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1892]: DO vm-test-run-plv8> server # [ 150.325335] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1892]: REVOKE ROLE vm-test-run-plv8> server # [ 150.346714] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1892]: REVOKE vm-test-run-plv8> server # [ 150.405367] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1892]: DO vm-test-run-plv8> server # [ 150.481489] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 150.814639] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1902]: DO vm-test-run-plv8> server # [ 150.837584] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 151.116028] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1904]: DO vm-test-run-plv8> server # [ 151.159820] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 151.500169] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1906]: DO vm-test-run-plv8> server # [ 151.565455] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-plv8> server # [ 151.951582] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1911]: ALTER ROLE vm-test-run-plv8> server # [ 151.994812] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-plv8> server # [ 152.493542] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1914]: GRANT ROLE vm-test-run-plv8> server # [ 152.511574] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1914]: DO vm-test-run-plv8> server # [ 152.608024] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-plv8> server # [ 153.102016] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1923]: GRANT vm-test-run-plv8> server # [ 153.146738] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-plv8> server # [ 153.725403] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1936]: CREATE FUNCTION vm-test-run-plv8> server # [ 153.728799] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1936]: REVOKE vm-test-run-plv8> server # [ 153.737122] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1936]: REVOKE vm-test-run-plv8> server # [ 153.753173] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1936]: GRANT vm-test-run-plv8> server # [ 153.806300] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-plv8> server # [ 154.259339] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1944]: DO vm-test-run-plv8> server # [ 154.278651] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-plv8> server # [ 154.562854] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1946]: ALTER ROLE vm-test-run-plv8> server # [ 154.605054] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-plv8> server # [ 154.954362] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1948]: DROP EXTENSION vm-test-run-plv8> server # [ 154.982498] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-plv8> server # [ 155.449121] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1950]: CREATE FUNCTION vm-test-run-plv8> server # [ 155.467384] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1950]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 155.487416] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1950]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 155.536736] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-plv8> server # [ 156.007197] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1959]: DO vm-test-run-plv8> server # [ 156.050357] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1959]: CREATE FUNCTION vm-test-run-plv8> server # [ 156.145618] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-plv8> server # [ 156.641642] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1967]: CREATE FUNCTION vm-test-run-plv8> server # [ 156.657500] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1967]: CREATE FUNCTION vm-test-run-plv8> server # [ 156.702499] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql vm-test-run-plv8> server # [ 157.128101] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1978]: CREATE FUNCTION vm-test-run-plv8> server # [ 157.146556] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1978]: CREATE FUNCTION vm-test-run-plv8> server # [ 157.173174] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1978]: CREATE FUNCTION vm-test-run-plv8> server # [ 157.221986] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1978]: CREATE FUNCTION vm-test-run-plv8> server # [ 157.237410] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1978]: CREATE FUNCTION vm-test-run-plv8> server # [ 157.266767] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1978]: CREATE FUNCTION vm-test-run-plv8> server # [ 157.332769] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Running postgresql schema... vm-test-run-plv8> server # [ 157.768131] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER DATABASE vm-test-run-plv8> server # [ 157.774472] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER DATABASE vm-test-run-plv8> server # [ 157.868894] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER ROLE vm-test-run-plv8> server # [ 157.941836] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER ROLE vm-test-run-plv8> server # [ 158.018522] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER ROLE vm-test-run-plv8> server # [ 158.070322] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER ROLE vm-test-run-plv8> server # [ 158.126355] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER ROLE vm-test-run-plv8> server # [ 158.193069] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER ROLE vm-test-run-plv8> server # [ 158.246674] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER ROLE vm-test-run-plv8> server # [ 158.297467] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER ROLE vm-test-run-plv8> server # [ 158.349328] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER ROLE vm-test-run-plv8> server # [ 158.360262] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1985]: ALTER ROLE vm-test-run-plv8> server # [ 158.423871] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1412]: Database initialization complete vm-test-run-plv8> server # [ 158.463917] systemd[1]: Finished Supabase Database Initialization. vm-test-run-plv8> server # [ 158.471541] systemd[1]: Reached target Multi-User System. vm-test-run-plv8> server # [ 158.485947] systemd[1]: Startup finished in 14.932s (kernel) + 2min 23.533s (userspace) = 2min 38.465s. vm-test-run-plv8> server: (finished: waiting for unit supabase-db-init.service, in 160.77 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.60 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.4' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.4' CASCADE;" , in 7.22 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.94 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.76 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.5' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.5' CASCADE;" , in 7.06 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.72 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.84 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 7.35 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.51 seconds) vm-test-run-plv8> (finished: subtest: Check upgrade path with postgresql 15, in 26.02 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.66 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 # [ 187.976597] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 2.09 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.60 seconds) vm-test-run-plv8> (finished: subtest: Check the install of the last version of the extension, in 3.35 seconds) vm-test-run-plv8> (finished: run the VM test script, in 190.28 seconds) vm-test-run-plv8> test script finished in 190.76s vm-test-run-plv8> cleanup vm-test-run-plv8> kill machine (pid 9) vm-test-run-plv8> qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13) vm-test-run-plv8> vde_switch: EOF data port: Interrupted system call vm-test-run-plv8> kill vlan (pid 7) vm-test-run-plv8> (finished: cleanup, in 0.00 seconds) vm-test-run-plv8> vde_switch: Caught signal 15, cleaning up and exiting