this derivation will be built: /nix/store/6w9sjb34i37rlczq5g5kxnh51gnncmrl-vm-test-run-plv8.drv these 5 paths will be fetched (69.2 KiB download, 336.4 KiB unpacked): /nix/store/0skrgdc9ny3rsk84wkz2dn7r101cj40f-closure-info /nix/store/57wyk95526zmwjf4dpbdjwwl6h316abm-nixos-system-server-test /nix/store/kwagx5xvjw626prglqmzc6djnlf8l0i1-nixos-test-driver-plv8 /nix/store/qvxvqy1ygn1ar19v28csbkzzcwjz8ws3-nixos-vm /nix/store/d314x74k2j5ksihma1yqbscv0qkm4rrj-run-nixos-vm building '/nix/store/6w9sjb34i37rlczq5g5kxnh51gnncmrl-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> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-plv8> server: QEMU running (pid 9) vm-test-run-plv8> server # Formatting '/build/vm-state-server/tmp.G3mPvMZwRg', fmt=raw size=1073741824 vm-test-run-plv8> server # Discarding device blocks: 0/262144 done vm-test-run-plv8> server # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-plv8> server # Filesystem UUID: 1cbdca73-88a4-4149-9703-9c0563995e37 vm-test-run-plv8> server # Superblock backups stored on blocks: vm-test-run-plv8> server # 32768, 98304, 163840, 229376 vm-test-run-plv8> server # vm-test-run-plv8> server # Allocating group tables: 0/8 done vm-test-run-plv8> server # Writing inode tables: 0/8 done vm-test-run-plv8> server # Creating journal (8192 blocks): done vm-test-run-plv8> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-plv8> server # vm-test-run-plv8> server # Virtualisation disk image created. vm-test-run-plv8> (finished: start all VMs, in 0.12 seconds) vm-test-run-plv8> server: waiting for unit supabase-db-init.service vm-test-run-plv8> server: waiting for the VM to finish booting vm-test-run-plv8> server # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) vm-test-run-plv8> server # vm-test-run-plv8> server # vm-test-run-plv8> server # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+BEFD1920+BEF31920 CA00 vm-test-run-plv8> server # Press Ctrl-B to configure iPXE (PCI 00:03.0)... vm-test-run-plv8> server # vm-test-run-plv8> server # vm-test-run-plv8> server # vm-test-run-plv8> server # vm-test-run-plv8> server # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM BEFD1920 BEF31920 CB00 vm-test-run-plv8> server # Press Ctrl-B to configure iPXE (PCI 00:09.0)... vm-test-run-plv8> server # vm-test-run-plv8> server # vm-test-run-plv8> server # Booting from ROM... vm-test-run-plv8> server # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.12.63 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP PREEMPT_DYNAMIC Thu Dec 18 12:55:23 UTC 2025 vm-test-run-plv8> server # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/57wyk95526zmwjf4dpbdjwwl6h316abm-nixos-system-server-test/init regInfo=/nix/store/0skrgdc9ny3rsk84wkz2dn7r101cj40f-closure-info/registration console=ttyS0,115200n8 console=tty0 vm-test-run-plv8> server # [ 0.000000] BIOS-provided physical RAM map: vm-test-run-plv8> server # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable vm-test-run-plv8> server # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved vm-test-run-plv8> server # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved vm-test-run-plv8> server # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdafff] usable vm-test-run-plv8> server # [ 0.000000] BIOS-e820: [mem 0x00000000bffdb000-0x00000000bfffffff] reserved vm-test-run-plv8> server # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved vm-test-run-plv8> server # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved vm-test-run-plv8> server # [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable vm-test-run-plv8> server # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved vm-test-run-plv8> server # [ 0.000000] NX (Execute Disable) protection: active vm-test-run-plv8> server # [ 0.000000] APIC: Static calls initialized vm-test-run-plv8> server # [ 0.000000] SMBIOS 2.8 present. vm-test-run-plv8> server # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 vm-test-run-plv8> server # [ 0.000000] DMI: Memory slots populated: 1/1 vm-test-run-plv8> server # [ 0.000000] Hypervisor detected: KVM vm-test-run-plv8> server # [ 0.000000] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 vm-test-run-plv8> server # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 vm-test-run-plv8> server # [ 0.000000] kvm-clock: using sched offset of 324805139 cycles vm-test-run-plv8> server # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-plv8> server # [ 0.000003] tsc: Detected 2994.372 MHz processor vm-test-run-plv8> server # [ 0.000875] last_pfn = 0x140000 max_arch_pfn = 0x400000000 vm-test-run-plv8> server # [ 0.000904] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs vm-test-run-plv8> server # [ 0.000906] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT vm-test-run-plv8> server # [ 0.000945] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 vm-test-run-plv8> server # [ 0.002799] found SMP MP-table at [mem 0x000f5470-0x000f547f] vm-test-run-plv8> server # [ 0.002809] Using GB pages for direct mapping vm-test-run-plv8> server # [ 0.003091] RAMDISK: [mem 0xbf3be000-0xbffcffff] vm-test-run-plv8> server # [ 0.003096] ACPI: Early table checksum verification disabled vm-test-run-plv8> server # [ 0.003098] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) vm-test-run-plv8> server # [ 0.003102] ACPI: RSDT 0x00000000BFFE2434 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.003106] ACPI: FACP 0x00000000BFFE22E0 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.003109] ACPI: DSDT 0x00000000BFFE0040 0022A0 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.003111] ACPI: FACS 0x00000000BFFE0000 000040 vm-test-run-plv8> server # [ 0.003113] ACPI: APIC 0x00000000BFFE2354 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.003114] ACPI: HPET 0x00000000BFFE23D4 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.003116] ACPI: WAET 0x00000000BFFE240C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.003118] ACPI: Reserving FACP table memory at [mem 0xbffe22e0-0xbffe2353] vm-test-run-plv8> server # [ 0.003119] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22df] vm-test-run-plv8> server # [ 0.003119] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] vm-test-run-plv8> server # [ 0.003120] ACPI: Reserving APIC table memory at [mem 0xbffe2354-0xbffe23d3] vm-test-run-plv8> server # [ 0.003121] ACPI: Reserving HPET table memory at [mem 0xbffe23d4-0xbffe240b] vm-test-run-plv8> server # [ 0.003121] ACPI: Reserving WAET table memory at [mem 0xbffe240c-0xbffe2433] vm-test-run-plv8> server # [ 0.003340] No NUMA configuration found vm-test-run-plv8> server # [ 0.003341] Faking a node at [mem 0x0000000000000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.003343] NODE_DATA(0) allocated [mem 0x13fff88c0-0x13fffddff] vm-test-run-plv8> server # [ 0.003358] Zone ranges: vm-test-run-plv8> server # [ 0.003359] DMA [mem 0x0000000000001000-0x0000000000ffffff] vm-test-run-plv8> server # [ 0.003360] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] vm-test-run-plv8> server # [ 0.003361] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.003362] Device empty vm-test-run-plv8> server # [ 0.003363] Movable zone start for each node vm-test-run-plv8> server # [ 0.003363] Early memory node ranges vm-test-run-plv8> server # [ 0.003363] node 0: [mem 0x0000000000001000-0x000000000009efff] vm-test-run-plv8> server # [ 0.003364] node 0: [mem 0x0000000000100000-0x00000000bffdafff] vm-test-run-plv8> server # [ 0.003365] node 0: [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.003366] Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.003470] On node 0, zone DMA: 1 pages in unavailable ranges vm-test-run-plv8> server # [ 0.003484] On node 0, zone DMA: 97 pages in unavailable ranges vm-test-run-plv8> server # [ 0.009945] On node 0, zone Normal: 37 pages in unavailable ranges vm-test-run-plv8> server # [ 0.010389] ACPI: PM-Timer IO Port: 0x608 vm-test-run-plv8> server # [ 0.010399] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) vm-test-run-plv8> server # [ 0.010425] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 vm-test-run-plv8> server # [ 0.010427] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) vm-test-run-plv8> server # [ 0.010429] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) vm-test-run-plv8> server # [ 0.010430] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) vm-test-run-plv8> server # [ 0.010431] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) vm-test-run-plv8> server # [ 0.010432] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) vm-test-run-plv8> server # [ 0.010434] ACPI: Using ACPI (MADT) for SMP configuration information vm-test-run-plv8> server # [ 0.010435] ACPI: HPET id: 0x8086a201 base: 0xfed00000 vm-test-run-plv8> server # [ 0.010440] TSC deadline timer available vm-test-run-plv8> server # [ 0.010444] CPU topo: Max. logical packages: 1 vm-test-run-plv8> server # [ 0.010444] CPU topo: Max. logical dies: 1 vm-test-run-plv8> server # [ 0.010445] CPU topo: Max. dies per package: 1 vm-test-run-plv8> server # [ 0.010449] CPU topo: Max. threads per core: 1 vm-test-run-plv8> server # [ 0.010449] CPU topo: Num. cores per package: 2 vm-test-run-plv8> server # [ 0.010450] CPU topo: Num. threads per package: 2 vm-test-run-plv8> server # [ 0.010450] CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs vm-test-run-plv8> server # [ 0.010466] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() vm-test-run-plv8> server # [ 0.010478] kvm-guest: KVM setup pv remote TLB flush vm-test-run-plv8> server # [ 0.010481] kvm-guest: setup PV sched yield vm-test-run-plv8> server # [ 0.010488] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.010489] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] vm-test-run-plv8> server # [ 0.010490] PM: hibernation: Registered nosave memory: [mem 0xbffdb000-0xffffffff] vm-test-run-plv8> server # [ 0.010491] [mem 0xc0000000-0xfeffbfff] available for PCI devices vm-test-run-plv8> server # [ 0.010492] Booting paravirtualized kernel on KVM vm-test-run-plv8> server # [ 0.010495] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns vm-test-run-plv8> server # [ 0.014843] setup_percpu: NR_CPUS:384 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 vm-test-run-plv8> server # [ 0.015045] percpu: Embedded 116 pages/cpu s294912 r65536 d114688 u1048576 vm-test-run-plv8> server # [ 0.015079] kvm-guest: PV spinlocks enabled vm-test-run-plv8> server # [ 0.015080] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) vm-test-run-plv8> server # [ 0.015083] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/57wyk95526zmwjf4dpbdjwwl6h316abm-nixos-system-server-test/init regInfo=/nix/store/0skrgdc9ny3rsk84wkz2dn7r101cj40f-closure-info/registration console=ttyS0,115200n8 console=tty0 vm-test-run-plv8> server # [ 0.015167] Unknown kernel command line parameters "regInfo=/nix/store/0skrgdc9ny3rsk84wkz2dn7r101cj40f-closure-info/registration", will be passed to user space. vm-test-run-plv8> server # [ 0.015185] random: crng init done vm-test-run-plv8> server # [ 0.015529] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-plv8> server # [ 0.015709] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-plv8> server # [ 0.015730] Fallback order for Node 0: 0 vm-test-run-plv8> server # [ 0.015733] Built 1 zonelists, mobility grouping on. Total pages: 1048441 vm-test-run-plv8> server # [ 0.015734] Policy zone: Normal vm-test-run-plv8> server # [ 0.015913] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-plv8> server # [ 0.015917] software IO TLB: area num 2. vm-test-run-plv8> server # [ 0.030743] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm-test-run-plv8> server # [ 0.031414] allocated 8388608 bytes of page_ext vm-test-run-plv8> server # [ 0.031431] ftrace: allocating 46234 entries in 181 pages vm-test-run-plv8> server # [ 0.041619] ftrace: allocated 181 pages with 5 groups vm-test-run-plv8> server # [ 0.042495] Dynamic Preempt: voluntary vm-test-run-plv8> server # [ 0.042693] rcu: Preemptible hierarchical RCU implementation. vm-test-run-plv8> server # [ 0.042695] rcu: RCU event tracing is enabled. vm-test-run-plv8> server # [ 0.042695] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. vm-test-run-plv8> server # [ 0.042697] Trampoline variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.042698] Rude variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.042698] Tracing variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.042699] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. vm-test-run-plv8> server # [ 0.042700] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm-test-run-plv8> server # [ 0.042710] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-plv8> server # [ 0.042712] 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.042714] 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.047430] NR_IRQS: 24832, nr_irqs: 440, preallocated irqs: 16 vm-test-run-plv8> server # [ 0.047619] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-plv8> server # [ 0.047725] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-plv8> server # [ 0.051397] Console: colour VGA+ 80x25 vm-test-run-plv8> server # [ 0.051400] printk: legacy console [tty0] enabled vm-test-run-plv8> server # [ 0.083555] printk: legacy console [ttyS0] enabled vm-test-run-plv8> server # [ 0.176276] ACPI: Core revision 20240827 vm-test-run-plv8> server # [ 0.177024] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns vm-test-run-plv8> server # [ 0.178623] APIC: Switch to symmetric I/O mode setup vm-test-run-plv8> server # [ 0.179540] x2apic enabled vm-test-run-plv8> server # [ 0.180355] APIC: Switched APIC routing to: physical x2apic vm-test-run-plv8> server # [ 0.181259] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() vm-test-run-plv8> server # [ 0.182442] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() vm-test-run-plv8> server # [ 0.183963] kvm-guest: setup PV IPIs vm-test-run-plv8> server # [ 0.185502] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 vm-test-run-plv8> server # [ 0.186567] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2b29812ce43, max_idle_ns: 440795323173 ns vm-test-run-plv8> server # [ 0.188110] Calibrating delay loop (skipped) preset value.. 5988.74 BogoMIPS (lpj=2994372) vm-test-run-plv8> server # [ 0.189215] x86/cpu: User Mode Instruction Prevention (UMIP) activated vm-test-run-plv8> server # [ 0.191005] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 vm-test-run-plv8> server # [ 0.191107] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 vm-test-run-plv8> server # [ 0.191113] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization vm-test-run-plv8> server # [ 0.192110] Spectre V2 : Mitigation: Retpolines vm-test-run-plv8> server # [ 0.194109] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT vm-test-run-plv8> server # [ 0.196109] Spectre V2 : Enabling Restricted Speculation for firmware calls vm-test-run-plv8> server # [ 0.197111] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier vm-test-run-plv8> server # [ 0.198111] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl vm-test-run-plv8> server # [ 0.199110] Speculative Return Stack Overflow: IBPB-extending microcode not applied! vm-test-run-plv8> server # [ 0.200110] Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. vm-test-run-plv8> server # [ 0.200111] active return thunk: srso_alias_return_thunk vm-test-run-plv8> server # [ 0.203118] Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode vm-test-run-plv8> server # [ 0.204110] Transient Scheduler Attacks: Forcing mitigation on in a VM vm-test-run-plv8> server # [ 0.206110] Transient Scheduler Attacks: Vulnerable: Clear CPU buffers attempted, no microcode vm-test-run-plv8> server # [ 0.207131] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' vm-test-run-plv8> server # [ 0.209110] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' vm-test-run-plv8> server # [ 0.210110] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' vm-test-run-plv8> server # [ 0.211110] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' vm-test-run-plv8> server # [ 0.213110] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 vm-test-run-plv8> server # [ 0.214110] x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8 vm-test-run-plv8> server # [ 0.216110] x86/fpu: Enabled xstate features 0x207, context size is 840 bytes, using 'compacted' format. vm-test-run-plv8> server # [ 0.245138] Freeing SMP alternatives memory: 40K vm-test-run-plv8> server # [ 0.246060] pid_max: default: 32768 minimum: 301 vm-test-run-plv8> server # [ 0.246670] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-plv8> server # [ 0.248116] landlock: Up and running. vm-test-run-plv8> server # [ 0.248818] Yama: becoming mindful. vm-test-run-plv8> server # [ 0.249405] LSM support for eBPF active vm-test-run-plv8> server # [ 0.250693] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.252115] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.254530] smpboot: CPU0: AMD EPYC 7313P 16-Core Processor (family: 0x19, model: 0x1, stepping: 0x1) vm-test-run-plv8> server # [ 0.255649] Performance Events: Fam17h+ core perfctr, AMD PMU driver. vm-test-run-plv8> server # [ 0.256115] ... version: 0 vm-test-run-plv8> server # [ 0.256934] ... bit width: 48 vm-test-run-plv8> server # [ 0.257682] ... generic registers: 6 vm-test-run-plv8> server # [ 0.258113] ... value mask: 0000ffffffffffff vm-test-run-plv8> server # [ 0.259112] ... max period: 00007fffffffffff vm-test-run-plv8> server # [ 0.260113] ... fixed-purpose events: 0 vm-test-run-plv8> server # [ 0.260951] ... event mask: 000000000000003f vm-test-run-plv8> server # [ 0.262020] signal: max sigframe size: 3376 vm-test-run-plv8> server # [ 0.262741] rcu: Hierarchical SRCU implementation. vm-test-run-plv8> server # [ 0.263113] rcu: Max phase no-delay instances is 400. vm-test-run-plv8> server # [ 0.264205] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-plv8> server # [ 0.269897] smp: Bringing up secondary CPUs ... vm-test-run-plv8> server # [ 0.270987] smpboot: x86: Booting SMP configuration: vm-test-run-plv8> server # [ 0.271873] .... node #0, CPUs: #1 vm-test-run-plv8> server # [ 0.272198] smp: Brought up 1 node, 2 CPUs vm-test-run-plv8> server # [ 0.274022] smpboot: Total of 2 processors activated (11977.48 BogoMIPS) vm-test-run-plv8> server # [ 0.275196] Memory: 3979896K/4193764K available (16384K kernel code, 2651K rwdata, 12576K rodata, 3420K init, 3592K bss, 199444K reserved, 0K cma-reserved) vm-test-run-plv8> server # [ 0.276250] devtmpfs: initialized vm-test-run-plv8> server # [ 0.277217] x86/mm: Memory block size: 128MB vm-test-run-plv8> server # [ 0.279287] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns vm-test-run-plv8> server # [ 0.281118] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.283239] pinctrl core: initialized pinctrl subsystem vm-test-run-plv8> server # [ 0.284384] PM: RTC time: 21:22:13, date: 2026-10-22 vm-test-run-plv8> server # [ 0.285982] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-plv8> server # [ 0.287258] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-plv8> server # [ 0.288141] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-plv8> server # [ 0.289244] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-plv8> server # [ 0.291129] audit: initializing netlink subsys (disabled) vm-test-run-plv8> server # [ 0.292152] audit: type=2000 audit(1792704134.181:1): state=initialized audit_enabled=0 res=1 vm-test-run-plv8> server # [ 0.292263] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-plv8> server # [ 0.293152] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-plv8> server # [ 0.294114] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-plv8> server # [ 0.295113] thermal_sys: Registered thermal governor 'user_space' vm-test-run-plv8> server # [ 0.296113] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-plv8> server # [ 0.297136] cpuidle: using governor menu vm-test-run-plv8> server # [ 0.300319] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 vm-test-run-plv8> server # [ 0.301230] PCI: Using configuration type 1 for base access vm-test-run-plv8> server # [ 0.302111] PCI: Using configuration type 1 for extended access vm-test-run-plv8> server # [ 0.303217] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. vm-test-run-plv8> server # [ 0.323177] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.324112] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-plv8> server # [ 0.325113] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.327113] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-plv8> server # [ 0.329110] ACPI: Added _OSI(Module Device) vm-test-run-plv8> server # [ 0.329748] ACPI: Added _OSI(Processor Device) vm-test-run-plv8> server # [ 0.331120] ACPI: Added _OSI(Processor Aggregator Device) vm-test-run-plv8> server # [ 0.333107] ACPI: 1 ACPI AML tables successfully acquired and loaded vm-test-run-plv8> server # [ 0.337398] ACPI: Interpreter enabled vm-test-run-plv8> server # [ 0.338134] ACPI: PM: (supports S0 S3 S4 S5) vm-test-run-plv8> server # [ 0.339033] ACPI: Using IOAPIC for interrupt routing vm-test-run-plv8> server # [ 0.339858] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug vm-test-run-plv8> server # [ 0.341107] PCI: Using E820 reservations for host bridge windows vm-test-run-plv8> server # [ 0.341107] ACPI: Enabled 2 GPEs in block 00 to 0F vm-test-run-plv8> server # [ 0.347029] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) vm-test-run-plv8> server # [ 0.347798] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] vm-test-run-plv8> server # [ 0.349455] acpiphp: Slot [3] registered vm-test-run-plv8> server # [ 0.350087] acpiphp: Slot [4] registered vm-test-run-plv8> server # [ 0.350780] acpiphp: Slot [5] registered vm-test-run-plv8> server # [ 0.351107] acpiphp: Slot [6] registered vm-test-run-plv8> server # [ 0.351107] acpiphp: Slot [7] registered vm-test-run-plv8> server # [ 0.351107] acpiphp: Slot [8] registered vm-test-run-plv8> server # [ 0.352686] acpiphp: Slot [9] registered vm-test-run-plv8> server # [ 0.354149] acpiphp: Slot [10] registered vm-test-run-plv8> server # [ 0.355093] acpiphp: Slot [11] registered vm-test-run-plv8> server # [ 0.355625] acpiphp: Slot [12] registered vm-test-run-plv8> server # [ 0.356146] acpiphp: Slot [13] registered vm-test-run-plv8> server # [ 0.357070] acpiphp: Slot [14] registered vm-test-run-plv8> server # [ 0.357764] acpiphp: Slot [15] registered vm-test-run-plv8> server # [ 0.359146] acpiphp: Slot [16] registered vm-test-run-plv8> server # [ 0.360064] acpiphp: Slot [17] registered vm-test-run-plv8> server # [ 0.360768] acpiphp: Slot [18] registered vm-test-run-plv8> server # [ 0.362151] acpiphp: Slot [19] registered vm-test-run-plv8> server # [ 0.362956] acpiphp: Slot [20] registered vm-test-run-plv8> server # [ 0.363608] acpiphp: Slot [21] registered vm-test-run-plv8> server # [ 0.364139] acpiphp: Slot [22] registered vm-test-run-plv8> server # [ 0.364868] acpiphp: Slot [23] registered vm-test-run-plv8> server # [ 0.365135] acpiphp: Slot [24] registered vm-test-run-plv8> server # [ 0.365937] acpiphp: Slot [25] registered vm-test-run-plv8> server # [ 0.367684] acpiphp: Slot [26] registered vm-test-run-plv8> server # [ 0.368145] acpiphp: Slot [27] registered vm-test-run-plv8> server # [ 0.368983] acpiphp: Slot [28] registered vm-test-run-plv8> server # [ 0.369873] acpiphp: Slot [29] registered vm-test-run-plv8> server # [ 0.370873] acpiphp: Slot [30] registered vm-test-run-plv8> server # [ 0.371765] acpiphp: Slot [31] registered vm-test-run-plv8> server # [ 0.372136] PCI host bridge to bus 0000:00 vm-test-run-plv8> server # [ 0.373074] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] vm-test-run-plv8> server # [ 0.374096] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] vm-test-run-plv8> server # [ 0.375070] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] vm-test-run-plv8> server # [ 0.377113] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] vm-test-run-plv8> server # [ 0.378113] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] vm-test-run-plv8> server # [ 0.380114] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-plv8> server # [ 0.381312] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.383587] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint vm-test-run-plv8> server # [ 0.385865] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint vm-test-run-plv8> server # [ 0.391107] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] vm-test-run-plv8> server # [ 0.394511] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk vm-test-run-plv8> server # [ 0.396112] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk vm-test-run-plv8> server # [ 0.397111] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk vm-test-run-plv8> server # [ 0.398107] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk vm-test-run-plv8> server # [ 0.398107] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint vm-test-run-plv8> server # [ 0.405883] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] vm-test-run-plv8> server # [ 0.410107] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.413639] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI vm-test-run-plv8> server # [ 0.415126] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB vm-test-run-plv8> server # [ 0.416471] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.423875] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] vm-test-run-plv8> server # [ 0.435670] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] vm-test-run-plv8> server # [ 0.446125] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] vm-test-run-plv8> server # [ 0.447188] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] vm-test-run-plv8> server # [ 0.448579] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.453080] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] vm-test-run-plv8> server # [ 0.454701] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] vm-test-run-plv8> server # [ 0.464112] pci 0000:00:03.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] vm-test-run-plv8> server # [ 0.467114] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] vm-test-run-plv8> server # [ 0.469844] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.472112] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] vm-test-run-plv8> server # [ 0.475112] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] vm-test-run-plv8> server # [ 0.485113] pci 0000:00:04.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] vm-test-run-plv8> server # [ 0.490928] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.494113] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] vm-test-run-plv8> server # [ 0.497112] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] vm-test-run-plv8> server # [ 0.501112] pci 0000:00:05.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] vm-test-run-plv8> server # [ 0.509107] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.513113] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] vm-test-run-plv8> server # [ 0.515907] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] vm-test-run-plv8> server # [ 0.521009] pci 0000:00:06.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] vm-test-run-plv8> server # [ 0.525645] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.530113] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] vm-test-run-plv8> server # [ 0.531107] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] vm-test-run-plv8> server # [ 0.536107] pci 0000:00:07.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] vm-test-run-plv8> server # [ 0.540983] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.544949] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] vm-test-run-plv8> server # [ 0.549980] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] vm-test-run-plv8> server # [ 0.561002] pci 0000:00:08.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] vm-test-run-plv8> server # [ 0.566107] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.569114] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] vm-test-run-plv8> server # [ 0.571113] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] vm-test-run-plv8> server # [ 0.576115] pci 0000:00:09.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] vm-test-run-plv8> server # [ 0.582114] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] vm-test-run-plv8> server # [ 0.583107] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.585805] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] vm-test-run-plv8> server # [ 0.594112] pci 0000:00:0a.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] vm-test-run-plv8> server # [ 0.600284] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.603113] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] vm-test-run-plv8> server # [ 0.606113] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] vm-test-run-plv8> server # [ 0.613116] pci 0000:00:0b.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] vm-test-run-plv8> server # [ 0.617434] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.619056] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] vm-test-run-plv8> server # [ 0.621944] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] vm-test-run-plv8> server # [ 0.629115] pci 0000:00:0c.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] vm-test-run-plv8> server # [ 0.634557] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 vm-test-run-plv8> server # [ 0.636410] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 vm-test-run-plv8> server # [ 0.638297] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 vm-test-run-plv8> server # [ 0.639295] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 vm-test-run-plv8> server # [ 0.640209] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 vm-test-run-plv8> server # [ 0.642610] iommu: Default domain type: Translated vm-test-run-plv8> server # [ 0.643111] iommu: DMA domain TLB invalidation policy: lazy mode vm-test-run-plv8> server # [ 0.644150] ACPI: bus type USB registered vm-test-run-plv8> server # [ 0.645081] usbcore: registered new interface driver usbfs vm-test-run-plv8> server # [ 0.645107] usbcore: registered new interface driver hub vm-test-run-plv8> server # [ 0.645149] usbcore: registered new device driver usb vm-test-run-plv8> server # [ 0.646385] NetLabel: Initializing vm-test-run-plv8> server # [ 0.647022] NetLabel: domain hash size = 128 vm-test-run-plv8> server # [ 0.647107] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO vm-test-run-plv8> server # [ 0.647107] NetLabel: unlabeled traffic allowed by default vm-test-run-plv8> server # [ 0.647107] PCI: Using ACPI for IRQ routing vm-test-run-plv8> server # [ 0.649478] pci 0000:00:02.0: vgaarb: setting as boot VGA device vm-test-run-plv8> server # [ 0.650107] pci 0000:00:02.0: vgaarb: bridge control possible vm-test-run-plv8> server # [ 0.650107] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none vm-test-run-plv8> server # [ 0.652116] vgaarb: loaded vm-test-run-plv8> server # [ 0.652653] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 vm-test-run-plv8> server # [ 0.653111] hpet0: 3 comparators, 64-bit 100.000000 MHz counter vm-test-run-plv8> server # [ 0.658220] clocksource: Switched to clocksource kvm-clock vm-test-run-plv8> server # [ 0.659232] VFS: Disk quotas dquot_6.6.0 vm-test-run-plv8> server # [ 0.660088] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-plv8> server # [ 0.662120] pnp: PnP ACPI init vm-test-run-plv8> server # [ 0.663565] pnp: PnP ACPI: found 6 devices vm-test-run-plv8> server # [ 0.674603] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns vm-test-run-plv8> server # [ 0.677133] clocksource: Switched to clocksource acpi_pm vm-test-run-plv8> server # [ 0.678069] NET: Registered PF_INET protocol family vm-test-run-plv8> server # [ 0.678892] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-plv8> server # [ 0.691411] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.692880] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.694304] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.695749] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-plv8> server # [ 0.697024] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-plv8> server # [ 0.698237] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-plv8> server # [ 0.699685] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.701053] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.702791] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-plv8> server # [ 0.703994] NET: Registered PF_XDP protocol family vm-test-run-plv8> server # [ 0.705027] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] vm-test-run-plv8> server # [ 0.706348] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] vm-test-run-plv8> server # [ 0.707386] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] vm-test-run-plv8> server # [ 0.708465] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] vm-test-run-plv8> server # [ 0.709602] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] vm-test-run-plv8> server # [ 0.710890] pci 0000:00:01.0: PIIX3: Enabling Passive Release vm-test-run-plv8> server # [ 0.711830] pci 0000:00:00.0: Limiting direct PCI/PCI transfers vm-test-run-plv8> server # [ 0.714223] ACPI: \_SB_.LNKD: Enabled at IRQ 11 vm-test-run-plv8> server # [ 0.717173] PCI: CLS 0 bytes, default 64 vm-test-run-plv8> server # [ 0.717900] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) vm-test-run-plv8> server # [ 0.718052] Trying to unpack rootfs image as initramfs... vm-test-run-plv8> server # [ 0.718139] software IO TLB: mapped [mem 0x00000000bb3be000-0x00000000bf3be000] (64MB) vm-test-run-plv8> server # [ 0.721300] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2b29812ce43, max_idle_ns: 440795323173 ns vm-test-run-plv8> server # [ 0.736956] Initialise system trusted keyrings vm-test-run-plv8> server # [ 0.738033] workingset: timestamp_bits=40 max_order=20 bucket_order=0 vm-test-run-plv8> server # [ 0.753217] Key type asymmetric registered vm-test-run-plv8> server # [ 0.754173] Asymmetric key parser 'x509' registered vm-test-run-plv8> server # [ 0.755352] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) vm-test-run-plv8> server # [ 0.757087] io scheduler mq-deadline registered vm-test-run-plv8> server # [ 0.758014] io scheduler kyber registered vm-test-run-plv8> server # [ 0.760200] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-plv8> server # [ 0.761723] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A vm-test-run-plv8> server # [ 0.764210] Linux agpgart interface v0.103 vm-test-run-plv8> server # [ 0.765253] ACPI: bus type drm_connector registered vm-test-run-plv8> server # [ 0.767174] usbcore: registered new interface driver usbserial_generic vm-test-run-plv8> server # [ 0.768540] usbserial: USB Serial support registered for generic vm-test-run-plv8> server # [ 0.770054] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled vm-test-run-plv8> server # [ 0.771699] drop_monitor: Initializing network drop monitor service vm-test-run-plv8> server # [ 0.773406] NET: Registered PF_INET6 protocol family vm-test-run-plv8> server # [ 0.796412] Freeing initrd memory: 12360K vm-test-run-plv8> server # [ 0.801545] Segment Routing with IPv6 vm-test-run-plv8> server # [ 0.802330] In-situ OAM (IOAM) with IPv6 vm-test-run-plv8> server # [ 0.804318] IPI shorthand broadcast: enabled vm-test-run-plv8> server # [ 0.808836] sched_clock: Marking stable (675022551, 133482198)->(871893521, -63388772) vm-test-run-plv8> server # [ 0.811006] registered taskstats version 1 vm-test-run-plv8> server # [ 0.812225] Loading compiled-in X.509 certificates vm-test-run-plv8> server # [ 0.820571] Demotion targets for Node 0: null vm-test-run-plv8> server # [ 0.821766] Key type .fscrypt registered vm-test-run-plv8> server # [ 0.822593] Key type fscrypt-provisioning registered vm-test-run-plv8> server # [ 0.823918] PM: Magic number: 14:729:399 vm-test-run-plv8> server # [ 0.826162] RAS: Correctable Errors collector initialized. vm-test-run-plv8> server # [ 0.832945] clk: Disabling unused clocks vm-test-run-plv8> server # [ 0.833936] PM: genpd: Disabling unused power domains vm-test-run-plv8> server # [ 0.837380] Freeing unused decrypted memory: 2028K vm-test-run-plv8> server # [ 0.839514] Freeing unused kernel image (initmem) memory: 3420K vm-test-run-plv8> server # [ 0.840737] Write protecting the kernel read-only data: 30720k vm-test-run-plv8> server # [ 0.842661] Freeing unused kernel image (rodata/data gap) memory: 1760K vm-test-run-plv8> server # [ 0.906693] x86/mm: Checked W+X mappings: passed, no W+X pages found. vm-test-run-plv8> server # [ 0.908098] Run /init as init process vm-test-run-plv8> server # [ 0.962591] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-plv8> server # [ 1.123697] ACPI: \_SB_.LNKC: Enabled at IRQ 10 vm-test-run-plv8> server # [ 1.142280] SCSI subsystem initialized vm-test-run-plv8> server # [ 1.144777] uhci_hcd 0000:00:01.2: UHCI Host Controller vm-test-run-plv8> server # [ 1.144966] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 vm-test-run-plv8> server # [ 1.145582] ACPI: \_SB_.LNKA: Enabled at IRQ 10 vm-test-run-plv8> server # [ 1.148531] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 vm-test-run-plv8> server # [ 1.150114] uhci_hcd 0000:00:01.2: detected 2 ports vm-test-run-plv8> server # [ 1.151415] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 vm-test-run-plv8> server # [ 1.153908] serio: i8042 KBD port at 0x60,0x64 irq 1 vm-test-run-plv8> server # [ 1.154750] serio: i8042 AUX port at 0x60,0x64 irq 12 vm-test-run-plv8> server # [ 1.156007] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.12 vm-test-run-plv8> server # [ 1.162073] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 vm-test-run-plv8> server # [ 1.163786] usb usb1: Product: UHCI Host Controller vm-test-run-plv8> server # [ 1.164922] usb usb1: Manufacturer: Linux 6.12.63 uhci_hcd vm-test-run-plv8> server # [ 1.166290] usb usb1: SerialNumber: 0000:00:01.2 vm-test-run-plv8> server # [ 1.169293] ACPI: \_SB_.LNKB: Enabled at IRQ 11 vm-test-run-plv8> server # [ 1.184695] hub 1-0:1.0: USB hub found vm-test-run-plv8> server # [ 1.185597] hub 1-0:1.0: 2 ports detected vm-test-run-plv8> server # [ 1.209137] scsi host0: ata_piix vm-test-run-plv8> server # [ 1.210674] scsi host1: ata_piix vm-test-run-plv8> server # [ 1.211570] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 vm-test-run-plv8> server # [ 1.213137] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 vm-test-run-plv8> server # [ 1.372748] ata2: found unknown device (class 0) vm-test-run-plv8> server # [ 1.375094] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 vm-test-run-plv8> server # [ 1.377596] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 vm-test-run-plv8> server # [ 1.404989] usb 1-1: new full-speed USB device number 2 using uhci_hcd vm-test-run-plv8> server # [ 1.422816] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-plv8> server # [ 1.432736] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 vm-test-run-plv8> server # [ 1.433469] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-plv8> server # [ 1.443969] netfs: FS-Cache loaded vm-test-run-plv8> server # [ 1.456405] 9pnet: Installing 9P2000 support vm-test-run-plv8> server # [ 1.458590] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray vm-test-run-plv8> server # [ 1.459978] cdrom: Uniform CD-ROM driver Revision: 3.20 vm-test-run-plv8> server # [ 1.576785] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 vm-test-run-plv8> server # [ 1.578467] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 vm-test-run-plv8> server # [ 1.579965] usb 1-1: Product: QEMU USB Tablet vm-test-run-plv8> server # [ 1.581321] usb 1-1: Manufacturer: QEMU vm-test-run-plv8> server # [ 1.582063] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 vm-test-run-plv8> server # [ 1.598682] hid: raw HID events driver (C) Jiri Kosina vm-test-run-plv8> server # [ 1.608270] usbcore: registered new interface driver usbhid vm-test-run-plv8> server # [ 1.610308] usbhid: USB HID core driver vm-test-run-plv8> server # [ 1.613245] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 vm-test-run-plv8> server # [ 1.615601] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0 vm-test-run-plv8> server # [ 1.862348] EXT4-fs (vda): mounted filesystem 1cbdca73-88a4-4149-9703-9c0563995e37 r/w with ordered data mode. Quota mode: none. vm-test-run-plv8> server # [ 1.887662] 9p: Installing v9fs 9p2000 file system support vm-test-run-plv8> server # [ 2.298523] EXT4-fs (vda): re-mounted 1cbdca73-88a4-4149-9703-9c0563995e37. vm-test-run-plv8> server # [ 2.304261] booting system configuration /nix/store/57wyk95526zmwjf4dpbdjwwl6h316abm-nixos-system-server-test vm-test-run-plv8> server # [ 4.939124] systemd[1]: Inserted module 'autofs4' vm-test-run-plv8> server # [ 5.027275] 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 # [ 5.033122] systemd[1]: Detected virtualization kvm. vm-test-run-plv8> server # [ 5.034246] systemd[1]: Detected architecture x86-64. vm-test-run-plv8> server # [ 5.035406] systemd[1]: Detected first boot. vm-test-run-plv8> server # [ 5.042320] systemd[1]: Initializing machine ID from random generator. vm-test-run-plv8> server # [ 5.050549] systemd[1]: Hostname set to . vm-test-run-plv8> server # [ 5.242987] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-plv8> server # [ 5.395329] systemd[1]: Applying preset policy. vm-test-run-plv8> server # [ 6.286367] systemd[1]: Populated /etc with preset unit settings. vm-test-run-plv8> server # [ 7.152151] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-plv8> server # [ 7.212625] systemd[1]: Created slice Slice /system/getty. vm-test-run-plv8> server # [ 7.214289] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-plv8> server # [ 7.215869] systemd[1]: Created slice User and Session Slice. vm-test-run-plv8> server # [ 7.217604] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-plv8> server # [ 7.219054] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-plv8> server # [ 7.220473] systemd[1]: Expecting device /dev/hvc0... vm-test-run-plv8> server # [ 7.221448] systemd[1]: Expecting device /dev/ttyS0... vm-test-run-plv8> server # [ 7.222456] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-plv8> server # [ 7.223694] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-plv8> server # [ 7.224696] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-plv8> server # [ 7.226022] systemd[1]: Reached target Path Units. vm-test-run-plv8> server # [ 7.227047] systemd[1]: Reached target Remote File Systems. vm-test-run-plv8> server # [ 7.228133] systemd[1]: Reached target Slice Units. vm-test-run-plv8> server # [ 7.229228] systemd[1]: Reached target Swaps. vm-test-run-plv8> server # [ 7.237362] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-plv8> server # [ 7.241426] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-plv8> server # [ 7.243558] systemd[1]: Listening on Journal Audit Socket. vm-test-run-plv8> server # [ 7.245187] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-plv8> server # [ 7.246383] systemd[1]: Listening on Journal Sockets. vm-test-run-plv8> server # [ 7.247596] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-plv8> server # [ 7.248749] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 7.250572] systemd[1]: Listening on udev Control Socket. vm-test-run-plv8> server # [ 7.251648] systemd[1]: Listening on udev Kernel Socket. vm-test-run-plv8> server # [ 7.260759] systemd[1]: Mounting Huge Pages File System... vm-test-run-plv8> server # [ 7.265565] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-plv8> server # [ 7.270859] systemd[1]: Mounting Kernel Debug File System... vm-test-run-plv8> server # [ 7.277380] systemd[1]: Mounting Kernel Trace File System... vm-test-run-plv8> server # [ 7.287995] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-plv8> server # [ 7.289607] systemd[1]: Load Kernel Module 9pnet_virtio was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!9pnet_virtio). vm-test-run-plv8> server # [ 7.305239] systemd[1]: Starting Load Kernel Module configfs... vm-test-run-plv8> server # [ 7.306288] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-plv8> server # [ 7.312115] systemd[1]: Starting Load Kernel Module efi_pstore... vm-test-run-plv8> server # [ 7.317349] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-plv8> server # [ 7.318380] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-plv8> server # [ 7.322127] 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 # [ 7.338888] systemd[1]: Starting Journal Service... vm-test-run-plv8> server # [ 7.351688] systemd[1]: Starting Load Kernel Modules... vm-test-run-plv8> server # [ 7.360850] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-plv8> server # [ 7.368571] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-plv8> server # [ 7.370850] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 7.382980] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-plv8> server # [ 7.397350] systemd[1]: Mounted Huge Pages File System. vm-test-run-plv8> server # [ 7.398786] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-plv8> server # [ 7.402862] systemd[1]: Mounted Kernel Debug File System. vm-test-run-plv8> server # [ 7.404223] systemd[1]: Mounted Kernel Trace File System. vm-test-run-plv8> server # [ 7.409068] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-plv8> server # [ 7.421814] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-plv8> server # [ 7.428871] systemd[1]: modprobe@configfs.service: Deactivated successfully. vm-test-run-plv8> server # [ 7.433145] systemd[1]: Finished Load Kernel Module configfs. vm-test-run-plv8> server # [ 7.440406] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-plv8> server # [ 7.442514] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. vm-test-run-plv8> server # [ 7.445044] systemd[1]: Finished Load Kernel Module efi_pstore. vm-test-run-plv8> server # [ 7.449881] fuse: init (API version 7.41) vm-test-run-plv8> server # [ 7.458040] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-plv8> server # [ 7.459732] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-plv8> server # [ 7.466467] systemd[1]: Mounting FUSE Control File System... vm-test-run-plv8> server # [ 7.476405] systemd-journald[410]: Collecting audit messages is enabled. vm-test-run-plv8> server # [ 7.487966] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-plv8> server # [ 7.509632] loop: module loaded vm-test-run-plv8> server # [ 7.520414] EXT4-fs (vda): re-mounted 1cbdca73-88a4-4149-9703-9c0563995e37. vm-test-run-plv8> server # [ 7.523438] systemd[1]: Mounted FUSE Control File System. vm-test-run-plv8> server # [ 7.529025] systemd[1]: Finished Load Kernel Modules. vm-test-run-plv8> server # [ 7.536415] systemd[1]: Starting Firewall... vm-test-run-plv8> server # [ 7.544612] systemd[1]: Starting Apply Kernel Variables... vm-test-run-plv8> server # [ 7.547828] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-plv8> server # [ 7.549181] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-plv8> server # [ 7.559418] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-plv8> server # [ 7.560582] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 7.614225] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-plv8> server # [ 7.645574] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-plv8> server # [ 7.647117] systemd[1]: Reached target First Boot Complete. vm-test-run-plv8> server # [ 7.677607] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-plv8> server # [ 7.686417] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-plv8> server # [ 7.700154] systemd[1]: Finished Apply Kernel Variables. vm-test-run-plv8> server # [ 7.704924] systemd[1]: Started Journal Service. vm-test-run-plv8> server # [ 7.574178] systemd-modules-load[411]: Inserted module 'loop' vm-test-run-plv8> server # [ 7.580924] systemd-oomd[412]: No swap; memory pressure usage will be degraded vm-test-run-plv8> server # [ 7.584861] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-plv8> server # [ 7.652939] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-plv8> server # [ 7.810161] systemd-journald[410]: Received client request to flush runtime journal. vm-test-run-plv8> server # [ 7.731478] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-plv8> server # [ 7.734446] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-plv8> server # [ 7.736482] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-plv8> server # [ 7.741246] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-plv8> server # [ 7.845567] systemd-udevd[457]: Using default interface naming scheme 'v258'. vm-test-run-plv8> server # [ 8.067332] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-plv8> server # [ 8.239966] systemd[1]: Found device /dev/hvc0. vm-test-run-plv8> server # [ 8.268715] systemd[1]: Mounting /run/wrappers... vm-test-run-plv8> server # [ 8.275321] systemd[1]: Found device /dev/ttyS0. vm-test-run-plv8> server # [ 8.302950] (udev-worker)[491]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 8.305310] (udev-worker)[486]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-plv8> server # [ 8.308034] (udev-worker)[486]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 8.319144] systemd[1]: Mounted /run/wrappers. vm-test-run-plv8> server # [ 8.320385] systemd[1]: Reached target Local File Systems. vm-test-run-plv8> server # [ 8.326578] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-plv8> server # [ 8.331554] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-plv8> server # [ 8.332560] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-plv8> server # [ 8.336336] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-plv8> server # [ 8.339539] systemd[1]: Starting Create System Files and Directories... vm-test-run-plv8> server # [ 8.408764] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-plv8> server # [ 8.418732] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-plv8> server # [ 8.490763] systemd[1]: Finished Create System Files and Directories. vm-test-run-plv8> server # [ 8.494805] systemd[1]: Found device Virtio network device. vm-test-run-plv8> server # [ 8.632588] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 vm-test-run-plv8> server # [ 8.504529] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-plv8> server # [ 8.506354] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-plv8> server # [ 8.646600] mousedev: PS/2 mouse device common for all mice vm-test-run-plv8> server # [ 8.647767] ACPI: button: Power Button [PWRF] vm-test-run-plv8> server # [ 8.704094] rtc_cmos 00:05: RTC can wake from S4 vm-test-run-plv8> server # [ 8.576440] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-plv8> server # [ 8.712781] rtc_cmos 00:05: registered as rtc0 vm-test-run-plv8> server # [ 8.721627] rtc_cmos 00:05: setting system clock to 2026-10-22T21:22:22 UTC (1792704142) vm-test-run-plv8> server # [ 8.723883] systemd-journald[410]: Time jumped backwards, rotating. vm-test-run-plv8> server # [ 8.746046] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs vm-test-run-plv8> server # [ 8.760085] parport_pc 00:03: reported by Plug and Play ACPI vm-test-run-plv8> server # [ 8.761311] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] vm-test-run-plv8> server # [ 8.767934] Floppy drive(s): fd0 is 2.88M AMI BIOS vm-test-run-plv8> server # [ 8.781949] FDC 0 is a S82078B vm-test-run-plv8> server # [ 8.651334] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-plv8> server # [ 8.657268] systemd[1]: Starting Update is Completed... vm-test-run-plv8> server # [ 8.804022] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 vm-test-run-plv8> server # [ 8.815752] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD vm-test-run-plv8> server # [ 8.828837] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 vm-test-run-plv8> server # [ 8.847961] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console vm-test-run-plv8> server # [ 8.860138] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 vm-test-run-plv8> server # [ 8.862051] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 vm-test-run-plv8> server # [ 8.881049] Console: switching to colour dummy device 80x25 vm-test-run-plv8> server # [ 8.881371] cryptd: max_cpu_qlen set to 1000 vm-test-run-plv8> server # [ 8.882069] [drm] Found bochs VGA, ID 0xb0c5. vm-test-run-plv8> server # [ 8.885722] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. vm-test-run-plv8> server # [ 8.754129] systemd[1]: Finished Update is Completed. vm-test-run-plv8> server # [ 8.892573] [drm] Found EDID data blob. vm-test-run-plv8> server # [ 8.893988] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 vm-test-run-plv8> server # [ 8.897328] fbcon: bochs-drmdrmfb (fb0) is primary device vm-test-run-plv8> server # [ 8.953466] AES CTR mode by8 optimization enabled vm-test-run-plv8> server # [ 8.965657] Console: switching to colour frame buffer device 160x50 vm-test-run-plv8> server # [ 9.050352] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device vm-test-run-plv8> server # [ 9.052272] ppdev: user-space parallel port driver vm-test-run-plv8> server # [ 8.953331] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 9.076726] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-plv8> server # [ 9.078489] systemd[1]: Stopped Virtual Console Setup. vm-test-run-plv8> server # [ 9.093959] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 9.196934] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-plv8> server # [ 9.201210] systemd[1]: Stopped Virtual Console Setup. vm-test-run-plv8> server # [ 9.211438] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 9.397022] kvm_amd: TSC scaling supported vm-test-run-plv8> server # [ 9.397507] kvm_amd: Nested Virtualization enabled vm-test-run-plv8> server # [ 9.398100] kvm_amd: Nested Paging enabled vm-test-run-plv8> server # [ 9.398603] kvm_amd: LBR virtualization supported vm-test-run-plv8> server # [ 9.402300] kvm_amd: Virtual VMLOAD VMSAVE supported vm-test-run-plv8> server # [ 9.402876] kvm_amd: Virtual GIF supported vm-test-run-plv8> server # [ 9.481390] EDAC MC: Ver: 3.0.0 vm-test-run-plv8> server # [ 9.768372] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-plv8> server # [ 9.771288] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-plv8> server # [ 10.435264] systemd[1]: Finished Firewall. vm-test-run-plv8> server # [ 11.837741] systemd[1]: Finished Virtual Console Setup. vm-test-run-plv8> server # [ 11.840714] systemd[1]: Reached target System Initialization. vm-test-run-plv8> server # [ 11.847241] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-plv8> server # [ 11.848458] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-plv8> server # [ 11.849618] systemd[1]: Reached target Timer Units. vm-test-run-plv8> server # [ 11.851712] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-plv8> server # [ 11.853314] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-plv8> server # [ 11.855156] systemd[1]: Listening on Hostname Service Socket. vm-test-run-plv8> server # [ 11.857003] systemd[1]: Reached target Socket Units. vm-test-run-plv8> server # [ 11.858301] systemd[1]: Reached target Basic System. vm-test-run-plv8> server # [ 11.861646] systemd[1]: Started backdoor.service. vm-test-run-plv8> server # [ 11.870834] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-plv8> server # [ 11.877596] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 11.881050] systemd[1]: Started Reset console on configuration changes. vm-test-run-plv8> server # [ 11.886599] systemd[1]: Starting resolvconf update... vm-test-run-plv8> server # [ 11.901676] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-plv8> server # [ 12.052485] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-plv8> server # connecting to host... vm-test-run-plv8> server # [ 12.078534] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 12.081914] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 12.082756] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 12.086685] nsncd[681]: Oct 22 21:22:25.989 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 12.091353] systemd[1]: Starting User Login Management... 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 12.67 seconds) vm-test-run-plv8> server: (finished: waiting for the VM to finish booting, in 12.68 seconds) vm-test-run-plv8> server # [ 12.212748] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-plv8> server # [ 12.215718] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-plv8> server # [ 12.217156] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-plv8> server # [ 12.225520] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-plv8> server # [ 12.229262] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 12.232331] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-plv8> server # [ 12.235408] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 12.243070] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 12.247867] dbus-daemon[684]: dbus[684]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-plv8> server # [ 12.250254] systemd-logind[706]: New seat seat0. vm-test-run-plv8> server # [ 12.263195] systemd-logind[706]: Watching system buttons on /dev/input/event2 (Power Button) vm-test-run-plv8> server # [ 12.264572] systemd-logind[706]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-plv8> server # [ 12.266353] systemd-logind[706]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) vm-test-run-plv8> server # [ 12.271421] systemd[1]: Started User Login Management. vm-test-run-plv8> server # [ 12.277967] systemd[1]: Starting linger-users.service... vm-test-run-plv8> server # [ 12.360307] nsncd[748]: Oct 22 21:22:26.271 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 12.372251] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 12.372586] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-plv8> server # [ 12.378204] systemd[1]: Finished linger-users.service. vm-test-run-plv8> server # [ 12.379302] systemd[1]: Started D-Bus System Message Bus. vm-test-run-plv8> server # [ 12.398375] dbus-daemon[684]: [system] Successfully activated service 'org.freedesktop.systemd1' vm-test-run-plv8> server # [ 12.421517] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 12.423417] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 12.461534] systemd[1]: Finished resolvconf update. vm-test-run-plv8> server # [ 12.463377] systemd[1]: Reached target Preparation for Network. vm-test-run-plv8> server # [ 12.470657] systemd[1]: Starting DHCP Client... vm-test-run-plv8> server # [ 12.476821] systemd[1]: Starting Address configuration of eth1... vm-test-run-plv8> server # [ 12.666192] network-addresses-eth1-start[781]: adding address 192.168.1.1/24... done vm-test-run-plv8> server # [ 12.681937] dhcpcd[802]: dhcpcd-10.2.4 starting vm-test-run-plv8> server # [ 12.705958] network-addresses-eth1-start[781]: adding address 2001:db8:1::1/64... done vm-test-run-plv8> server # [ 12.710951] dhcpcd[812]: dev: loaded udev vm-test-run-plv8> server # [ 12.749769] systemd[1]: Finished Address configuration of eth1. vm-test-run-plv8> server # [ 12.755845] systemd[1]: Starting Networking Setup... vm-test-run-plv8> server # [ 12.898808] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-plv8> server # [ 12.900382] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-plv8> server # [ 12.832844] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-plv8> server # [ 13.062321] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-plv8> server # [ 13.180328] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-plv8> server # [ 13.181295] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-plv8> server # [ 13.192000] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-plv8> server # [ 13.193242] cfg80211: failed to load regulatory.db vm-test-run-plv8> server # [ 13.107914] systemd[1]: Finished Networking Setup. vm-test-run-plv8> server # [ 13.110929] systemd[1]: Reached target Network. vm-test-run-plv8> server # [ 13.118436] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-plv8> server # [ 13.124881] systemd[1]: Starting Permit User Sessions... vm-test-run-plv8> server # [ 13.228587] systemd[1]: Finished Permit User Sessions. vm-test-run-plv8> server # [ 13.235829] systemd[1]: Started Getty on tty1. vm-test-run-plv8> server # [ 13.238196] systemd[1]: Reached target Login Prompts. vm-test-run-plv8> server # [ 13.404946] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-plv8> server # [ 13.275216] dhcpcd[812]: eth0: waiting for carrier vm-test-run-plv8> server # [ 13.372105] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[875]: Initializing database at /var/lib/postgresql/data vm-test-run-plv8> server # [ 13.632192] dhcpcd[812]: eth0: carrier acquired vm-test-run-plv8> server # [ 13.671966] dhcpcd[812]: DUID 00:01:00:01:32:6d:3b:13:52:54:00:12:34:56 vm-test-run-plv8> server # [ 13.675594] dhcpcd[812]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 13.677083] dhcpcd[812]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-plv8> server # [ 13.910990] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: The files belonging to this database system will be owned by user "postgres". vm-test-run-plv8> server # [ 13.911680] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: This user must also own the server process. vm-test-run-plv8> server # [ 13.953854] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-plv8> server # [ 13.957038] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: The default database encoding has accordingly been set to "UTF8". vm-test-run-plv8> server # [ 13.960320] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: The default text search configuration will be set to "english". vm-test-run-plv8> server # [ 13.961955] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: Data page checksums are enabled. vm-test-run-plv8> server # [ 13.963245] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-plv8> server # [ 13.965148] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: creating subdirectories ... ok vm-test-run-plv8> server # [ 13.966755] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: selecting dynamic shared memory implementation ... posix vm-test-run-plv8> server # [ 14.260094] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: selecting default max_connections ... 100 vm-test-run-plv8> server # [ 14.460344] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: selecting default shared_buffers ... 128MB vm-test-run-plv8> server # [ 15.101493] dhcpcd[812]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 15.269382] NET: Registered PF_PACKET protocol family vm-test-run-plv8> server # [ 15.148772] dhcpcd[812]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 15.154284] dhcpcd[812]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 15.948067] dhcpcd[812]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 15.950427] dhcpcd[812]: eth0: Router Advertisement from fe80::2 vm-test-run-plv8> server # [ 15.952463] dhcpcd[812]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-plv8> server # [ 15.957343] dhcpcd[812]: eth0: adding route to fec0::/64 vm-test-run-plv8> server # [ 15.958343] dhcpcd[812]: eth0: adding default route via fe80::2 vm-test-run-plv8> server # [ 16.533294] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: selecting default time zone ... UTC vm-test-run-plv8> server # [ 16.540677] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: creating configuration files ... ok vm-test-run-plv8> server # [ 16.808949] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: running bootstrap script ... ok vm-test-run-plv8> server # [ 17.645640] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: performing post-bootstrap initialization ... ok vm-test-run-plv8> server # [ 17.887316] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: syncing data to disk ... ok vm-test-run-plv8> server # [ 17.887818] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-plv8> server # [ 17.888960] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: 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 # [ 17.894498] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: Success. You can now start the database server using: vm-test-run-plv8> server # [ 17.894664] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[876]: /nix/store/n5sl2rnzlpjxv8kk27mmigamrbh0xfmg-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-plv8> server # [ 18.126356] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[875]: Validating PostgreSQL configuration... vm-test-run-plv8> server # [ 18.196349] v302hl8mgk1zl4lx1riz4zwqgii10dsn-postgresql-init[941]: 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 # [ 18.448311] postgres[943]: 2026-10-22 21:22:32.359 UTC [943] LOG: pgaudit extension initialized vm-test-run-plv8> server # [ 18.656414] postgres[943]: 2026-10-22 21:22:32.568 UTC [943] LOG: pgsodium primary server secret key loaded vm-test-run-plv8> server # [ 18.786076] postgres[943]: 2026-10-22 21:22:32.697 UTC [943] LOG: vault primary server secret key loaded vm-test-run-plv8> server # [ 18.823408] postgres[943]: 2026-10-22 21:22:32.734 UTC [943] LOG: starting PostgreSQL 15.19 on x86_64-pc-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-plv8> server # [ 18.827112] postgres[943]: 2026-10-22 21:22:32.738 UTC [943] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-plv8> server # [ 18.828787] postgres[943]: 2026-10-22 21:22:32.738 UTC [943] LOG: listening on IPv6 address "::", port 5432 vm-test-run-plv8> server # [ 18.830956] postgres[943]: 2026-10-22 21:22:32.742 UTC [943] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-plv8> server # [ 18.846651] postgres[958]: 2026-10-22 21:22:32.757 UTC [958] LOG: database system was shut down at 2026-10-22 21:22:31 UTC vm-test-run-plv8> server # [ 18.862714] postgres[943]: 2026-10-22 21:22:32.774 UTC [943] LOG: database system is ready to accept connections vm-test-run-plv8> server # [ 18.865062] postgres[962]: 2026-10-22 21:22:32.776 UTC [962] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 18.868245] postgres[961]: 2026-10-22 21:22:32.779 UTC [961] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-plv8> server # [ 18.871578] systemd[1]: Started PostgreSQL Database Server. vm-test-run-plv8> server # [ 18.872626] postgres[943]: 2026-10-22 21:22:32.784 UTC [943] LOG: background worker "pg_net 0.20.4 worker" (PID 962) exited with exit code 1 vm-test-run-plv8> server # [ 18.875235] postgres[963]: 2026-10-22 21:22:32.785 UTC [963] LOG: pg_cron scheduler started vm-test-run-plv8> server # [ 18.880640] systemd[1]: Starting Supabase Database Initialization... vm-test-run-plv8> server # [ 18.919461] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Waiting for PostgreSQL to be ready... vm-test-run-plv8> server # [ 18.983394] postgres[969]: ::1 2026-10-22 21:22:32.894 UTC [969] root@root FATAL: role "root" does not exist vm-test-run-plv8> server # [ 18.988433] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: PostgreSQL is ready vm-test-run-plv8> server # [ 18.989485] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Creating postgres role... vm-test-run-plv8> server # [ 19.036186] postgres[971]: ::1 2026-10-22 21:22:32.947 UTC [971] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-plv8> server # [ 19.038558] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[970]: CREATE ROLE vm-test-run-plv8> server # [ 19.077707] postgres[973]: ::1 2026-10-22 21:22:32.988 UTC [973] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-plv8> server # [ 19.080093] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[972]: ALTER DATABASE vm-test-run-plv8> server # [ 19.090484] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-plv8> server # [ 19.127936] postgres[975]: ::1 2026-10-22 21:22:33.039 UTC [975] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-plv8> server # [ 19.130842] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: CREATE PUBLICATION vm-test-run-plv8> server # [ 19.131224] postgres[975]: ::1 2026-10-22 21:22:33.042 UTC [975] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-plv8> server # [ 19.134889] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: ALTER ROLE vm-test-run-plv8> server # [ 19.136329] postgres[975]: ::1 2026-10-22 21:22:33.046 UTC [975] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-plv8> server # [ 19.138644] postgres[975]: ::1 2026-10-22 21:22:33.048 UTC [975] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-plv8> server # [ 19.140968] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: CREATE ROLE vm-test-run-plv8> server # [ 19.142081] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: CREATE ROLE vm-test-run-plv8> server # [ 19.143202] postgres[975]: ::1 2026-10-22 21:22:33.050 UTC [975] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-plv8> server # [ 19.145278] postgres[975]: ::1 2026-10-22 21:22:33.053 UTC [975] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-plv8> server # [ 19.147355] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: GRANT ROLE vm-test-run-plv8> server # [ 19.148297] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: GRANT vm-test-run-plv8> server # [ 19.150299] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: CREATE ROLE vm-test-run-plv8> server # [ 19.151559] postgres[975]: ::1 2026-10-22 21:22:33.056 UTC [975] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-plv8> server # [ 19.153821] postgres[975]: ::1 2026-10-22 21:22:33.058 UTC [975] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-plv8> server # [ 19.154513] postgres[975]: ::1 2026-10-22 21:22:33.060 UTC [975] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-plv8> server # [ 19.155112] postgres[975]: ::1 2026-10-22 21:22:33.063 UTC [975] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-plv8> server # [ 19.155806] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: GRANT ROLE vm-test-run-plv8> server # [ 19.157904] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: CREATE SCHEMA vm-test-run-plv8> server # [ 19.856551] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: CREATE EXTENSION vm-test-run-plv8> server # [ 19.857979] postgres[975]: ::1 2026-10-22 21:22:33.768 UTC [975] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-plv8> server # [ 20.105043] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: CREATE EXTENSION vm-test-run-plv8> server # [ 20.106622] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: CREATE ROLE vm-test-run-plv8> server # [ 20.108603] postgres[975]: ::1 2026-10-22 21:22:34.016 UTC [975] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-plv8> server # [ 20.111522] postgres[975]: ::1 2026-10-22 21:22:34.018 UTC [975] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-plv8> server # [ 20.114313] postgres[975]: ::1 2026-10-22 21:22:34.019 UTC [975] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-plv8> server # [ 20.118040] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: CREATE ROLE vm-test-run-plv8> server # [ 20.119141] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: CREATE ROLE vm-test-run-plv8> server # [ 20.120661] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: CREATE ROLE vm-test-run-plv8> server # [ 20.121901] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: GRANT ROLE vm-test-run-plv8> server # [ 20.123157] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: GRANT ROLE vm-test-run-plv8> server # [ 20.124374] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: GRANT ROLE vm-test-run-plv8> server # [ 20.125423] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: GRANT ROLE vm-test-run-plv8> server # [ 20.126719] postgres[975]: ::1 2026-10-22 21:22:34.020 UTC [975] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-plv8> server # [ 20.128864] postgres[975]: ::1 2026-10-22 21:22:34.021 UTC [975] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-plv8> server # [ 20.131359] postgres[975]: ::1 2026-10-22 21:22:34.023 UTC [975] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-plv8> server # [ 20.133167] postgres[975]: ::1 2026-10-22 21:22:34.025 UTC [975] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-plv8> server # [ 20.134753] postgres[975]: ::1 2026-10-22 21:22:34.026 UTC [975] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-plv8> server # [ 20.136302] postgres[975]: ::1 2026-10-22 21:22:34.028 UTC [975] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 20.138271] postgres[975]: ::1 2026-10-22 21:22:34.030 UTC [975] 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 # [ 20.141408] postgres[975]: ::1 2026-10-22 21:22:34.033 UTC [975] 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 # [ 20.144444] postgres[975]: ::1 2026-10-22 21:22:34.034 UTC [975] 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 # [ 20.147546] postgres[975]: ::1 2026-10-22 21:22:34.036 UTC [975] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 20.150594] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: GRANT vm-test-run-plv8> server # [ 20.151683] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 20.153109] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 20.154163] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 20.155787] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: GRANT vm-test-run-plv8> server # [ 20.156708] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: ALTER ROLE vm-test-run-plv8> server # [ 20.158223] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 20.159466] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 20.160811] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 20.162121] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: ALTER ROLE vm-test-run-plv8> server # [ 20.163300] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[974]: ALTER ROLE vm-test-run-plv8> server # [ 20.164508] postgres[975]: ::1 2026-10-22 21:22:34.039 UTC [975] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-plv8> server # [ 20.164811] postgres[975]: ::1 2026-10-22 21:22:34.040 UTC [975] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 20.165862] postgres[975]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 20.166937] postgres[975]: ::1 2026-10-22 21:22:34.042 UTC [975] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 20.167638] postgres[975]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 20.168645] postgres[975]: ::1 2026-10-22 21:22:34.044 UTC [975] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 20.169471] postgres[975]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 20.170525] postgres[975]: ::1 2026-10-22 21:22:34.050 UTC [975] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-plv8> server # [ 20.170614] postgres[975]: ::1 2026-10-22 21:22:34.051 UTC [975] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-plv8> server # [ 20.171135] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-plv8> server # [ 20.211825] postgres[983]: ::1 2026-10-22 21:22:34.123 UTC [983] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 20.214869] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE SCHEMA vm-test-run-plv8> server # [ 20.216429] postgres[983]: ::1 2026-10-22 21:22:34.126 UTC [983] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-plv8> server # [ 20.218594] postgres[983]: instance_id uuid NULL, vm-test-run-plv8> server # [ 20.220197] postgres[983]: id uuid NOT NULL UNIQUE, vm-test-run-plv8> server # [ 20.221379] postgres[983]: aud varchar(255) NULL, vm-test-run-plv8> server # [ 20.221905] postgres[983]: "role" varchar(255) NULL, vm-test-run-plv8> server # [ 20.222258] postgres[983]: email varchar(255) NULL UNIQUE, vm-test-run-plv8> server # [ 20.222910] postgres[983]: encrypted_password varchar(255) NULL, vm-test-run-plv8> server # [ 20.224278] postgres[983]: confirmed_at timestamptz NULL, vm-test-run-plv8> server # [ 20.225113] postgres[983]: invited_at timestamptz NULL, vm-test-run-plv8> server # [ 20.226355] postgres[983]: confirmation_token varchar(255) NULL, vm-test-run-plv8> server # [ 20.227925] postgres[983]: confirmation_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 20.228377] postgres[983]: recovery_token varchar(255) NULL, vm-test-run-plv8> server # [ 20.229143] postgres[983]: recovery_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 20.229885] postgres[983]: email_change_token varchar(255) NULL, vm-test-run-plv8> server # [ 20.230710] postgres[983]: email_change varchar(255) NULL, vm-test-run-plv8> server # [ 20.232929] postgres[983]: email_change_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 20.234625] postgres[983]: last_sign_in_at timestamptz NULL, vm-test-run-plv8> server # [ 20.236218] postgres[983]: raw_app_meta_data jsonb NULL, vm-test-run-plv8> server # [ 20.238496] postgres[983]: raw_user_meta_data jsonb NULL, vm-test-run-plv8> server # [ 20.238596] postgres[983]: is_super_admin bool NULL, vm-test-run-plv8> server # [ 20.238671] postgres[983]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 20.238742] postgres[983]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 20.238840] postgres[983]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 20.238916] postgres[983]: ); vm-test-run-plv8> server # [ 20.258149] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE TABLE vm-test-run-plv8> server # [ 20.259754] postgres[983]: ::1 2026-10-22 21:22:34.170 UTC [983] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-plv8> server # [ 20.265768] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE INDEX vm-test-run-plv8> server # [ 20.266876] postgres[983]: ::1 2026-10-22 21:22:34.177 UTC [983] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-plv8> server # [ 20.274894] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE INDEX vm-test-run-plv8> server # [ 20.275907] postgres[983]: ::1 2026-10-22 21:22:34.186 UTC [983] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-plv8> server # [ 20.279440] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: COMMENT vm-test-run-plv8> server # [ 20.280516] postgres[983]: ::1 2026-10-22 21:22:34.190 UTC [983] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-plv8> server # [ 20.282233] postgres[983]: instance_id uuid NULL, vm-test-run-plv8> server # [ 20.282869] postgres[983]: id bigserial NOT NULL, vm-test-run-plv8> server # [ 20.282977] postgres[983]: "token" varchar(255) NULL, vm-test-run-plv8> server # [ 20.283088] postgres[983]: user_id varchar(255) NULL, vm-test-run-plv8> server # [ 20.283163] postgres[983]: revoked bool NULL, vm-test-run-plv8> server # [ 20.283234] postgres[983]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 20.283304] postgres[983]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 20.283373] postgres[983]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 20.283443] postgres[983]: ); vm-test-run-plv8> server # [ 20.295447] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE TABLE vm-test-run-plv8> server # [ 20.295616] postgres[983]: ::1 2026-10-22 21:22:34.206 UTC [983] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-plv8> server # [ 20.303520] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE INDEX vm-test-run-plv8> server # [ 20.304956] postgres[983]: ::1 2026-10-22 21:22:34.216 UTC [983] 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 # [ 20.309398] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE INDEX vm-test-run-plv8> server # [ 20.309543] postgres[983]: ::1 2026-10-22 21:22:34.220 UTC [983] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-plv8> server # [ 20.317889] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE INDEX vm-test-run-plv8> server # [ 20.319123] postgres[983]: ::1 2026-10-22 21:22:34.229 UTC [983] 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 # [ 20.322857] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: COMMENT vm-test-run-plv8> server # [ 20.324220] postgres[983]: ::1 2026-10-22 21:22:34.233 UTC [983] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-plv8> server # [ 20.324583] postgres[983]: id uuid NOT NULL, vm-test-run-plv8> server # [ 20.325723] postgres[983]: uuid uuid NULL, vm-test-run-plv8> server # [ 20.326881] postgres[983]: raw_base_config text NULL, vm-test-run-plv8> server # [ 20.327660] postgres[983]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 20.327957] postgres[983]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 20.328946] postgres[983]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 20.330252] postgres[983]: ); vm-test-run-plv8> server # [ 20.336829] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE TABLE vm-test-run-plv8> server # [ 20.338224] postgres[983]: ::1 2026-10-22 21:22:34.248 UTC [983] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-plv8> server # [ 20.340387] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: COMMENT vm-test-run-plv8> server # [ 20.341475] postgres[983]: ::1 2026-10-22 21:22:34.252 UTC [983] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-plv8> server # [ 20.341637] postgres[983]: instance_id uuid NULL, vm-test-run-plv8> server # [ 20.341739] postgres[983]: id uuid NOT NULL, vm-test-run-plv8> server # [ 20.343819] postgres[983]: payload json NULL, vm-test-run-plv8> server # [ 20.346079] postgres[983]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 20.346952] postgres[983]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 20.347914] postgres[983]: ); vm-test-run-plv8> server # [ 20.360980] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE TABLE vm-test-run-plv8> server # [ 20.362217] postgres[983]: ::1 2026-10-22 21:22:34.272 UTC [983] 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 # [ 20.367517] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE INDEX vm-test-run-plv8> server # [ 20.367672] postgres[983]: ::1 2026-10-22 21:22:34.279 UTC [983] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-plv8> server # [ 20.371497] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: COMMENT vm-test-run-plv8> server # [ 20.372566] postgres[983]: ::1 2026-10-22 21:22:34.283 UTC [983] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-plv8> server # [ 20.372665] postgres[983]: "version" varchar(255) NOT NULL, vm-test-run-plv8> server # [ 20.373896] postgres[983]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-plv8> server # [ 20.376561] postgres[983]: ); vm-test-run-plv8> server # [ 20.380444] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE TABLE vm-test-run-plv8> server # [ 20.381323] postgres[983]: ::1 2026-10-22 21:22:34.292 UTC [983] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-plv8> server # [ 20.385577] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: COMMENT vm-test-run-plv8> server # [ 20.389378] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: INSERT 0 7 vm-test-run-plv8> server # [ 20.390988] postgres[983]: ::1 2026-10-22 21:22:34.301 UTC [983] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-plv8> server # [ 20.392727] postgres[983]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-plv8> server # [ 20.393888] postgres[983]: $$ language sql stable; vm-test-run-plv8> server # [ 20.399671] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE FUNCTION vm-test-run-plv8> server # [ 20.401231] postgres[983]: ::1 2026-10-22 21:22:34.311 UTC [983] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-plv8> server # [ 20.401353] postgres[983]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-plv8> server # [ 20.401465] postgres[983]: $$ language sql stable; vm-test-run-plv8> server # [ 20.405455] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE FUNCTION vm-test-run-plv8> server # [ 20.406692] postgres[983]: ::1 2026-10-22 21:22:34.318 UTC [983] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-plv8> server # [ 20.408949] postgres[983]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-plv8> server # [ 20.409085] postgres[983]: $$ language sql stable; vm-test-run-plv8> server # [ 20.411589] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE FUNCTION vm-test-run-plv8> server # [ 20.412803] postgres[983]: ::1 2026-10-22 21:22:34.323 UTC [983] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-plv8> server # [ 20.415268] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: GRANT vm-test-run-plv8> server # [ 20.415823] postgres[983]: ::1 2026-10-22 21:22:34.326 UTC [983] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 20.420860] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: CREATE ROLE vm-test-run-plv8> server # [ 20.422434] postgres[983]: ::1 2026-10-22 21:22:34.332 UTC [983] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 20.424416] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: GRANT vm-test-run-plv8> server # [ 20.425870] postgres[983]: ::1 2026-10-22 21:22:34.336 UTC [983] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 20.429153] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: GRANT vm-test-run-plv8> server # [ 20.429443] postgres[983]: ::1 2026-10-22 21:22:34.340 UTC [983] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 20.432765] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: GRANT vm-test-run-plv8> server # [ 20.434264] postgres[983]: ::1 2026-10-22 21:22:34.344 UTC [983] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-plv8> server # [ 20.437116] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: ALTER ROLE vm-test-run-plv8> server # [ 20.438182] postgres[983]: ::1 2026-10-22 21:22:34.348 UTC [983] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 20.442269] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: ALTER TABLE vm-test-run-plv8> server # [ 20.444070] postgres[983]: ::1 2026-10-22 21:22:34.353 UTC [983] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 20.446197] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: ALTER TABLE vm-test-run-plv8> server # [ 20.447503] postgres[983]: ::1 2026-10-22 21:22:34.358 UTC [983] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 20.449841] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: ALTER TABLE vm-test-run-plv8> server # [ 20.451206] postgres[983]: ::1 2026-10-22 21:22:34.361 UTC [983] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 20.453914] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: ALTER TABLE vm-test-run-plv8> server # [ 20.455454] postgres[983]: ::1 2026-10-22 21:22:34.365 UTC [983] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 20.458342] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[982]: ALTER TABLE vm-test-run-plv8> server # [ 20.471274] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-plv8> server # [ 20.527187] postgres[985]: ::1 2026-10-22 21:22:34.438 UTC [985] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 20.531603] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[984]: CREATE SCHEMA vm-test-run-plv8> server # [ 20.533184] postgres[985]: ::1 2026-10-22 21:22:34.443 UTC [985] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 20.536328] postgres[985]: ::1 2026-10-22 21:22:34.444 UTC [985] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-plv8> server # [ 20.538733] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[984]: CREATE ROLE vm-test-run-plv8> server # [ 20.540296] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[984]: ALTER ROLE vm-test-run-plv8> server # [ 20.541455] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[984]: GRANT vm-test-run-plv8> server # [ 20.542456] postgres[985]: ::1 2026-10-22 21:22:34.446 UTC [985] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-plv8> server # [ 20.544861] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[984]: DO vm-test-run-plv8> server # [ 20.549463] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-plv8> server # [ 20.573677] dhcpcd[812]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-plv8> server # [ 20.576155] dhcpcd[812]: eth0: adding route to 10.0.2.0/24 vm-test-run-plv8> server # [ 20.577219] dhcpcd[812]: eth0: adding default route via 10.0.2.2 vm-test-run-plv8> server # [ 20.603870] postgres[991]: ::1 2026-10-22 21:22:34.515 UTC [991] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-plv8> server # [ 20.606688] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: ALTER ROLE vm-test-run-plv8> server # [ 20.608825] postgres[991]: ::1 2026-10-22 21:22:34.520 UTC [991] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-plv8> server # [ 20.610917] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: ALTER ROLE vm-test-run-plv8> server # [ 20.613577] postgres[991]: ::1 2026-10-22 21:22:34.524 UTC [991] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-plv8> server # [ 20.613692] postgres[991]: RETURNS event_trigger vm-test-run-plv8> server # [ 20.613818] postgres[991]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 20.614165] postgres[991]: AS $$ vm-test-run-plv8> server # [ 20.614937] postgres[991]: DECLARE vm-test-run-plv8> server # [ 20.615790] postgres[991]: schema_is_cron bool; vm-test-run-plv8> server # [ 20.616623] postgres[991]: BEGIN vm-test-run-plv8> server # [ 20.620897] postgres[991]: schema_is_cron = ( vm-test-run-plv8> server # [ 20.621657] postgres[991]: SELECT n.nspname = 'cron' vm-test-run-plv8> server # [ 20.621760] postgres[991]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 20.621980] postgres[991]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-plv8> server # [ 20.625721] postgres[991]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 20.626181] postgres[991]: ); vm-test-run-plv8> server # [ 20.626847] postgres[991]: vm-test-run-plv8> server # [ 20.627364] postgres[991]: IF schema_is_cron vm-test-run-plv8> server # [ 20.628226] postgres[991]: THEN vm-test-run-plv8> server # [ 20.628397] postgres[991]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 20.629246] postgres[991]: vm-test-run-plv8> server # [ 20.630317] postgres[991]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 20.630804] postgres[991]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 20.631832] postgres[991]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 20.632800] postgres[991]: vm-test-run-plv8> server # [ 20.633655] postgres[991]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 20.634578] postgres[991]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 20.635494] postgres[991]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 20.636249] postgres[991]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 20.637093] postgres[991]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 20.637656] postgres[991]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 20.638470] postgres[991]: vm-test-run-plv8> server # [ 20.639478] postgres[991]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 20.640315] postgres[991]: vm-test-run-plv8> server # [ 20.642875] postgres[991]: END IF; vm-test-run-plv8> server # [ 20.643095] postgres[991]: vm-test-run-plv8> server # [ 20.644071] postgres[991]: END; vm-test-run-plv8> server # [ 20.646458] postgres[991]: $$; vm-test-run-plv8> server # [ 20.648088] postgres[991]: ::1 2026-10-22 21:22:34.552 UTC [991] 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 # [ 20.649084] postgres[991]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 20.651164] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: CREATE FUNCTION vm-test-run-plv8> server # [ 20.653214] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 20.655631] postgres[991]: ::1 2026-10-22 21:22:34.566 UTC [991] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-plv8> server # [ 20.658421] postgres[991]: ::1 2026-10-22 21:22:34.570 UTC [991] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-plv8> server # [ 20.661091] postgres[991]: RETURNS event_trigger vm-test-run-plv8> server # [ 20.662131] postgres[991]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 20.663055] postgres[991]: AS $$ vm-test-run-plv8> server # [ 20.664238] postgres[991]: BEGIN vm-test-run-plv8> server # [ 20.664724] postgres[991]: IF EXISTS ( vm-test-run-plv8> server # [ 20.665571] postgres[991]: SELECT 1 vm-test-run-plv8> server # [ 20.666182] postgres[991]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 20.666863] postgres[991]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 20.667542] postgres[991]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 20.668909] postgres[991]: WHERE ext.extname = 'pg_net' vm-test-run-plv8> server # [ 20.669113] postgres[991]: ) vm-test-run-plv8> server # [ 20.670124] postgres[991]: THEN vm-test-run-plv8> server # [ 20.671275] postgres[991]: IF NOT EXISTS ( vm-test-run-plv8> server # [ 20.671862] postgres[991]: SELECT 1 vm-test-run-plv8> server # [ 20.673246] postgres[991]: FROM pg_roles vm-test-run-plv8> server # [ 20.675555] postgres[991]: WHERE rolname = 'supabase_functions_admin' vm-test-run-plv8> server # [ 20.675686] postgres[991]: ) vm-test-run-plv8> server # [ 20.675791] postgres[991]: THEN vm-test-run-plv8> server # [ 20.675888] postgres[991]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 20.675982] postgres[991]: END IF; vm-test-run-plv8> server # [ 20.676091] postgres[991]: vm-test-run-plv8> server # [ 20.676230] postgres[991]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 20.676336] postgres[991]: vm-test-run-plv8> server # [ 20.676433] postgres[991]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 20.676532] postgres[991]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 20.676635] postgres[991]: vm-test-run-plv8> server # [ 20.676740] postgres[991]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plv8> server # [ 20.677950] postgres[991]: 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 # [ 20.678158] postgres[991]: vm-test-run-plv8> server # [ 20.678257] postgres[991]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plv8> server # [ 20.679107] postgres[991]: 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 # [ 20.680096] postgres[991]: vm-test-run-plv8> server # [ 20.680867] postgres[991]: 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 # [ 20.682579] postgres[991]: 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 # [ 20.684971] postgres[991]: END IF; vm-test-run-plv8> server # [ 20.685102] postgres[991]: END; vm-test-run-plv8> server # [ 20.685198] postgres[991]: $$; vm-test-run-plv8> server # [ 20.685328] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: COMMENT vm-test-run-plv8> server # [ 20.685862] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: CREATE FUNCTION vm-test-run-plv8> server # [ 20.687358] postgres[991]: ::1 2026-10-22 21:22:34.586 UTC [991] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-plv8> server # [ 20.714206] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: COMMENT vm-test-run-plv8> server # [ 20.720262] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: DO vm-test-run-plv8> server # [ 20.724271] postgres[991]: ::1 2026-10-22 21:22:34.634 UTC [991] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-plv8> server # [ 20.728922] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: CREATE ROLE vm-test-run-plv8> server # [ 20.730165] postgres[991]: ::1 2026-10-22 21:22:34.641 UTC [991] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-plv8> server # [ 20.733052] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: GRANT vm-test-run-plv8> server # [ 20.734169] postgres[991]: ::1 2026-10-22 21:22:34.644 UTC [991] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 20.737315] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: GRANT vm-test-run-plv8> server # [ 20.737648] postgres[991]: ::1 2026-10-22 21:22:34.649 UTC [991] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 20.740040] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: GRANT vm-test-run-plv8> server # [ 20.741618] postgres[991]: ::1 2026-10-22 21:22:34.652 UTC [991] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 20.744195] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: GRANT vm-test-run-plv8> server # [ 20.744579] postgres[991]: ::1 2026-10-22 21:22:34.656 UTC [991] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 20.745181] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: GRANT vm-test-run-plv8> server # [ 20.747140] postgres[991]: ::1 2026-10-22 21:22:34.658 UTC [991] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 20.753305] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: GRANT vm-test-run-plv8> server # [ 20.754063] postgres[991]: ::1 2026-10-22 21:22:34.665 UTC [991] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 20.757419] postgres[991]: ::1 2026-10-22 21:22:34.665 UTC [991] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 20.759887] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: GRANT vm-test-run-plv8> server # [ 20.760252] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: GRANT vm-test-run-plv8> server # [ 20.760868] postgres[991]: ::1 2026-10-22 21:22:34.668 UTC [991] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 20.766516] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: GRANT vm-test-run-plv8> server # [ 20.768764] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[986]: DO vm-test-run-plv8> server # [ 20.779372] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running pgbouncer auth schema... vm-test-run-plv8> server # [ 20.849825] postgres[1019]: ::1 2026-10-22 21:22:34.760 UTC [1019] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-plv8> server # [ 20.855240] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[994]: CREATE ROLE vm-test-run-plv8> server # [ 20.855596] postgres[1019]: ::1 2026-10-22 21:22:34.767 UTC [1019] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-plv8> server # [ 20.859652] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[994]: REVOKE vm-test-run-plv8> server # [ 20.860934] postgres[1019]: ::1 2026-10-22 21:22:34.772 UTC [1019] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-plv8> server # [ 20.871738] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[994]: CREATE SCHEMA vm-test-run-plv8> server # [ 20.872119] postgres[1019]: ::1 2026-10-22 21:22:34.783 UTC [1019] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-plv8> server # [ 20.872825] postgres[1019]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-plv8> server # [ 20.876308] postgres[1019]: $$ vm-test-run-plv8> server # [ 20.876439] postgres[1019]: BEGIN vm-test-run-plv8> server # [ 20.876536] postgres[1019]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-plv8> server # [ 20.876664] postgres[1019]: vm-test-run-plv8> server # [ 20.876744] postgres[1019]: RETURN QUERY vm-test-run-plv8> server # [ 20.877934] postgres[1019]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-plv8> server # [ 20.879835] postgres[1019]: WHERE usename = p_usename; vm-test-run-plv8> server # [ 20.881062] postgres[1019]: END; vm-test-run-plv8> server # [ 20.884441] postgres[1019]: $$ LANGUAGE plpgsql vm-test-run-plv8> server # [ 20.886140] postgres[1019]: SET search_path = '' vm-test-run-plv8> server # [ 20.887329] postgres[1019]: SECURITY DEFINER; vm-test-run-plv8> server # [ 20.888297] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[994]: CREATE FUNCTION vm-test-run-plv8> server # [ 20.889456] postgres[1019]: ::1 2026-10-22 21:22:34.801 UTC [1019] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-plv8> server # [ 20.890693] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[994]: REVOKE vm-test-run-plv8> server # [ 20.892986] postgres[1019]: ::1 2026-10-22 21:22:34.804 UTC [1019] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-plv8> server # [ 20.897419] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[994]: GRANT vm-test-run-plv8> server # [ 20.911534] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running stat extension... vm-test-run-plv8> server # [ 20.968150] postgres[1034]: ::1 2026-10-22 21:22:34.879 UTC [1034] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-plv8> server # [ 20.970994] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1028]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-plv8> server # [ 20.974471] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1028]: CREATE SCHEMA vm-test-run-plv8> server # [ 20.975753] postgres[1034]: ::1 2026-10-22 21:22:34.887 UTC [1034] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-plv8> server # [ 21.042482] systemd[1]: Started DHCP Client. vm-test-run-plv8> server # [ 21.390403] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1028]: CREATE EXTENSION vm-test-run-plv8> server # [ 21.408296] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-plv8> server # [ 21.462850] postgres[1043]: ::1 2026-10-22 21:22:35.373 UTC [1043] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-plv8> server # [ 21.465709] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1042]: GRANT vm-test-run-plv8> server # [ 21.467357] postgres[1043]: ::1 2026-10-22 21:22:35.377 UTC [1043] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 21.471867] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1042]: GRANT vm-test-run-plv8> server # [ 21.473034] postgres[1043]: ::1 2026-10-22 21:22:35.383 UTC [1043] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 21.476384] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1042]: GRANT vm-test-run-plv8> server # [ 21.476542] postgres[1043]: ::1 2026-10-22 21:22:35.387 UTC [1043] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 21.480419] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1042]: GRANT vm-test-run-plv8> server # [ 21.481492] postgres[1043]: ::1 2026-10-22 21:22:35.391 UTC [1043] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 21.484470] postgres[1043]: ::1 2026-10-22 21:22:35.394 UTC [1043] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 21.486541] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1042]: GRANT vm-test-run-plv8> server # [ 21.487583] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1042]: GRANT vm-test-run-plv8> server # [ 21.488734] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1042]: GRANT vm-test-run-plv8> server # [ 21.489806] postgres[1043]: ::1 2026-10-22 21:22:35.396 UTC [1043] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 21.491870] postgres[1043]: ::1 2026-10-22 21:22:35.396 UTC [1043] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 21.494391] postgres[1043]: ::1 2026-10-22 21:22:35.405 UTC [1043] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 21.496661] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1042]: GRANT vm-test-run-plv8> server # [ 21.499363] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1042]: GRANT vm-test-run-plv8> server # [ 21.504162] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1042]: DO vm-test-run-plv8> server # [ 21.505482] postgres[1043]: ::1 2026-10-22 21:22:35.415 UTC [1043] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-plv8> server # [ 21.507990] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1042]: ALTER ROLE vm-test-run-plv8> server # [ 21.516992] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-plv8> server # [ 21.578550] postgres[1045]: ::1 2026-10-22 21:22:35.489 UTC [1045] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 21.582208] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: GRANT vm-test-run-plv8> server # [ 21.582342] postgres[1045]: ::1 2026-10-22 21:22:35.493 UTC [1045] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 21.585648] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: GRANT vm-test-run-plv8> server # [ 21.586759] postgres[1045]: ::1 2026-10-22 21:22:35.498 UTC [1045] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 21.589560] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: GRANT vm-test-run-plv8> server # [ 21.590688] postgres[1045]: ::1 2026-10-22 21:22:35.501 UTC [1045] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 21.593582] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: ALTER TABLE vm-test-run-plv8> server # [ 21.595280] postgres[1045]: ::1 2026-10-22 21:22:35.505 UTC [1045] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 21.597738] postgres[1045]: ::1 2026-10-22 21:22:35.506 UTC [1045] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 21.600311] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: ALTER TABLE vm-test-run-plv8> server # [ 21.601533] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: ALTER TABLE vm-test-run-plv8> server # [ 21.602521] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: ALTER TABLE vm-test-run-plv8> server # [ 21.603925] postgres[1045]: ::1 2026-10-22 21:22:35.508 UTC [1045] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 21.605732] postgres[1045]: ::1 2026-10-22 21:22:35.511 UTC [1045] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 21.607474] postgres[1045]: ::1 2026-10-22 21:22:35.514 UTC [1045] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 21.609206] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: ALTER TABLE vm-test-run-plv8> server # [ 21.610463] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: GRANT vm-test-run-plv8> server # [ 21.611458] postgres[1045]: ::1 2026-10-22 21:22:35.515 UTC [1045] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 21.613171] postgres[1045]: ::1 2026-10-22 21:22:35.521 UTC [1045] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 21.615445] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: GRANT vm-test-run-plv8> server # [ 21.616836] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: GRANT vm-test-run-plv8> server # [ 21.617927] postgres[1045]: ::1 2026-10-22 21:22:35.527 UTC [1045] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 21.622145] postgres[1045]: ::1 2026-10-22 21:22:35.528 UTC [1045] 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 # [ 21.624660] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: GRANT vm-test-run-plv8> server # [ 21.626546] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 21.626682] postgres[1045]: ::1 2026-10-22 21:22:35.537 UTC [1045] 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 # [ 21.630202] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 21.631612] postgres[1045]: ::1 2026-10-22 21:22:35.543 UTC [1045] 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 # [ 21.634159] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1044]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 21.646921] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-plv8> server # [ 21.702455] postgres[1047]: ::1 2026-10-22 21:22:35.613 UTC [1047] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-plv8> server # [ 21.706372] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1046]: CREATE SCHEMA vm-test-run-plv8> server # [ 21.719218] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-plv8> server # [ 21.776425] postgres[1049]: ::1 2026-10-22 21:22:35.687 UTC [1049] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-plv8> server # [ 21.781417] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1048]: GRANT vm-test-run-plv8> server # [ 21.782461] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1048]: GRANT vm-test-run-plv8> server # [ 21.784301] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1048]: GRANT vm-test-run-plv8> server # [ 21.785467] postgres[1049]: ::1 2026-10-22 21:22:35.693 UTC [1049] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 21.787691] postgres[1049]: ::1 2026-10-22 21:22:35.693 UTC [1049] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 21.790500] postgres[1049]: ::1 2026-10-22 21:22:35.694 UTC [1049] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 21.792926] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1048]: GRANT vm-test-run-plv8> server # [ 21.797375] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-plv8> server # [ 21.853655] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1050]: DO vm-test-run-plv8> server # [ 21.855171] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1050]: DO vm-test-run-plv8> server # [ 21.856241] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1050]: DO vm-test-run-plv8> server # [ 21.864798] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-plv8> server # [ 21.924266] postgres[1053]: ::1 2026-10-22 21:22:35.834 UTC [1053] 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 # [ 21.927623] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1052]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 21.929029] postgres[1053]: ::1 2026-10-22 21:22:35.839 UTC [1053] 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 # [ 21.931627] postgres[1053]: ::1 2026-10-22 21:22:35.842 UTC [1053] 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 # [ 21.934148] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1052]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 21.935980] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1052]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 21.946304] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-plv8> server # [ 21.997985] postgres[1055]: ::1 2026-10-22 21:22:35.909 UTC [1055] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-plv8> server # [ 22.002298] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1054]: ALTER ROLE vm-test-run-plv8> server # [ 22.009179] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-plv8> server # [ 22.050145] postgres[1061]: ::1 2026-10-22 21:22:35.961 UTC [1061] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 22.052508] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: 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 # [ 22.055435] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 22.057044] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: 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 # [ 22.061203] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: DROP FUNCTION vm-test-run-plv8> server # [ 22.062203] postgres[1061]: ::1 2026-10-22 21:22:35.963 UTC [1061] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 22.064040] postgres[1061]: ::1 2026-10-22 21:22:35.964 UTC [1061] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 22.066399] postgres[1061]: DECLARE vm-test-run-plv8> server # [ 22.067236] postgres[1061]: cmd record; vm-test-run-plv8> server # [ 22.067926] postgres[1061]: BEGIN vm-test-run-plv8> server # [ 22.068585] postgres[1061]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 22.069821] postgres[1061]: LOOP vm-test-run-plv8> server # [ 22.070743] postgres[1061]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 22.071699] postgres[1061]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 22.073140] postgres[1061]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 22.074276] postgres[1061]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 22.075631] postgres[1061]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 22.076574] postgres[1061]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 22.077584] postgres[1061]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 22.079074] postgres[1061]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 22.079923] postgres[1061]: , 'CREATE TYPE' vm-test-run-plv8> server # [ 22.080795] postgres[1061]: , 'CREATE RULE' vm-test-run-plv8> server # [ 22.081598] postgres[1061]: , 'COMMENT' vm-test-run-plv8> server # [ 22.082457] postgres[1061]: ) vm-test-run-plv8> server # [ 22.083517] postgres[1061]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 22.083642] postgres[1061]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 22.084643] postgres[1061]: THEN vm-test-run-plv8> server # [ 22.085701] postgres[1061]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 22.087791] postgres[1061]: END IF; vm-test-run-plv8> server # [ 22.087983] postgres[1061]: END LOOP; vm-test-run-plv8> server # [ 22.089129] postgres[1061]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 22.089669] postgres[1061]: ::1 2026-10-22 21:22:35.969 UTC [1061] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 22.090528] postgres[1061]: DECLARE vm-test-run-plv8> server # [ 22.091724] postgres[1061]: obj record; vm-test-run-plv8> server # [ 22.092613] postgres[1061]: BEGIN vm-test-run-plv8> server # [ 22.093582] postgres[1061]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 22.093764] postgres[1061]: LOOP vm-test-run-plv8> server # [ 22.093891] postgres[1061]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 22.093980] postgres[1061]: 'schema' vm-test-run-plv8> server # [ 22.094108] postgres[1061]: , 'table' vm-test-run-plv8> server # [ 22.094184] postgres[1061]: , 'foreign table' vm-test-run-plv8> server # [ 22.094257] postgres[1061]: , 'view' vm-test-run-plv8> server # [ 22.094328] postgres[1061]: , 'materialized view' vm-test-run-plv8> server # [ 22.094414] postgres[1061]: , 'function' vm-test-run-plv8> server # [ 22.094496] postgres[1061]: , 'trigger' vm-test-run-plv8> server # [ 22.094568] postgres[1061]: , 'type' vm-test-run-plv8> server # [ 22.094639] postgres[1061]: , 'rule' vm-test-run-plv8> server # [ 22.094710] postgres[1061]: ) vm-test-run-plv8> server # [ 22.094899] postgres[1061]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 22.096911] postgres[1061]: THEN vm-test-run-plv8> server # [ 22.097882] postgres[1061]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 22.100912] postgres[1061]: END IF; vm-test-run-plv8> server # [ 22.101830] postgres[1061]: END LOOP; vm-test-run-plv8> server # [ 22.104135] postgres[1061]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 22.104914] postgres[1061]: ::1 2026-10-22 21:22:35.970 UTC [1061] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 22.105501] postgres[1061]: ::1 2026-10-22 21:22:35.971 UTC [1061] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 22.106150] postgres[1061]: ON ddl_command_end vm-test-run-plv8> server # [ 22.106672] postgres[1061]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 22.107276] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: CREATE FUNCTION vm-test-run-plv8> server # [ 22.107767] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: CREATE FUNCTION vm-test-run-plv8> server # [ 22.108518] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: 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 # [ 22.109263] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 22.109713] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 22.110544] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: 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 # [ 22.111274] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 22.111936] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1059]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 22.112582] postgres[1061]: ::1 2026-10-22 21:22:35.975 UTC [1061] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 22.113384] postgres[1061]: ::1 2026-10-22 21:22:35.975 UTC [1061] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 22.114263] postgres[1061]: ON sql_drop vm-test-run-plv8> server # [ 22.116419] postgres[1061]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 22.120445] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-plv8> server # [ 22.395544] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1062]: DO vm-test-run-plv8> server # [ 22.403446] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-plv8> server # [ 22.452618] postgres[1065]: ::1 2026-10-22 21:22:36.364 UTC [1065] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-plv8> server # [ 22.456973] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: CREATE SCHEMA vm-test-run-plv8> server # [ 22.457648] postgres[1065]: ::1 2026-10-22 21:22:36.368 UTC [1065] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-plv8> server # [ 22.458654] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: 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 # [ 22.462604] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: DROP FUNCTION vm-test-run-plv8> server # [ 22.464281] postgres[1065]: ::1 2026-10-22 21:22:36.374 UTC [1065] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 22.467286] postgres[1065]: "operationName" text default null, vm-test-run-plv8> server # [ 22.468374] postgres[1065]: query text default null, vm-test-run-plv8> server # [ 22.469317] postgres[1065]: variables jsonb default null, vm-test-run-plv8> server # [ 22.470513] postgres[1065]: extensions jsonb default null vm-test-run-plv8> server # [ 22.471527] postgres[1065]: ) vm-test-run-plv8> server # [ 22.472215] postgres[1065]: returns jsonb vm-test-run-plv8> server # [ 22.473157] postgres[1065]: language plpgsql vm-test-run-plv8> server # [ 22.474471] postgres[1065]: as $$ vm-test-run-plv8> server # [ 22.475800] postgres[1065]: DECLARE vm-test-run-plv8> server # [ 22.476511] postgres[1065]: server_version float; vm-test-run-plv8> server # [ 22.477458] postgres[1065]: BEGIN vm-test-run-plv8> server # [ 22.478195] postgres[1065]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 22.479645] postgres[1065]: vm-test-run-plv8> server # [ 22.480296] postgres[1065]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 22.481274] postgres[1065]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 22.482320] postgres[1065]: 'data', null::jsonb, vm-test-run-plv8> server # [ 22.483314] postgres[1065]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 22.484375] postgres[1065]: ); vm-test-run-plv8> server # [ 22.485151] postgres[1065]: ELSE vm-test-run-plv8> server # [ 22.485813] postgres[1065]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 22.486816] postgres[1065]: 'data', null::jsonb, vm-test-run-plv8> server # [ 22.487737] postgres[1065]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 22.490086] postgres[1065]: ); vm-test-run-plv8> server # [ 22.490958] postgres[1065]: END IF; vm-test-run-plv8> server # [ 22.491906] postgres[1065]: END; vm-test-run-plv8> server # [ 22.492370] postgres[1065]: $$; vm-test-run-plv8> server # [ 22.492492] postgres[1065]: ::1 2026-10-22 21:22:36.377 UTC [1065] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.492563] postgres[1065]: ::1 2026-10-22 21:22:36.383 UTC [1065] 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 # [ 22.492631] postgres[1065]: ::1 2026-10-22 21:22:36.385 UTC [1065] 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 # [ 22.492697] postgres[1065]: ::1 2026-10-22 21:22:36.387 UTC [1065] 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 # [ 22.492789] postgres[1065]: ::1 2026-10-22 21:22:36.391 UTC [1065] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 22.492860] postgres[1065]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.492933] postgres[1065]: ::1 2026-10-22 21:22:36.397 UTC [1065] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 22.493049] postgres[1065]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.493167] postgres[1065]: ::1 2026-10-22 21:22:36.403 UTC [1065] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 22.493732] postgres[1065]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.494739] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: CREATE FUNCTION vm-test-run-plv8> server # [ 22.495315] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: GRANT vm-test-run-plv8> server # [ 22.495983] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 22.496631] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 22.497176] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 22.497648] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 22.498214] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 22.518839] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 22.520909] postgres[1065]: ::1 2026-10-22 21:22:36.432 UTC [1065] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 22.521425] postgres[1065]: RETURNS event_trigger vm-test-run-plv8> server # [ 22.522281] postgres[1065]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 22.522933] postgres[1065]: AS $func$ vm-test-run-plv8> server # [ 22.523537] postgres[1065]: DECLARE vm-test-run-plv8> server # [ 22.524479] postgres[1065]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 22.525238] postgres[1065]: BEGIN vm-test-run-plv8> server # [ 22.525899] postgres[1065]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 22.526748] postgres[1065]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 22.527743] postgres[1065]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 22.528504] postgres[1065]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 22.529200] postgres[1065]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 22.529919] postgres[1065]: ); vm-test-run-plv8> server # [ 22.530817] postgres[1065]: vm-test-run-plv8> server # [ 22.531086] postgres[1065]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 22.531937] postgres[1065]: THEN vm-test-run-plv8> server # [ 22.532750] postgres[1065]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.533386] postgres[1065]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.534280] postgres[1065]: vm-test-run-plv8> server # [ 22.534961] postgres[1065]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.536910] postgres[1065]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.537913] postgres[1065]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.538589] postgres[1065]: vm-test-run-plv8> server # [ 22.540092] postgres[1065]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 22.541139] postgres[1065]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 22.542227] postgres[1065]: "operationName" text default null, vm-test-run-plv8> server # [ 22.542978] postgres[1065]: query text default null, vm-test-run-plv8> server # [ 22.543918] postgres[1065]: variables jsonb default null, vm-test-run-plv8> server # [ 22.544931] postgres[1065]: extensions jsonb default null vm-test-run-plv8> server # [ 22.545988] postgres[1065]: ) vm-test-run-plv8> server # [ 22.547882] postgres[1065]: returns jsonb vm-test-run-plv8> server # [ 22.548943] postgres[1065]: language sql vm-test-run-plv8> server # [ 22.551119] postgres[1065]: as $$ vm-test-run-plv8> server # [ 22.551501] postgres[1065]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-plv8> server # [ 22.552183] postgres[1065]: $$; vm-test-run-plv8> server # [ 22.552296] postgres[1065]: vm-test-run-plv8> server # [ 22.552393] postgres[1065]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.552467] postgres[1065]: END IF; vm-test-run-plv8> server # [ 22.552534] postgres[1065]: vm-test-run-plv8> server # [ 22.552600] postgres[1065]: END; vm-test-run-plv8> server # [ 22.552698] postgres[1065]: $func$; vm-test-run-plv8> server # [ 22.557522] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: CREATE FUNCTION vm-test-run-plv8> server # [ 22.559039] postgres[1065]: ::1 2026-10-22 21:22:36.470 UTC [1065] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-plv8> server # [ 22.560883] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: 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 # [ 22.563766] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 22.565297] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 22.565768] postgres[1065]: ::1 2026-10-22 21:22:36.473 UTC [1065] 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 # [ 22.567436] postgres[1065]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-plv8> server # [ 22.570540] postgres[1065]: ::1 2026-10-22 21:22:36.475 UTC [1065] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-plv8> server # [ 22.572971] postgres[1065]: ::1 2026-10-22 21:22:36.480 UTC [1065] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 22.575416] postgres[1065]: RETURNS event_trigger vm-test-run-plv8> server # [ 22.576298] postgres[1065]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 22.576871] postgres[1065]: AS $func$ vm-test-run-plv8> server # [ 22.577539] postgres[1065]: DECLARE vm-test-run-plv8> server # [ 22.578276] postgres[1065]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 22.579982] postgres[1065]: BEGIN vm-test-run-plv8> server # [ 22.580925] postgres[1065]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 22.581794] postgres[1065]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 22.582984] postgres[1065]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 22.584174] postgres[1065]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 22.585048] postgres[1065]: ); vm-test-run-plv8> server # [ 22.585549] postgres[1065]: vm-test-run-plv8> server # [ 22.586118] postgres[1065]: IF graphql_is_dropped vm-test-run-plv8> server # [ 22.586961] postgres[1065]: THEN vm-test-run-plv8> server # [ 22.587502] postgres[1065]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 22.588606] postgres[1065]: "operationName" text default null, vm-test-run-plv8> server # [ 22.589940] postgres[1065]: query text default null, vm-test-run-plv8> server # [ 22.590085] postgres[1065]: variables jsonb default null, vm-test-run-plv8> server # [ 22.590174] postgres[1065]: extensions jsonb default null vm-test-run-plv8> server # [ 22.590312] postgres[1065]: ) vm-test-run-plv8> server # [ 22.591123] postgres[1065]: returns jsonb vm-test-run-plv8> server # [ 22.592169] postgres[1065]: language plpgsql vm-test-run-plv8> server # [ 22.592929] postgres[1065]: as $$ vm-test-run-plv8> server # [ 22.593720] postgres[1065]: DECLARE vm-test-run-plv8> server # [ 22.594475] postgres[1065]: server_version float; vm-test-run-plv8> server # [ 22.595277] postgres[1065]: BEGIN vm-test-run-plv8> server # [ 22.595954] postgres[1065]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 22.596706] postgres[1065]: vm-test-run-plv8> server # [ 22.597422] postgres[1065]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 22.598323] postgres[1065]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 22.599126] postgres[1065]: 'data', null::jsonb, vm-test-run-plv8> server # [ 22.599794] postgres[1065]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 22.600500] postgres[1065]: ); vm-test-run-plv8> server # [ 22.601230] postgres[1065]: ELSE vm-test-run-plv8> server # [ 22.601969] postgres[1065]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 22.602903] postgres[1065]: 'data', null::jsonb, vm-test-run-plv8> server # [ 22.603739] postgres[1065]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 22.604561] postgres[1065]: ); vm-test-run-plv8> server # [ 22.605288] postgres[1065]: END IF; vm-test-run-plv8> server # [ 22.605908] postgres[1065]: END; vm-test-run-plv8> server # [ 22.608322] postgres[1065]: $$; vm-test-run-plv8> server # [ 22.608954] postgres[1065]: END IF; vm-test-run-plv8> server # [ 22.609394] postgres[1065]: vm-test-run-plv8> server # [ 22.609817] postgres[1065]: END; vm-test-run-plv8> server # [ 22.610337] postgres[1065]: $func$; vm-test-run-plv8> server # [ 22.610856] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: COMMENT vm-test-run-plv8> server # [ 22.611589] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: CREATE FUNCTION vm-test-run-plv8> server # [ 22.612191] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: 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 # [ 22.615288] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 22.615737] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 22.616455] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1064]: COMMENT vm-test-run-plv8> server # [ 22.617044] postgres[1065]: ::1 2026-10-22 21:22:36.490 UTC [1065] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-plv8> server # [ 22.617687] postgres[1065]: ::1 2026-10-22 21:22:36.491 UTC [1065] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-plv8> server # [ 22.618425] postgres[1065]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-plv8> server # [ 22.619207] postgres[1065]: ::1 2026-10-22 21:22:36.498 UTC [1065] 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 # [ 22.638913] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-plv8> server # [ 22.681754] postgres[1067]: ::1 2026-10-22 21:22:36.593 UTC [1067] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 22.683669] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1066]: 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 # [ 22.685856] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1066]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 22.687589] postgres[1067]: ::1 2026-10-22 21:22:36.593 UTC [1067] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 22.688180] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1066]: 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 # [ 22.693920] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1066]: DROP FUNCTION vm-test-run-plv8> server # [ 22.694574] postgres[1067]: ::1 2026-10-22 21:22:36.605 UTC [1067] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 22.695114] postgres[1067]: DECLARE vm-test-run-plv8> server # [ 22.695703] postgres[1067]: cmd record; vm-test-run-plv8> server # [ 22.697223] postgres[1067]: BEGIN vm-test-run-plv8> server # [ 22.698715] postgres[1067]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 22.700691] postgres[1067]: LOOP vm-test-run-plv8> server # [ 22.703885] postgres[1067]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 22.704410] postgres[1067]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 22.705964] postgres[1067]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 22.706101] postgres[1067]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 22.706597] postgres[1067]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 22.707443] postgres[1067]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 22.708155] postgres[1067]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 22.708928] postgres[1067]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 22.709700] postgres[1067]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-plv8> server # [ 22.711510] postgres[1067]: , 'CREATE RULE' vm-test-run-plv8> server # [ 22.712211] postgres[1067]: , 'COMMENT' vm-test-run-plv8> server # [ 22.712786] postgres[1067]: ) vm-test-run-plv8> server # [ 22.712897] postgres[1067]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 22.713105] postgres[1067]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 22.713679] postgres[1067]: THEN vm-test-run-plv8> server # [ 22.714567] postgres[1067]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 22.715441] postgres[1067]: END IF; vm-test-run-plv8> server # [ 22.716193] postgres[1067]: END LOOP; vm-test-run-plv8> server # [ 22.716878] postgres[1067]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 22.720845] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1066]: CREATE FUNCTION vm-test-run-plv8> server # [ 22.721454] postgres[1067]: ::1 2026-10-22 21:22:36.632 UTC [1067] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 22.722284] postgres[1067]: DECLARE vm-test-run-plv8> server # [ 22.723173] postgres[1067]: obj record; vm-test-run-plv8> server # [ 22.723912] postgres[1067]: BEGIN vm-test-run-plv8> server # [ 22.726138] postgres[1067]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 22.727482] postgres[1067]: LOOP vm-test-run-plv8> server # [ 22.729052] postgres[1067]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 22.729766] postgres[1067]: 'schema' vm-test-run-plv8> server # [ 22.731179] postgres[1067]: , 'table' vm-test-run-plv8> server # [ 22.731724] postgres[1067]: , 'foreign table' vm-test-run-plv8> server # [ 22.733588] postgres[1067]: , 'view' vm-test-run-plv8> server # [ 22.735967] postgres[1067]: , 'materialized view' vm-test-run-plv8> server # [ 22.736108] postgres[1067]: , 'function' vm-test-run-plv8> server # [ 22.736211] postgres[1067]: , 'trigger' vm-test-run-plv8> server # [ 22.736307] postgres[1067]: , 'type' vm-test-run-plv8> server # [ 22.736399] postgres[1067]: , 'rule' vm-test-run-plv8> server # [ 22.737282] postgres[1067]: ) vm-test-run-plv8> server # [ 22.738087] postgres[1067]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 22.738949] postgres[1067]: THEN vm-test-run-plv8> server # [ 22.739910] postgres[1067]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 22.740769] postgres[1067]: END IF; vm-test-run-plv8> server # [ 22.741701] postgres[1067]: END LOOP; vm-test-run-plv8> server # [ 22.742862] postgres[1067]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 22.743291] postgres[1067]: ::1 2026-10-22 21:22:36.646 UTC [1067] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 22.744524] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1066]: CREATE FUNCTION vm-test-run-plv8> server # [ 22.747467] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1066]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 22.748147] postgres[1067]: ::1 2026-10-22 21:22:36.659 UTC [1067] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 22.749185] postgres[1067]: ON ddl_command_end vm-test-run-plv8> server # [ 22.750375] postgres[1067]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 22.752720] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1066]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 22.753346] postgres[1067]: ::1 2026-10-22 21:22:36.664 UTC [1067] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 22.756524] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1066]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 22.757825] postgres[1067]: ::1 2026-10-22 21:22:36.668 UTC [1067] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 22.759678] postgres[1067]: ON sql_drop vm-test-run-plv8> server # [ 22.760277] postgres[1067]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 22.762647] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1066]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 22.777670] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-plv8> server # [ 22.815114] postgres[1069]: ::1 2026-10-22 21:22:36.726 UTC [1069] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-plv8> server # [ 22.817626] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1068]: ALTER ROLE vm-test-run-plv8> server # [ 22.824549] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-plv8> server # [ 22.868246] postgres[1072]: ::1 2026-10-22 21:22:36.778 UTC [1072] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 22.870619] postgres[1072]: returns event_trigger vm-test-run-plv8> server # [ 22.871552] postgres[1072]: language plpgsql vm-test-run-plv8> server # [ 22.872337] postgres[1072]: AS $func$ vm-test-run-plv8> server # [ 22.872869] postgres[1072]: DECLARE vm-test-run-plv8> server # [ 22.873703] postgres[1072]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 22.874596] postgres[1072]: BEGIN vm-test-run-plv8> server # [ 22.875215] postgres[1072]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 22.875982] postgres[1072]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 22.876727] postgres[1072]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 22.878735] postgres[1072]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 22.880209] postgres[1072]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 22.881162] postgres[1072]: ); vm-test-run-plv8> server # [ 22.881749] postgres[1072]: vm-test-run-plv8> server # [ 22.882355] postgres[1072]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 22.883353] postgres[1072]: THEN vm-test-run-plv8> server # [ 22.884096] postgres[1072]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.885842] postgres[1072]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.887653] postgres[1072]: vm-test-run-plv8> server # [ 22.888293] postgres[1072]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.890239] postgres[1072]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.892870] postgres[1072]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.895255] postgres[1072]: vm-test-run-plv8> server # [ 22.895821] postgres[1072]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 22.897411] postgres[1072]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 22.898715] postgres[1072]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 22.899731] postgres[1072]: "operationName" text default null, vm-test-run-plv8> server # [ 22.901142] postgres[1072]: query text default null, vm-test-run-plv8> server # [ 22.902535] postgres[1072]: variables jsonb default null, vm-test-run-plv8> server # [ 22.903707] postgres[1072]: extensions jsonb default null vm-test-run-plv8> server # [ 22.904814] postgres[1072]: ) vm-test-run-plv8> server # [ 22.905491] postgres[1072]: returns jsonb vm-test-run-plv8> server # [ 22.906496] postgres[1072]: language sql vm-test-run-plv8> server # [ 22.907292] postgres[1072]: as $$ vm-test-run-plv8> server # [ 22.907883] postgres[1072]: -- This changed vm-test-run-plv8> server # [ 22.908520] postgres[1072]: select graphql.resolve( vm-test-run-plv8> server # [ 22.909570] postgres[1072]: query := query, vm-test-run-plv8> server # [ 22.910537] postgres[1072]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 22.911590] postgres[1072]: "operationName" := "operationName", vm-test-run-plv8> server # [ 22.912501] postgres[1072]: extensions := extensions vm-test-run-plv8> server # [ 22.913327] postgres[1072]: ); vm-test-run-plv8> server # [ 22.913937] postgres[1072]: $$; vm-test-run-plv8> server # [ 22.914587] postgres[1072]: vm-test-run-plv8> server # [ 22.915147] postgres[1072]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 22.916910] postgres[1072]: END IF; vm-test-run-plv8> server # [ 22.917572] postgres[1072]: vm-test-run-plv8> server # [ 22.918097] postgres[1072]: END; vm-test-run-plv8> server # [ 22.918697] postgres[1072]: $func$; vm-test-run-plv8> server # [ 22.919539] postgres[1072]: ::1 2026-10-22 21:22:36.788 UTC [1072] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 22.921794] postgres[1072]: RETURNS event_trigger vm-test-run-plv8> server # [ 22.922527] postgres[1072]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 22.923466] postgres[1072]: AS $func$ vm-test-run-plv8> server # [ 22.924115] postgres[1072]: DECLARE vm-test-run-plv8> server # [ 22.924646] postgres[1072]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 22.925428] postgres[1072]: BEGIN vm-test-run-plv8> server # [ 22.926163] postgres[1072]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 22.927055] postgres[1072]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 22.928342] postgres[1072]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 22.930476] postgres[1072]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 22.931937] postgres[1072]: ); vm-test-run-plv8> server # [ 22.932955] postgres[1072]: vm-test-run-plv8> server # [ 22.933083] postgres[1072]: IF graphql_is_dropped vm-test-run-plv8> server # [ 22.933183] postgres[1072]: THEN vm-test-run-plv8> server # [ 22.934273] postgres[1072]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 22.934963] postgres[1072]: "operationName" text default null, vm-test-run-plv8> server # [ 22.935935] postgres[1072]: query text default null, vm-test-run-plv8> server # [ 22.936963] postgres[1072]: variables jsonb default null, vm-test-run-plv8> server # [ 22.938507] postgres[1072]: extensions jsonb default null vm-test-run-plv8> server # [ 22.939627] postgres[1072]: ) vm-test-run-plv8> server # [ 22.940806] postgres[1072]: returns jsonb vm-test-run-plv8> server # [ 22.941670] postgres[1072]: language plpgsql vm-test-run-plv8> server # [ 22.941879] postgres[1072]: as $$ vm-test-run-plv8> server # [ 22.942692] postgres[1072]: DECLARE vm-test-run-plv8> server # [ 22.943882] postgres[1072]: server_version float; vm-test-run-plv8> server # [ 22.944402] postgres[1072]: BEGIN vm-test-run-plv8> server # [ 22.945593] postgres[1072]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 22.945865] postgres[1072]: vm-test-run-plv8> server # [ 22.946898] postgres[1072]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 22.947919] postgres[1072]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 22.948715] postgres[1072]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 22.949602] postgres[1072]: jsonb_build_object( vm-test-run-plv8> server # [ 22.950525] postgres[1072]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 22.951509] postgres[1072]: ) vm-test-run-plv8> server # [ 22.952370] postgres[1072]: ) vm-test-run-plv8> server # [ 22.953209] postgres[1072]: ); vm-test-run-plv8> server # [ 22.953967] postgres[1072]: ELSE vm-test-run-plv8> server # [ 22.954319] postgres[1072]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 22.955181] postgres[1072]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 22.956146] postgres[1072]: jsonb_build_object( vm-test-run-plv8> server # [ 22.956799] postgres[1072]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 22.957587] postgres[1072]: ) vm-test-run-plv8> server # [ 22.959725] postgres[1072]: ) vm-test-run-plv8> server # [ 22.961623] postgres[1072]: ); vm-test-run-plv8> server # [ 22.962521] postgres[1072]: END IF; vm-test-run-plv8> server # [ 22.962638] postgres[1072]: END; vm-test-run-plv8> server # [ 22.963205] postgres[1072]: $$; vm-test-run-plv8> server # [ 22.964063] postgres[1072]: END IF; vm-test-run-plv8> server # [ 22.964688] postgres[1072]: vm-test-run-plv8> server # [ 22.965461] postgres[1072]: END; vm-test-run-plv8> server # [ 22.966048] postgres[1072]: $func$; vm-test-run-plv8> server # [ 22.966264] postgres[1072]: ::1 2026-10-22 21:22:36.792 UTC [1072] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 22.967879] postgres[1072]: "operationName" text default null, vm-test-run-plv8> server # [ 22.968885] postgres[1072]: query text default null, vm-test-run-plv8> server # [ 22.971645] postgres[1072]: variables jsonb default null, vm-test-run-plv8> server # [ 22.973489] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1070]: CREATE FUNCTION vm-test-run-plv8> server # [ 22.973587] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1070]: CREATE FUNCTION vm-test-run-plv8> server # [ 22.973659] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1070]: CREATE FUNCTION vm-test-run-plv8> server # [ 22.973723] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1070]: 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 # [ 22.974137] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1070]: DROP EXTENSION vm-test-run-plv8> server # [ 22.974757] postgres[1072]: extensions jsonb default null vm-test-run-plv8> server # [ 22.976344] postgres[1072]: ) vm-test-run-plv8> server # [ 22.977544] postgres[1072]: returns jsonb vm-test-run-plv8> server # [ 22.978600] postgres[1072]: language plpgsql vm-test-run-plv8> server # [ 22.980922] postgres[1072]: as $$ vm-test-run-plv8> server # [ 22.981852] postgres[1072]: DECLARE vm-test-run-plv8> server # [ 22.982588] postgres[1072]: server_version float; vm-test-run-plv8> server # [ 22.983630] postgres[1072]: BEGIN vm-test-run-plv8> server # [ 22.984584] postgres[1072]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 22.985538] postgres[1072]: vm-test-run-plv8> server # [ 22.986292] postgres[1072]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 22.987059] postgres[1072]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 22.987662] postgres[1072]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 22.988861] postgres[1072]: jsonb_build_object( vm-test-run-plv8> server # [ 22.990201] postgres[1072]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 22.990990] postgres[1072]: ) vm-test-run-plv8> server # [ 22.992065] postgres[1072]: ) vm-test-run-plv8> server # [ 22.993247] postgres[1072]: ); vm-test-run-plv8> server # [ 22.993935] postgres[1072]: ELSE vm-test-run-plv8> server # [ 22.994577] postgres[1072]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 22.995261] postgres[1072]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 22.996107] postgres[1072]: jsonb_build_object( vm-test-run-plv8> server # [ 22.996743] postgres[1072]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 22.997466] postgres[1072]: ) vm-test-run-plv8> server # [ 22.998269] postgres[1072]: ) vm-test-run-plv8> server # [ 22.999378] postgres[1072]: ); vm-test-run-plv8> server # [ 23.000248] postgres[1072]: END IF; vm-test-run-plv8> server # [ 23.001098] postgres[1072]: END; vm-test-run-plv8> server # [ 23.001311] postgres[1072]: $$; vm-test-run-plv8> server # [ 23.002117] postgres[1072]: ::1 2026-10-22 21:22:36.802 UTC [1072] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 23.582866] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1070]: DO vm-test-run-plv8> server # [ 23.597608] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: 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 # [ 23.652487] postgres[1078]: ::1 2026-10-22 21:22:37.563 UTC [1078] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-plv8> server # [ 23.656127] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1077]: GRANT ROLE vm-test-run-plv8> server # [ 23.668432] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-plv8> server # [ 23.744627] postgres[1080]: ::1 2026-10-22 21:22:37.654 UTC [1080] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 23.744874] postgres[1080]: returns event_trigger vm-test-run-plv8> server # [ 23.747067] postgres[1080]: language plpgsql vm-test-run-plv8> server # [ 23.747845] postgres[1080]: AS $func$ vm-test-run-plv8> server # [ 23.748598] postgres[1080]: DECLARE vm-test-run-plv8> server # [ 23.749473] postgres[1080]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 23.750867] postgres[1080]: BEGIN vm-test-run-plv8> server # [ 23.750978] postgres[1080]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 23.751111] postgres[1080]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 23.751284] postgres[1080]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 23.751353] postgres[1080]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 23.751421] postgres[1080]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 23.751488] postgres[1080]: ); vm-test-run-plv8> server # [ 23.751554] postgres[1080]: vm-test-run-plv8> server # [ 23.751627] postgres[1080]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 23.751692] postgres[1080]: THEN vm-test-run-plv8> server # [ 23.751839] postgres[1080]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 23.752809] postgres[1080]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 23.755282] postgres[1080]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 23.757226] postgres[1080]: "operationName" text default null, vm-test-run-plv8> server # [ 23.758841] postgres[1080]: query text default null, vm-test-run-plv8> server # [ 23.760622] postgres[1080]: variables jsonb default null, vm-test-run-plv8> server # [ 23.762340] postgres[1080]: extensions jsonb default null vm-test-run-plv8> server # [ 23.763408] postgres[1080]: ) vm-test-run-plv8> server # [ 23.763505] postgres[1080]: returns jsonb vm-test-run-plv8> server # [ 23.763604] postgres[1080]: language sql vm-test-run-plv8> server # [ 23.763698] postgres[1080]: as $$ vm-test-run-plv8> server # [ 23.763799] postgres[1080]: select graphql.resolve( vm-test-run-plv8> server # [ 23.764578] postgres[1080]: query := query, vm-test-run-plv8> server # [ 23.765479] postgres[1080]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 23.766250] postgres[1080]: "operationName" := "operationName", vm-test-run-plv8> server # [ 23.767128] postgres[1080]: extensions := extensions vm-test-run-plv8> server # [ 23.767906] postgres[1080]: ); vm-test-run-plv8> server # [ 23.769068] postgres[1080]: $$; vm-test-run-plv8> server # [ 23.769799] postgres[1080]: vm-test-run-plv8> server # [ 23.771321] postgres[1080]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 23.772196] postgres[1080]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 23.772985] postgres[1080]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 23.774066] postgres[1080]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 23.775746] postgres[1080]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 23.776678] postgres[1080]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 23.777661] postgres[1080]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 23.778500] postgres[1080]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 23.780871] postgres[1080]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 23.786881] postgres[1080]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 23.788841] postgres[1080]: END IF; vm-test-run-plv8> server # [ 23.791122] postgres[1080]: vm-test-run-plv8> server # [ 23.792052] postgres[1080]: END; vm-test-run-plv8> server # [ 23.794264] postgres[1080]: $func$; vm-test-run-plv8> server # [ 23.799837] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1079]: CREATE FUNCTION vm-test-run-plv8> server # [ 23.801145] postgres[1080]: ::1 2026-10-22 21:22:37.712 UTC [1080] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 23.808031] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1079]: DROP EXTENSION vm-test-run-plv8> server # [ 24.300251] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1079]: DO vm-test-run-plv8> server # [ 24.309657] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-plv8> server # [ 24.592377] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1085]: DO vm-test-run-plv8> server # [ 24.778256] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1085]: DO vm-test-run-plv8> server # [ 24.788345] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-plv8> server # [ 24.831237] postgres[1088]: ::1 2026-10-22 21:22:38.742 UTC [1088] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-plv8> server # [ 24.834560] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1087]: ALTER ROLE vm-test-run-plv8> server # [ 24.842378] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-plv8> server # [ 24.894492] postgres[1090]: ::1 2026-10-22 21:22:38.805 UTC [1090] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-plv8> server # [ 24.897797] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1089]: REVOKE ROLE vm-test-run-plv8> server # [ 24.903866] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-plv8> server # [ 25.447267] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1091]: DO vm-test-run-plv8> server # [ 25.456751] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-plv8> server # [ 25.504248] postgres[1098]: ::1 2026-10-22 21:22:39.415 UTC [1098] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-plv8> server # [ 25.507700] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1097]: GRANT ROLE vm-test-run-plv8> server # [ 25.515546] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-plv8> server # [ 25.558678] postgres[1100]: ::1 2026-10-22 21:22:39.469 UTC [1100] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 25.565222] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1099]: GRANT vm-test-run-plv8> server # [ 25.567046] postgres[1100]: ::1 2026-10-22 21:22:39.476 UTC [1100] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 25.572559] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1099]: GRANT vm-test-run-plv8> server # [ 25.573847] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1099]: GRANT vm-test-run-plv8> server # [ 25.574873] postgres[1100]: ::1 2026-10-22 21:22:39.484 UTC [1100] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 25.576921] postgres[1100]: ::1 2026-10-22 21:22:39.485 UTC [1100] 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 # [ 25.579437] postgres[1100]: ::1 2026-10-22 21:22:39.487 UTC [1100] 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 # [ 25.582059] postgres[1100]: ::1 2026-10-22 21:22:39.489 UTC [1100] 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 # [ 25.585436] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1099]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 25.586652] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1099]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 25.588191] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1099]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 25.592424] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-plv8> server # [ 25.636274] postgres[1102]: ::1 2026-10-22 21:22:39.547 UTC [1102] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-plv8> server # [ 25.639919] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1101]: GRANT ROLE vm-test-run-plv8> server # [ 25.650522] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 25.690137] postgres[1104]: ::1 2026-10-22 21:22:39.601 UTC [1104] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-plv8> server # [ 25.693096] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1103]: GRANT ROLE vm-test-run-plv8> server # [ 25.703148] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-plv8> server # [ 25.768165] postgres[1106]: ::1 2026-10-22 21:22:39.679 UTC [1106] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-plv8> server # [ 25.770329] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1105]: ALTER ROLE vm-test-run-plv8> server # [ 25.771536] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1105]: ALTER ROLE vm-test-run-plv8> server # [ 25.772891] postgres[1106]: ::1 2026-10-22 21:22:39.682 UTC [1106] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-plv8> server # [ 25.774739] postgres[1106]: ::1 2026-10-22 21:22:39.683 UTC [1106] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-plv8> server # [ 25.776579] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1105]: ALTER ROLE vm-test-run-plv8> server # [ 25.778921] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1105]: DO vm-test-run-plv8> server # [ 25.783524] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 25.828304] postgres[1108]: ::1 2026-10-22 21:22:39.739 UTC [1108] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-plv8> server # [ 25.830916] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1107]: GRANT ROLE vm-test-run-plv8> server # [ 25.833246] postgres[1108]: ::1 2026-10-22 21:22:39.744 UTC [1108] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-plv8> server # [ 25.836464] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1107]: REVOKE ROLE vm-test-run-plv8> server # [ 25.848167] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-plv8> server # [ 25.890696] postgres[1110]: ::1 2026-10-22 21:22:39.799 UTC [1110] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 25.891367] postgres[1110]: returns event_trigger vm-test-run-plv8> server # [ 25.892449] postgres[1110]: language plpgsql vm-test-run-plv8> server # [ 25.893133] postgres[1110]: AS $func$ vm-test-run-plv8> server # [ 25.894562] postgres[1110]: DECLARE vm-test-run-plv8> server # [ 25.895186] postgres[1110]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 25.897147] postgres[1110]: BEGIN vm-test-run-plv8> server # [ 25.897734] postgres[1110]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 25.898766] postgres[1110]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 25.900431] postgres[1110]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 25.900999] postgres[1110]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 25.903055] postgres[1110]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 25.904228] postgres[1110]: ); vm-test-run-plv8> server # [ 25.904626] postgres[1110]: vm-test-run-plv8> server # [ 25.905121] postgres[1110]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 25.905526] postgres[1110]: THEN vm-test-run-plv8> server # [ 25.906274] postgres[1110]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 25.906872] postgres[1110]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 25.907760] postgres[1110]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 25.908635] postgres[1110]: "operationName" text default null, vm-test-run-plv8> server # [ 25.909602] postgres[1110]: query text default null, vm-test-run-plv8> server # [ 25.910656] postgres[1110]: variables jsonb default null, vm-test-run-plv8> server # [ 25.911498] postgres[1110]: extensions jsonb default null vm-test-run-plv8> server # [ 25.912278] postgres[1110]: ) vm-test-run-plv8> server # [ 25.913211] postgres[1110]: returns jsonb vm-test-run-plv8> server # [ 25.913481] postgres[1110]: language sql vm-test-run-plv8> server # [ 25.914361] postgres[1110]: as $$ vm-test-run-plv8> server # [ 25.915252] postgres[1110]: select graphql.resolve( vm-test-run-plv8> server # [ 25.915772] postgres[1110]: query := query, vm-test-run-plv8> server # [ 25.916490] postgres[1110]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 25.917363] postgres[1110]: "operationName" := "operationName", vm-test-run-plv8> server # [ 25.918263] postgres[1110]: extensions := extensions vm-test-run-plv8> server # [ 25.918900] postgres[1110]: ); vm-test-run-plv8> server # [ 25.919900] postgres[1110]: $$; vm-test-run-plv8> server # [ 25.920060] postgres[1110]: vm-test-run-plv8> server # [ 25.920674] postgres[1110]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 25.921129] postgres[1110]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 25.921859] postgres[1110]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 25.923070] postgres[1110]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.923827] postgres[1110]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.926112] postgres[1110]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.926762] postgres[1110]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.927655] postgres[1110]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.928645] postgres[1110]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.929671] postgres[1110]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.930456] postgres[1110]: vm-test-run-plv8> server # [ 25.931574] postgres[1110]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-plv8> server # [ 25.932515] postgres[1110]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-plv8> server # [ 25.933659] postgres[1110]: grant usage on schema graphql to postgres with grant option; vm-test-run-plv8> server # [ 25.934553] postgres[1110]: END IF; vm-test-run-plv8> server # [ 25.936485] postgres[1110]: vm-test-run-plv8> server # [ 25.937372] postgres[1110]: END; vm-test-run-plv8> server # [ 25.938184] postgres[1110]: $func$; vm-test-run-plv8> server # [ 25.946402] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1109]: CREATE FUNCTION vm-test-run-plv8> server # [ 25.947111] postgres[1110]: ::1 2026-10-22 21:22:39.855 UTC [1110] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 25.951670] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1109]: DROP EXTENSION vm-test-run-plv8> server # [ 26.401161] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1109]: DO vm-test-run-plv8> server # [ 26.413204] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-plv8> server # [ 26.461243] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1112]: DO vm-test-run-plv8> server # [ 26.462340] postgres[1116]: ::1 2026-10-22 21:22:40.372 UTC [1116] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-plv8> server # [ 26.462978] postgres[1116]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 26.464060] postgres[1116]: AS $$ vm-test-run-plv8> server # [ 26.464936] postgres[1116]: BEGIN vm-test-run-plv8> server # [ 26.467703] postgres[1116]: IF EXISTS ( vm-test-run-plv8> server # [ 26.468585] postgres[1116]: SELECT vm-test-run-plv8> server # [ 26.469564] postgres[1116]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 26.470500] postgres[1116]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 26.471354] postgres[1116]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 26.472699] postgres[1116]: WHERE ext.extname = 'pg_cron' vm-test-run-plv8> server # [ 26.473270] postgres[1116]: ) vm-test-run-plv8> server # [ 26.473991] postgres[1116]: THEN vm-test-run-plv8> server # [ 26.474562] postgres[1116]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 26.475574] postgres[1116]: vm-test-run-plv8> server # [ 26.476318] postgres[1116]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 26.477119] postgres[1116]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 26.477767] postgres[1116]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 26.478593] postgres[1116]: vm-test-run-plv8> server # [ 26.479252] postgres[1116]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 26.480308] postgres[1116]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 26.481225] postgres[1116]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 26.481915] postgres[1116]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 26.484843] postgres[1116]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 26.485808] postgres[1116]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 26.486597] postgres[1116]: vm-test-run-plv8> server # [ 26.487742] postgres[1116]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 26.489424] postgres[1116]: revoke all on table cron.job from postgres; vm-test-run-plv8> server # [ 26.490238] postgres[1116]: grant select on table cron.job to postgres with grant option; vm-test-run-plv8> server # [ 26.493870] postgres[1116]: END IF; vm-test-run-plv8> server # [ 26.493982] postgres[1116]: END; vm-test-run-plv8> server # [ 26.494111] postgres[1116]: $$; vm-test-run-plv8> server # [ 26.500122] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1112]: CREATE FUNCTION vm-test-run-plv8> server # [ 26.501317] postgres[1116]: ::1 2026-10-22 21:22:40.412 UTC [1116] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-plv8> server # [ 26.502180] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1112]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 26.504667] postgres[1116]: ::1 2026-10-22 21:22:40.415 UTC [1116] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-plv8> server # [ 26.508374] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1112]: ALTER FUNCTION vm-test-run-plv8> server # [ 26.509912] postgres[1116]: ::1 2026-10-22 21:22:40.420 UTC [1116] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-plv8> server # [ 26.511236] postgres[1116]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-plv8> server # [ 26.512263] postgres[1116]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 26.514602] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1112]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 26.522323] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-plv8> server # [ 26.563759] postgres[1119]: ::1 2026-10-22 21:22:40.474 UTC [1119] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-plv8> server # [ 26.567422] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1118]: ALTER ROLE vm-test-run-plv8> server # [ 26.579506] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-plv8> server # [ 26.630219] postgres[1121]: ::1 2026-10-22 21:22:40.541 UTC [1121] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-plv8> server # [ 26.634738] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1120]: ALTER FUNCTION vm-test-run-plv8> server # [ 26.635932] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1120]: ALTER FUNCTION vm-test-run-plv8> server # [ 26.637100] postgres[1121]: ::1 2026-10-22 21:22:40.546 UTC [1121] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-plv8> server # [ 26.639125] postgres[1121]: ::1 2026-10-22 21:22:40.546 UTC [1121] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-plv8> server # [ 26.641124] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1120]: ALTER FUNCTION vm-test-run-plv8> server # [ 26.651284] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-plv8> server # [ 26.703498] postgres[1123]: ::1 2026-10-22 21:22:40.614 UTC [1123] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-plv8> server # [ 26.705925] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1122]: GRANT ROLE vm-test-run-plv8> server # [ 26.716270] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-plv8> server # [ 26.975440] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1124]: DO vm-test-run-plv8> server # [ 26.987680] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-plv8> server # [ 27.048201] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1126]: DO vm-test-run-plv8> server # [ 27.050867] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1126]: DO vm-test-run-plv8> server # [ 27.062893] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-plv8> server # [ 27.115279] postgres[1129]: ::1 2026-10-22 21:22:41.026 UTC [1129] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-plv8> server # [ 27.118243] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1128]: ALTER ROLE vm-test-run-plv8> server # [ 27.120860] postgres[1129]: ::1 2026-10-22 21:22:41.029 UTC [1129] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-plv8> server # [ 27.123926] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1128]: ALTER ROLE vm-test-run-plv8> server # [ 27.125256] postgres[1129]: ::1 2026-10-22 21:22:41.035 UTC [1129] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-plv8> server # [ 27.127946] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1128]: ALTER ROLE vm-test-run-plv8> server # [ 27.134590] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-plv8> server # [ 27.178493] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1130]: DO vm-test-run-plv8> server # [ 27.183949] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-plv8> server # [ 27.233703] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1132]: DO vm-test-run-plv8> server # [ 27.241859] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-plv8> server # [ 27.298695] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1134]: CREATE FUNCTION vm-test-run-plv8> server # [ 27.299906] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1134]: DO vm-test-run-plv8> server # [ 27.307605] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-plv8> server # [ 27.354215] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1136]: ALTER FUNCTION vm-test-run-plv8> server # [ 27.355538] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1136]: GRANT vm-test-run-plv8> server # [ 27.367964] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-plv8> server # [ 27.411813] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1138]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 27.415401] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1138]: ALTER FUNCTION vm-test-run-plv8> server # [ 27.417756] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1138]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 27.426699] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 27.467855] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1140]: DO vm-test-run-plv8> server # [ 27.477705] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-plv8> server # [ 27.531798] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1142]: CREATE FUNCTION vm-test-run-plv8> server # [ 27.534756] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1142]: GRANT vm-test-run-plv8> server # [ 27.543883] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-plv8> server # [ 27.594270] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1144]: REVOKE ROLE vm-test-run-plv8> server # [ 27.599315] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1144]: DO vm-test-run-plv8> server # [ 27.601146] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1144]: DO vm-test-run-plv8> server # [ 27.603754] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1144]: REVOKE ROLE vm-test-run-plv8> server # [ 27.605578] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1144]: REVOKE vm-test-run-plv8> server # [ 27.608539] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1144]: DO vm-test-run-plv8> server # [ 27.615471] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 27.653155] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1150]: DO vm-test-run-plv8> server # [ 27.661940] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 27.708498] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1152]: DO vm-test-run-plv8> server # [ 27.715732] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 27.769685] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1154]: DO vm-test-run-plv8> server # [ 27.780420] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-plv8> server # [ 27.832377] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1156]: ALTER ROLE vm-test-run-plv8> server # [ 27.839861] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-plv8> server # [ 27.892197] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1158]: GRANT ROLE vm-test-run-plv8> server # [ 27.894081] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1158]: DO vm-test-run-plv8> server # [ 27.901502] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-plv8> server # [ 27.954831] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1160]: GRANT vm-test-run-plv8> server # [ 27.966502] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-plv8> server # [ 28.013863] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1162]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.016282] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1162]: REVOKE vm-test-run-plv8> server # [ 28.018646] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1162]: REVOKE vm-test-run-plv8> server # [ 28.020575] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1162]: GRANT vm-test-run-plv8> server # [ 28.029472] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-plv8> server # [ 28.076286] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1164]: DO vm-test-run-plv8> server # [ 28.086802] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-plv8> server # [ 28.124359] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1166]: ALTER ROLE vm-test-run-plv8> server # [ 28.132089] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-plv8> server # [ 28.182601] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1168]: DROP EXTENSION vm-test-run-plv8> server # [ 28.191720] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-plv8> server # [ 28.245578] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1170]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.247621] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1170]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 28.249463] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1170]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 28.258791] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-plv8> server # [ 28.305294] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1172]: DO vm-test-run-plv8> server # [ 28.310807] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1172]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.319108] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-plv8> server # [ 28.367512] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1174]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.369279] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1174]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.377475] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql vm-test-run-plv8> server # [ 28.425251] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1176]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.427255] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1176]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.431439] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1176]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.435498] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1176]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.437818] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1176]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.439621] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1176]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.446803] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Running postgresql schema... vm-test-run-plv8> server # [ 28.489489] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER DATABASE vm-test-run-plv8> server # [ 28.491086] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER DATABASE vm-test-run-plv8> server # [ 28.496139] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER ROLE vm-test-run-plv8> server # [ 28.503213] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER ROLE vm-test-run-plv8> server # [ 28.510323] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER ROLE vm-test-run-plv8> server # [ 28.514214] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER ROLE vm-test-run-plv8> server # [ 28.522058] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER ROLE vm-test-run-plv8> server # [ 28.528562] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER ROLE vm-test-run-plv8> server # [ 28.535226] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER ROLE vm-test-run-plv8> server # [ 28.540057] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER ROLE vm-test-run-plv8> server # [ 28.544932] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER ROLE vm-test-run-plv8> server # [ 28.548134] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[1178]: ALTER ROLE vm-test-run-plv8> server # [ 28.555454] 643j8gf36s47ihb3j036qxpxwk61b194-supabase-db-init[966]: Database initialization complete vm-test-run-plv8> server # [ 28.562197] systemd[1]: Finished Supabase Database Initialization. vm-test-run-plv8> server # [ 28.562469] systemd[1]: Reached target Multi-User System. vm-test-run-plv8> server # [ 28.564179] systemd[1]: Startup finished in 4.691s (kernel) + 23.870s (userspace) = 28.562s. vm-test-run-plv8> server: (finished: waiting for unit supabase-db-init.service, in 29.34 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.08 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 1.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.09 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.09 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 1.30 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.08 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.08 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 1.25 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.07 seconds) vm-test-run-plv8> (finished: subtest: Check upgrade path with postgresql 15, in 4.15 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.07 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 0.39 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.11 seconds) vm-test-run-plv8> (finished: subtest: Check the install of the last version of the extension, in 0.57 seconds) vm-test-run-plv8> (finished: run the VM test script, in 34.17 seconds) vm-test-run-plv8> test script finished in 34.27s vm-test-run-plv8> cleanup vm-test-run-plv8> kill machine (pid 9) vm-test-run-plv8> qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/qzc04a3npl70cyyy6flnnrb2ig3kayxm-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.01 seconds) vm-test-run-plv8> vde_switch: Caught signal 15, cleaning up and exiting