this derivation will be built: /nix/store/3m3nm312h6q4vy0c340wnccx2aly35j8-vm-test-run-plv8.drv this path will be fetched (3.2 KiB download, 12.4 KiB unpacked): /nix/store/0jp7cz0pr6d3gxc7hl4zfrhabgxm82a3-nixos-test-driver-plv8 building '/nix/store/3m3nm312h6q4vy0c340wnccx2aly35j8-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 # Formatting '/build/vm-state-server/tmp.c6nZebTS4I', 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: a026473c-c783-4d82-afd1-e3dc7b1f1e12 vm-test-run-plv8> server # Superblock backups stored on blocks: vm-test-run-plv8> server # 32768, 98304, 163840, 229376 vm-test-run-plv8> server # vm-test-run-plv8> server # Allocating group tables: 0/8 done vm-test-run-plv8> server # Writing inode tables: 0/8 done vm-test-run-plv8> server # Creating journal (8192 blocks): done vm-test-run-plv8> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-plv8> server # vm-test-run-plv8> server # Virtualisation disk image created. vm-test-run-plv8> server: QEMU running (pid 9) vm-test-run-plv8> (finished: start all VMs, in 0.10 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/a59c0l293rrxpdfkhwyny4gihsvgbpai-nixos-system-server-test/init regInfo=/nix/store/pd47qqnplfg92s9nmm2zlnkb7md926ni-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.000001] kvm-clock: using sched offset of 368381633 cycles vm-test-run-plv8> server # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-plv8> server # [ 0.000006] tsc: Detected 2994.372 MHz processor vm-test-run-plv8> server # [ 0.002232] last_pfn = 0x140000 max_arch_pfn = 0x400000000 vm-test-run-plv8> server # [ 0.002268] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs vm-test-run-plv8> server # [ 0.002271] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT vm-test-run-plv8> server # [ 0.002332] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 vm-test-run-plv8> server # [ 0.004511] found SMP MP-table at [mem 0x000f5470-0x000f547f] vm-test-run-plv8> server # [ 0.004527] Using GB pages for direct mapping vm-test-run-plv8> server # [ 0.004896] RAMDISK: [mem 0xbf3be000-0xbffcffff] vm-test-run-plv8> server # [ 0.004903] ACPI: Early table checksum verification disabled vm-test-run-plv8> server # [ 0.004905] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) vm-test-run-plv8> server # [ 0.004910] ACPI: RSDT 0x00000000BFFE2434 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.004915] ACPI: FACP 0x00000000BFFE22E0 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.004920] ACPI: DSDT 0x00000000BFFE0040 0022A0 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.004923] ACPI: FACS 0x00000000BFFE0000 000040 vm-test-run-plv8> server # [ 0.004925] ACPI: APIC 0x00000000BFFE2354 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.004928] ACPI: HPET 0x00000000BFFE23D4 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.004931] ACPI: WAET 0x00000000BFFE240C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.004933] ACPI: Reserving FACP table memory at [mem 0xbffe22e0-0xbffe2353] vm-test-run-plv8> server # [ 0.004935] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22df] vm-test-run-plv8> server # [ 0.004936] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] vm-test-run-plv8> server # [ 0.004937] ACPI: Reserving APIC table memory at [mem 0xbffe2354-0xbffe23d3] vm-test-run-plv8> server # [ 0.004938] ACPI: Reserving HPET table memory at [mem 0xbffe23d4-0xbffe240b] vm-test-run-plv8> server # [ 0.004939] ACPI: Reserving WAET table memory at [mem 0xbffe240c-0xbffe2433] vm-test-run-plv8> server # [ 0.005219] No NUMA configuration found vm-test-run-plv8> server # [ 0.005220] Faking a node at [mem 0x0000000000000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.005223] NODE_DATA(0) allocated [mem 0x13fff88c0-0x13fffddff] vm-test-run-plv8> server # [ 0.005247] Zone ranges: vm-test-run-plv8> server # [ 0.005248] DMA [mem 0x0000000000001000-0x0000000000ffffff] vm-test-run-plv8> server # [ 0.005250] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] vm-test-run-plv8> server # [ 0.005251] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.005252] Device empty vm-test-run-plv8> server # [ 0.005254] Movable zone start for each node vm-test-run-plv8> server # [ 0.005254] Early memory node ranges vm-test-run-plv8> server # [ 0.005255] node 0: [mem 0x0000000000001000-0x000000000009efff] vm-test-run-plv8> server # [ 0.005256] node 0: [mem 0x0000000000100000-0x00000000bffdafff] vm-test-run-plv8> server # [ 0.005258] node 0: [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.005259] Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.005389] On node 0, zone DMA: 1 pages in unavailable ranges vm-test-run-plv8> server # [ 0.005407] On node 0, zone DMA: 97 pages in unavailable ranges vm-test-run-plv8> server # [ 0.013322] On node 0, zone Normal: 37 pages in unavailable ranges vm-test-run-plv8> server # [ 0.013875] ACPI: PM-Timer IO Port: 0x608 vm-test-run-plv8> server # [ 0.013888] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) vm-test-run-plv8> server # [ 0.013920] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 vm-test-run-plv8> server # [ 0.013923] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) vm-test-run-plv8> server # [ 0.013925] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) vm-test-run-plv8> server # [ 0.013926] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) vm-test-run-plv8> server # [ 0.013928] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) vm-test-run-plv8> server # [ 0.013929] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) vm-test-run-plv8> server # [ 0.013933] ACPI: Using ACPI (MADT) for SMP configuration information vm-test-run-plv8> server # [ 0.013934] ACPI: HPET id: 0x8086a201 base: 0xfed00000 vm-test-run-plv8> server # [ 0.013938] TSC deadline timer available vm-test-run-plv8> server # [ 0.013945] CPU topo: Max. logical packages: 1 vm-test-run-plv8> server # [ 0.013946] CPU topo: Max. logical dies: 1 vm-test-run-plv8> server # [ 0.013946] CPU topo: Max. dies per package: 1 vm-test-run-plv8> server # [ 0.013952] CPU topo: Max. threads per core: 1 vm-test-run-plv8> server # [ 0.013953] CPU topo: Num. cores per package: 2 vm-test-run-plv8> server # [ 0.013954] CPU topo: Num. threads per package: 2 vm-test-run-plv8> server # [ 0.013954] CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs vm-test-run-plv8> server # [ 0.013973] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() vm-test-run-plv8> server # [ 0.013987] kvm-guest: KVM setup pv remote TLB flush vm-test-run-plv8> server # [ 0.013990] kvm-guest: setup PV sched yield vm-test-run-plv8> server # [ 0.014000] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.014002] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] vm-test-run-plv8> server # [ 0.014003] PM: hibernation: Registered nosave memory: [mem 0xbffdb000-0xffffffff] vm-test-run-plv8> server # [ 0.014005] [mem 0xc0000000-0xfeffbfff] available for PCI devices vm-test-run-plv8> server # [ 0.014007] Booting paravirtualized kernel on KVM vm-test-run-plv8> server # [ 0.014010] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns vm-test-run-plv8> server # [ 0.018892] setup_percpu: NR_CPUS:384 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 vm-test-run-plv8> server # [ 0.019099] percpu: Embedded 116 pages/cpu s294912 r65536 d114688 u1048576 vm-test-run-plv8> server # [ 0.019141] kvm-guest: PV spinlocks enabled vm-test-run-plv8> server # [ 0.019143] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) vm-test-run-plv8> server # [ 0.019146] 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/a59c0l293rrxpdfkhwyny4gihsvgbpai-nixos-system-server-test/init regInfo=/nix/store/pd47qqnplfg92s9nmm2zlnkb7md926ni-closure-info/registration console=ttyS0,115200n8 console=tty0 vm-test-run-plv8> server # [ 0.019269] Unknown kernel command line parameters "regInfo=/nix/store/pd47qqnplfg92s9nmm2zlnkb7md926ni-closure-info/registration", will be passed to user space. vm-test-run-plv8> server # [ 0.019296] random: crng init done vm-test-run-plv8> server # [ 0.019645] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-plv8> server # [ 0.019822] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-plv8> server # [ 0.019849] Fallback order for Node 0: 0 vm-test-run-plv8> server # [ 0.019852] Built 1 zonelists, mobility grouping on. Total pages: 1048441 vm-test-run-plv8> server # [ 0.019853] Policy zone: Normal vm-test-run-plv8> server # [ 0.020048] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-plv8> server # [ 0.020052] software IO TLB: area num 2. vm-test-run-plv8> server # [ 0.038971] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm-test-run-plv8> server # [ 0.039845] allocated 8388608 bytes of page_ext vm-test-run-plv8> server # [ 0.039869] ftrace: allocating 46234 entries in 181 pages vm-test-run-plv8> server # [ 0.050397] ftrace: allocated 181 pages with 5 groups vm-test-run-plv8> server # [ 0.051271] Dynamic Preempt: voluntary vm-test-run-plv8> server # [ 0.051479] rcu: Preemptible hierarchical RCU implementation. vm-test-run-plv8> server # [ 0.051480] rcu: RCU event tracing is enabled. vm-test-run-plv8> server # [ 0.051480] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. vm-test-run-plv8> server # [ 0.051482] Trampoline variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.051483] Rude variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.051483] Tracing variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.051484] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. vm-test-run-plv8> server # [ 0.051485] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm-test-run-plv8> server # [ 0.051495] 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.051497] 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.051498] 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.057787] NR_IRQS: 24832, nr_irqs: 440, preallocated irqs: 16 vm-test-run-plv8> server # [ 0.058011] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-plv8> server # [ 0.058120] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-plv8> server # [ 0.062830] Console: colour VGA+ 80x25 vm-test-run-plv8> server # [ 0.062833] printk: legacy console [tty0] enabled vm-test-run-plv8> server # [ 0.103016] printk: legacy console [ttyS0] enabled vm-test-run-plv8> server # [ 0.200703] ACPI: Core revision 20240827 vm-test-run-plv8> server # [ 0.201483] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns vm-test-run-plv8> server # [ 0.203185] APIC: Switch to symmetric I/O mode setup vm-test-run-plv8> server # [ 0.204112] x2apic enabled vm-test-run-plv8> server # [ 0.204820] APIC: Switched APIC routing to: physical x2apic vm-test-run-plv8> server # [ 0.205691] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() vm-test-run-plv8> server # [ 0.206803] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() vm-test-run-plv8> server # [ 0.208107] kvm-guest: setup PV IPIs vm-test-run-plv8> server # [ 0.209637] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 vm-test-run-plv8> server # [ 0.210576] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2b29812ce43, max_idle_ns: 440795323173 ns vm-test-run-plv8> server # [ 0.212009] Calibrating delay loop (skipped) preset value.. 5988.74 BogoMIPS (lpj=2994372) vm-test-run-plv8> server # [ 0.214086] x86/cpu: User Mode Instruction Prevention (UMIP) activated vm-test-run-plv8> server # [ 0.215074] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 vm-test-run-plv8> server # [ 0.215991] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 vm-test-run-plv8> server # [ 0.217011] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization vm-test-run-plv8> server # [ 0.218009] Spectre V2 : Mitigation: Retpolines vm-test-run-plv8> server # [ 0.219479] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT vm-test-run-plv8> server # [ 0.221007] Spectre V2 : Enabling Restricted Speculation for firmware calls vm-test-run-plv8> server # [ 0.222011] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier vm-test-run-plv8> server # [ 0.223009] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl vm-test-run-plv8> server # [ 0.224008] Speculative Return Stack Overflow: IBPB-extending microcode not applied! vm-test-run-plv8> server # [ 0.225839] 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.225840] active return thunk: srso_alias_return_thunk vm-test-run-plv8> server # [ 0.227777] Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode vm-test-run-plv8> server # [ 0.228792] Transient Scheduler Attacks: Forcing mitigation on in a VM vm-test-run-plv8> server # [ 0.229680] Transient Scheduler Attacks: Vulnerable: Clear CPU buffers attempted, no microcode vm-test-run-plv8> server # [ 0.231022] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' vm-test-run-plv8> server # [ 0.232007] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' vm-test-run-plv8> server # [ 0.233007] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' vm-test-run-plv8> server # [ 0.234007] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' vm-test-run-plv8> server # [ 0.235008] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 vm-test-run-plv8> server # [ 0.236008] x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8 vm-test-run-plv8> server # [ 0.237008] x86/fpu: Enabled xstate features 0x207, context size is 840 bytes, using 'compacted' format. vm-test-run-plv8> server # [ 0.264609] Freeing SMP alternatives memory: 40K vm-test-run-plv8> server # [ 0.265010] pid_max: default: 32768 minimum: 301 vm-test-run-plv8> server # [ 0.266064] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-plv8> server # [ 0.267091] landlock: Up and running. vm-test-run-plv8> server # [ 0.267667] Yama: becoming mindful. vm-test-run-plv8> server # [ 0.268816] LSM support for eBPF active vm-test-run-plv8> server # [ 0.269458] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.270013] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.272397] smpboot: CPU0: AMD EPYC 7313P 16-Core Processor (family: 0x19, model: 0x1, stepping: 0x1) vm-test-run-plv8> server # [ 0.273448] Performance Events: Fam17h+ core perfctr, AMD PMU driver. vm-test-run-plv8> server # [ 0.274012] ... version: 0 vm-test-run-plv8> server # [ 0.274624] ... bit width: 48 vm-test-run-plv8> server # [ 0.275010] ... generic registers: 6 vm-test-run-plv8> server # [ 0.275684] ... value mask: 0000ffffffffffff vm-test-run-plv8> server # [ 0.276010] ... max period: 00007fffffffffff vm-test-run-plv8> server # [ 0.276839] ... fixed-purpose events: 0 vm-test-run-plv8> server # [ 0.277438] ... event mask: 000000000000003f vm-test-run-plv8> server # [ 0.278093] signal: max sigframe size: 3376 vm-test-run-plv8> server # [ 0.278838] rcu: Hierarchical SRCU implementation. vm-test-run-plv8> server # [ 0.279534] rcu: Max phase no-delay instances is 400. vm-test-run-plv8> server # [ 0.280073] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-plv8> server # [ 0.284500] smp: Bringing up secondary CPUs ... vm-test-run-plv8> server # [ 0.285156] smpboot: x86: Booting SMP configuration: vm-test-run-plv8> server # [ 0.285951] .... node #0, CPUs: #1 vm-test-run-plv8> server # [ 0.286155] smp: Brought up 1 node, 2 CPUs vm-test-run-plv8> server # [ 0.287696] smpboot: Total of 2 processors activated (11977.48 BogoMIPS) vm-test-run-plv8> server # [ 0.288192] Memory: 3979912K/4193764K available (16384K kernel code, 2651K rwdata, 12576K rodata, 3420K init, 3592K bss, 199444K reserved, 0K cma-reserved) vm-test-run-plv8> server # [ 0.289145] devtmpfs: initialized vm-test-run-plv8> server # [ 0.290047] x86/mm: Memory block size: 128MB vm-test-run-plv8> server # [ 0.291554] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns vm-test-run-plv8> server # [ 0.293018] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.294097] pinctrl core: initialized pinctrl subsystem vm-test-run-plv8> server # [ 0.295187] PM: RTC time: 14:18:45, date: 2026-10-26 vm-test-run-plv8> server # [ 0.296772] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-plv8> server # [ 0.298165] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-plv8> server # [ 0.299043] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-plv8> server # [ 0.300146] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-plv8> server # [ 0.301018] audit: initializing netlink subsys (disabled) vm-test-run-plv8> server # [ 0.301838] audit: type=2000 audit(1793024325.920:1): state=initialized audit_enabled=0 res=1 vm-test-run-plv8> server # [ 0.302033] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-plv8> server # [ 0.303010] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-plv8> server # [ 0.303871] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-plv8> server # [ 0.304617] thermal_sys: Registered thermal governor 'user_space' vm-test-run-plv8> server # [ 0.305009] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-plv8> server # [ 0.305880] cpuidle: using governor menu vm-test-run-plv8> server # [ 0.307453] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 vm-test-run-plv8> server # [ 0.308141] PCI: Using configuration type 1 for base access vm-test-run-plv8> server # [ 0.308972] PCI: Using configuration type 1 for extended access vm-test-run-plv8> server # [ 0.309806] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. vm-test-run-plv8> server # [ 0.329277] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.330012] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-plv8> server # [ 0.331011] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.333018] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-plv8> server # [ 0.335275] ACPI: Added _OSI(Module Device) vm-test-run-plv8> server # [ 0.336011] ACPI: Added _OSI(Processor Device) vm-test-run-plv8> server # [ 0.336914] ACPI: Added _OSI(Processor Aggregator Device) vm-test-run-plv8> server # [ 0.340320] ACPI: 1 ACPI AML tables successfully acquired and loaded vm-test-run-plv8> server # [ 0.344343] ACPI: Interpreter enabled vm-test-run-plv8> server # [ 0.345032] ACPI: PM: (supports S0 S3 S4 S5) vm-test-run-plv8> server # [ 0.345949] ACPI: Using IOAPIC for interrupt routing vm-test-run-plv8> server # [ 0.346764] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug vm-test-run-plv8> server # [ 0.348009] PCI: Using E820 reservations for host bridge windows vm-test-run-plv8> server # [ 0.349056] ACPI: Enabled 2 GPEs in block 00 to 0F vm-test-run-plv8> server # [ 0.353824] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) vm-test-run-plv8> server # [ 0.354976] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] vm-test-run-plv8> server # [ 0.357497] acpiphp: Slot [3] registered vm-test-run-plv8> server # [ 0.358105] acpiphp: Slot [4] registered vm-test-run-plv8> server # [ 0.358937] acpiphp: Slot [5] registered vm-test-run-plv8> server # [ 0.359493] acpiphp: Slot [6] registered vm-test-run-plv8> server # [ 0.361063] acpiphp: Slot [7] registered vm-test-run-plv8> server # [ 0.361700] acpiphp: Slot [8] registered vm-test-run-plv8> server # [ 0.362034] acpiphp: Slot [9] registered vm-test-run-plv8> server # [ 0.362684] acpiphp: Slot [10] registered vm-test-run-plv8> server # [ 0.363035] acpiphp: Slot [11] registered vm-test-run-plv8> server # [ 0.363724] acpiphp: Slot [12] registered vm-test-run-plv8> server # [ 0.365053] acpiphp: Slot [13] registered vm-test-run-plv8> server # [ 0.365839] acpiphp: Slot [14] registered vm-test-run-plv8> server # [ 0.366474] acpiphp: Slot [15] registered vm-test-run-plv8> server # [ 0.367034] acpiphp: Slot [16] registered vm-test-run-plv8> server # [ 0.367725] acpiphp: Slot [17] registered vm-test-run-plv8> server # [ 0.368034] acpiphp: Slot [18] registered vm-test-run-plv8> server # [ 0.368730] acpiphp: Slot [19] registered vm-test-run-plv8> server # [ 0.370035] acpiphp: Slot [20] registered vm-test-run-plv8> server # [ 0.370706] acpiphp: Slot [21] registered vm-test-run-plv8> server # [ 0.371035] acpiphp: Slot [22] registered vm-test-run-plv8> server # [ 0.371859] acpiphp: Slot [23] registered vm-test-run-plv8> server # [ 0.372653] acpiphp: Slot [24] registered vm-test-run-plv8> server # [ 0.373054] acpiphp: Slot [25] registered vm-test-run-plv8> server # [ 0.373743] acpiphp: Slot [26] registered vm-test-run-plv8> server # [ 0.375033] acpiphp: Slot [27] registered vm-test-run-plv8> server # [ 0.375791] acpiphp: Slot [28] registered vm-test-run-plv8> server # [ 0.376033] acpiphp: Slot [29] registered vm-test-run-plv8> server # [ 0.376771] acpiphp: Slot [30] registered vm-test-run-plv8> server # [ 0.378037] acpiphp: Slot [31] registered vm-test-run-plv8> server # [ 0.378769] PCI host bridge to bus 0000:00 vm-test-run-plv8> server # [ 0.379015] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] vm-test-run-plv8> server # [ 0.380014] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] vm-test-run-plv8> server # [ 0.381025] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] vm-test-run-plv8> server # [ 0.383011] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] vm-test-run-plv8> server # [ 0.384010] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] vm-test-run-plv8> server # [ 0.385011] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-plv8> server # [ 0.386224] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.388468] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint vm-test-run-plv8> server # [ 0.389655] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint vm-test-run-plv8> server # [ 0.398010] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] vm-test-run-plv8> server # [ 0.401668] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk vm-test-run-plv8> server # [ 0.403011] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk vm-test-run-plv8> server # [ 0.404011] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk vm-test-run-plv8> server # [ 0.406010] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk vm-test-run-plv8> server # [ 0.407194] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint vm-test-run-plv8> server # [ 0.411259] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] vm-test-run-plv8> server # [ 0.415908] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.417450] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI vm-test-run-plv8> server # [ 0.419022] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB vm-test-run-plv8> server # [ 0.420219] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.423560] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] vm-test-run-plv8> server # [ 0.427744] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] vm-test-run-plv8> server # [ 0.436016] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] vm-test-run-plv8> server # [ 0.438882] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] vm-test-run-plv8> server # [ 0.440310] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.444011] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] vm-test-run-plv8> server # [ 0.446774] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] vm-test-run-plv8> server # [ 0.452010] pci 0000:00:03.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] vm-test-run-plv8> server # [ 0.455017] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] vm-test-run-plv8> server # [ 0.457416] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.461010] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] vm-test-run-plv8> server # [ 0.462523] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] vm-test-run-plv8> server # [ 0.472606] pci 0000:00:04.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] vm-test-run-plv8> server # [ 0.476395] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.479011] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] vm-test-run-plv8> server # [ 0.480609] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] vm-test-run-plv8> server # [ 0.486010] pci 0000:00:05.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] vm-test-run-plv8> server # [ 0.489351] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.493010] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] vm-test-run-plv8> server # [ 0.497568] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] vm-test-run-plv8> server # [ 0.501503] pci 0000:00:06.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] vm-test-run-plv8> server # [ 0.505367] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.509010] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] vm-test-run-plv8> server # [ 0.510501] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] vm-test-run-plv8> server # [ 0.515010] pci 0000:00:07.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] vm-test-run-plv8> server # [ 0.522211] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.525010] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] vm-test-run-plv8> server # [ 0.527862] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] vm-test-run-plv8> server # [ 0.535586] pci 0000:00:08.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] vm-test-run-plv8> server # [ 0.540210] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.543566] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] vm-test-run-plv8> server # [ 0.545938] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] vm-test-run-plv8> server # [ 0.550010] pci 0000:00:09.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] vm-test-run-plv8> server # [ 0.552009] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] vm-test-run-plv8> server # [ 0.554319] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.557938] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] vm-test-run-plv8> server # [ 0.560009] pci 0000:00:0a.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] vm-test-run-plv8> server # [ 0.562950] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.565487] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] vm-test-run-plv8> server # [ 0.568454] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] vm-test-run-plv8> server # [ 0.570480] pci 0000:00:0b.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] vm-test-run-plv8> server # [ 0.573332] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.576450] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] vm-test-run-plv8> server # [ 0.578895] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] vm-test-run-plv8> server # [ 0.581873] pci 0000:00:0c.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] vm-test-run-plv8> server # [ 0.587363] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 vm-test-run-plv8> server # [ 0.588147] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 vm-test-run-plv8> server # [ 0.589201] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 vm-test-run-plv8> server # [ 0.590188] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 vm-test-run-plv8> server # [ 0.591126] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 vm-test-run-plv8> server # [ 0.592435] iommu: Default domain type: Translated vm-test-run-plv8> server # [ 0.594010] iommu: DMA domain TLB invalidation policy: lazy mode vm-test-run-plv8> server # [ 0.595051] ACPI: bus type USB registered vm-test-run-plv8> server # [ 0.595711] usbcore: registered new interface driver usbfs vm-test-run-plv8> server # [ 0.596018] usbcore: registered new interface driver hub vm-test-run-plv8> server # [ 0.596888] usbcore: registered new device driver usb vm-test-run-plv8> server # [ 0.598237] NetLabel: Initializing vm-test-run-plv8> server # [ 0.598713] NetLabel: domain hash size = 128 vm-test-run-plv8> server # [ 0.600010] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO vm-test-run-plv8> server # [ 0.600937] NetLabel: unlabeled traffic allowed by default vm-test-run-plv8> server # [ 0.601659] PCI: Using ACPI for IRQ routing vm-test-run-plv8> server # [ 0.602314] pci 0000:00:02.0: vgaarb: setting as boot VGA device vm-test-run-plv8> server # [ 0.602961] pci 0000:00:02.0: vgaarb: bridge control possible vm-test-run-plv8> server # [ 0.603005] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none vm-test-run-plv8> server # [ 0.605014] vgaarb: loaded vm-test-run-plv8> server # [ 0.605558] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 vm-test-run-plv8> server # [ 0.607010] hpet0: 3 comparators, 64-bit 100.000000 MHz counter vm-test-run-plv8> server # [ 0.612052] clocksource: Switched to clocksource kvm-clock vm-test-run-plv8> server # [ 0.614061] VFS: Disk quotas dquot_6.6.0 vm-test-run-plv8> server # [ 0.614729] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-plv8> server # [ 0.615997] pnp: PnP ACPI init vm-test-run-plv8> server # [ 0.617014] pnp: PnP ACPI: found 6 devices vm-test-run-plv8> server # [ 0.625086] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns vm-test-run-plv8> server # [ 0.626442] clocksource: Switched to clocksource acpi_pm vm-test-run-plv8> server # [ 0.627372] NET: Registered PF_INET protocol family vm-test-run-plv8> server # [ 0.628205] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-plv8> server # [ 0.640032] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.641338] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.642638] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.644097] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-plv8> server # [ 0.645350] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-plv8> server # [ 0.646510] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-plv8> server # [ 0.647696] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.648733] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.649849] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-plv8> server # [ 0.650747] NET: Registered PF_XDP protocol family vm-test-run-plv8> server # [ 0.651538] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] vm-test-run-plv8> server # [ 0.652479] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] vm-test-run-plv8> server # [ 0.653428] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] vm-test-run-plv8> server # [ 0.654453] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] vm-test-run-plv8> server # [ 0.655491] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] vm-test-run-plv8> server # [ 0.656723] pci 0000:00:01.0: PIIX3: Enabling Passive Release vm-test-run-plv8> server # [ 0.657641] pci 0000:00:00.0: Limiting direct PCI/PCI transfers vm-test-run-plv8> server # [ 0.659956] ACPI: \_SB_.LNKD: Enabled at IRQ 11 vm-test-run-plv8> server # [ 0.662485] PCI: CLS 0 bytes, default 64 vm-test-run-plv8> server # [ 0.663163] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) vm-test-run-plv8> server # [ 0.663309] Trying to unpack rootfs image as initramfs... vm-test-run-plv8> server # [ 0.663510] software IO TLB: mapped [mem 0x00000000bb3be000-0x00000000bf3be000] (64MB) vm-test-run-plv8> server # [ 0.666722] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2b29812ce43, max_idle_ns: 440795323173 ns vm-test-run-plv8> server # [ 0.680357] Initialise system trusted keyrings vm-test-run-plv8> server # [ 0.683082] workingset: timestamp_bits=40 max_order=20 bucket_order=0 vm-test-run-plv8> server # [ 0.693881] Key type asymmetric registered vm-test-run-plv8> server # [ 0.694565] Asymmetric key parser 'x509' registered vm-test-run-plv8> server # [ 0.695392] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) vm-test-run-plv8> server # [ 0.696948] io scheduler mq-deadline registered vm-test-run-plv8> server # [ 0.697683] io scheduler kyber registered vm-test-run-plv8> server # [ 0.698924] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-plv8> server # [ 0.700119] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A vm-test-run-plv8> server # [ 0.701927] Linux agpgart interface v0.103 vm-test-run-plv8> server # [ 0.702622] ACPI: bus type drm_connector registered vm-test-run-plv8> server # [ 0.703979] usbcore: registered new interface driver usbserial_generic vm-test-run-plv8> server # [ 0.704969] usbserial: USB Serial support registered for generic vm-test-run-plv8> server # [ 0.705916] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled vm-test-run-plv8> server # [ 0.707150] drop_monitor: Initializing network drop monitor service vm-test-run-plv8> server # [ 0.708202] NET: Registered PF_INET6 protocol family vm-test-run-plv8> server # [ 0.726105] Freeing initrd memory: 12360K vm-test-run-plv8> server # [ 0.727782] Segment Routing with IPv6 vm-test-run-plv8> server # [ 0.728556] In-situ OAM (IOAM) with IPv6 vm-test-run-plv8> server # [ 0.730138] IPI shorthand broadcast: enabled vm-test-run-plv8> server # [ 0.733843] sched_clock: Marking stable (586021195, 146986577)->(750990488, -17982716) vm-test-run-plv8> server # [ 0.735464] registered taskstats version 1 vm-test-run-plv8> server # [ 0.736286] Loading compiled-in X.509 certificates vm-test-run-plv8> server # [ 0.744552] Demotion targets for Node 0: null vm-test-run-plv8> server # [ 0.745756] Key type .fscrypt registered vm-test-run-plv8> server # [ 0.746685] Key type fscrypt-provisioning registered vm-test-run-plv8> server # [ 0.748405] PM: Magic number: 14:734:334 vm-test-run-plv8> server # [ 0.749372] tty tty55: hash matches vm-test-run-plv8> server # [ 0.751267] RAS: Correctable Errors collector initialized. vm-test-run-plv8> server # [ 0.756112] clk: Disabling unused clocks vm-test-run-plv8> server # [ 0.756767] PM: genpd: Disabling unused power domains vm-test-run-plv8> server # [ 0.759304] Freeing unused decrypted memory: 2028K vm-test-run-plv8> server # [ 0.760841] Freeing unused kernel image (initmem) memory: 3420K vm-test-run-plv8> server # [ 0.762064] Write protecting the kernel read-only data: 30720k vm-test-run-plv8> server # [ 0.764419] Freeing unused kernel image (rodata/data gap) memory: 1760K vm-test-run-plv8> server # [ 0.814758] x86/mm: Checked W+X mappings: passed, no W+X pages found. vm-test-run-plv8> server # [ 0.815794] Run /init as init process vm-test-run-plv8> server # [ 0.854647] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-plv8> server # [ 0.987925] uhci_hcd 0000:00:01.2: UHCI Host Controller vm-test-run-plv8> server # [ 0.989155] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 vm-test-run-plv8> server # [ 0.990712] uhci_hcd 0000:00:01.2: detected 2 ports vm-test-run-plv8> server # [ 0.991641] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 vm-test-run-plv8> server # [ 0.992669] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.12 vm-test-run-plv8> server # [ 0.993972] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 vm-test-run-plv8> server # [ 0.995169] usb usb1: Product: UHCI Host Controller vm-test-run-plv8> server # [ 0.995963] usb usb1: Manufacturer: Linux 6.12.63 uhci_hcd vm-test-run-plv8> server # [ 0.996749] ACPI: \_SB_.LNKC: Enabled at IRQ 10 vm-test-run-plv8> server # [ 0.996891] usb usb1: SerialNumber: 0000:00:01.2 vm-test-run-plv8> server # [ 1.002031] hub 1-0:1.0: USB hub found vm-test-run-plv8> server # [ 1.002713] hub 1-0:1.0: 2 ports detected vm-test-run-plv8> server # [ 1.009167] ACPI: \_SB_.LNKA: Enabled at IRQ 10 vm-test-run-plv8> server # [ 1.012280] ACPI: \_SB_.LNKB: Enabled at IRQ 11 vm-test-run-plv8> server # [ 1.022744] SCSI subsystem initialized vm-test-run-plv8> server # [ 1.022803] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 vm-test-run-plv8> server # [ 1.040179] serio: i8042 KBD port at 0x60,0x64 irq 1 vm-test-run-plv8> server # [ 1.041273] serio: i8042 AUX port at 0x60,0x64 irq 12 vm-test-run-plv8> server # [ 1.043674] scsi host0: ata_piix vm-test-run-plv8> server # [ 1.044459] scsi host1: ata_piix vm-test-run-plv8> server # [ 1.045129] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 vm-test-run-plv8> server # [ 1.046489] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 vm-test-run-plv8> server # [ 1.206372] ata2: found unknown device (class 0) vm-test-run-plv8> server # [ 1.207757] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 vm-test-run-plv8> server # [ 1.209774] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 vm-test-run-plv8> server # [ 1.222070] usb 1-1: new full-speed USB device number 2 using uhci_hcd vm-test-run-plv8> server # [ 1.234806] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-plv8> server # [ 1.247758] netfs: FS-Cache loaded vm-test-run-plv8> server # [ 1.249149] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 vm-test-run-plv8> server # [ 1.255696] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-plv8> server # [ 1.259777] 9pnet: Installing 9P2000 support vm-test-run-plv8> server # [ 1.280067] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray vm-test-run-plv8> server # [ 1.281304] cdrom: Uniform CD-ROM driver Revision: 3.20 vm-test-run-plv8> server # [ 1.391486] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 vm-test-run-plv8> server # [ 1.393318] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 vm-test-run-plv8> server # [ 1.394681] usb 1-1: Product: QEMU USB Tablet vm-test-run-plv8> server # [ 1.395494] usb 1-1: Manufacturer: QEMU vm-test-run-plv8> server # [ 1.396249] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 vm-test-run-plv8> server # [ 1.409168] hid: raw HID events driver (C) Jiri Kosina vm-test-run-plv8> server # [ 1.417458] usbcore: registered new interface driver usbhid vm-test-run-plv8> server # [ 1.418683] usbhid: USB HID core driver vm-test-run-plv8> server # [ 1.422450] 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.424564] 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.662134] EXT4-fs (vda): mounted filesystem a026473c-c783-4d82-afd1-e3dc7b1f1e12 r/w with ordered data mode. Quota mode: none. vm-test-run-plv8> server # [ 1.684407] 9p: Installing v9fs 9p2000 file system support vm-test-run-plv8> server # [ 1.896375] EXT4-fs (vda): re-mounted a026473c-c783-4d82-afd1-e3dc7b1f1e12. vm-test-run-plv8> server # [ 1.900328] booting system configuration /nix/store/a59c0l293rrxpdfkhwyny4gihsvgbpai-nixos-system-server-test vm-test-run-plv8> server # [ 3.265199] systemd[1]: Inserted module 'autofs4' vm-test-run-plv8> server # [ 3.323631] 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 # [ 3.330506] systemd[1]: Detected virtualization kvm. vm-test-run-plv8> server # [ 3.331682] systemd[1]: Detected architecture x86-64. vm-test-run-plv8> server # [ 3.332891] systemd[1]: Detected first boot. vm-test-run-plv8> server # [ 3.340355] systemd[1]: Initializing machine ID from random generator. vm-test-run-plv8> server # [ 3.350365] systemd[1]: Hostname set to . vm-test-run-plv8> server # [ 3.528460] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-plv8> server # [ 3.651721] systemd[1]: Applying preset policy. vm-test-run-plv8> server # [ 4.343375] systemd[1]: Populated /etc with preset unit settings. vm-test-run-plv8> server # [ 5.148941] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-plv8> server # [ 5.197183] systemd[1]: Created slice Slice /system/getty. vm-test-run-plv8> server # [ 5.199196] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-plv8> server # [ 5.201118] systemd[1]: Created slice User and Session Slice. vm-test-run-plv8> server # [ 5.202791] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-plv8> server # [ 5.204484] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-plv8> server # [ 5.205930] systemd[1]: Expecting device /dev/hvc0... vm-test-run-plv8> server # [ 5.206922] systemd[1]: Expecting device /dev/ttyS0... vm-test-run-plv8> server # [ 5.207904] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-plv8> server # [ 5.209189] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-plv8> server # [ 5.210342] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-plv8> server # [ 5.211631] systemd[1]: Reached target Path Units. vm-test-run-plv8> server # [ 5.212671] systemd[1]: Reached target Remote File Systems. vm-test-run-plv8> server # [ 5.213730] systemd[1]: Reached target Slice Units. vm-test-run-plv8> server # [ 5.214706] systemd[1]: Reached target Swaps. vm-test-run-plv8> server # [ 5.220838] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-plv8> server # [ 5.224540] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-plv8> server # [ 5.226104] systemd[1]: Listening on Journal Audit Socket. vm-test-run-plv8> server # [ 5.227081] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-plv8> server # [ 5.228032] systemd[1]: Listening on Journal Sockets. vm-test-run-plv8> server # [ 5.229669] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-plv8> server # [ 5.231094] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 5.232810] systemd[1]: Listening on udev Control Socket. vm-test-run-plv8> server # [ 5.233733] systemd[1]: Listening on udev Kernel Socket. vm-test-run-plv8> server # [ 5.241511] systemd[1]: Mounting Huge Pages File System... vm-test-run-plv8> server # [ 5.245400] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-plv8> server # [ 5.249754] systemd[1]: Mounting Kernel Debug File System... vm-test-run-plv8> server # [ 5.255539] systemd[1]: Mounting Kernel Trace File System... vm-test-run-plv8> server # [ 5.263938] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-plv8> server # [ 5.265621] systemd[1]: Load Kernel Module 9pnet_virtio was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!9pnet_virtio). vm-test-run-plv8> server # [ 5.271489] systemd[1]: Starting Load Kernel Module configfs... vm-test-run-plv8> server # [ 5.277420] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-plv8> server # [ 5.284151] systemd[1]: Starting Load Kernel Module efi_pstore... vm-test-run-plv8> server # [ 5.290866] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-plv8> server # [ 5.294398] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-plv8> server # [ 5.297616] 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 # [ 5.311311] systemd[1]: Starting Journal Service... vm-test-run-plv8> server # [ 5.318538] systemd[1]: Starting Load Kernel Modules... vm-test-run-plv8> server # [ 5.326431] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-plv8> server # [ 5.332369] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-plv8> server # [ 5.333448] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 5.341169] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-plv8> server # [ 5.348657] systemd[1]: Mounted Huge Pages File System. vm-test-run-plv8> server # [ 5.351572] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-plv8> server # [ 5.353513] systemd[1]: Mounted Kernel Debug File System. vm-test-run-plv8> server # [ 5.356592] systemd[1]: Mounted Kernel Trace File System. vm-test-run-plv8> server # [ 5.359404] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-plv8> server # [ 5.366762] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-plv8> server # [ 5.408592] systemd-journald[412]: Collecting audit messages is enabled. vm-test-run-plv8> server # [ 5.410729] systemd[1]: modprobe@configfs.service: Deactivated successfully. vm-test-run-plv8> server # [ 5.412169] systemd[1]: Finished Load Kernel Module configfs. vm-test-run-plv8> server # [ 5.413690] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. vm-test-run-plv8> server # [ 5.415729] systemd[1]: Finished Load Kernel Module efi_pstore. vm-test-run-plv8> server # [ 5.421567] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-plv8> server # [ 5.431260] EXT4-fs (vda): re-mounted a026473c-c783-4d82-afd1-e3dc7b1f1e12. vm-test-run-plv8> server # [ 5.441171] fuse: init (API version 7.41) vm-test-run-plv8> server # [ 5.444163] loop: module loaded vm-test-run-plv8> server # [ 5.452432] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-plv8> server # [ 5.456016] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-plv8> server # [ 5.465152] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-plv8> server # [ 5.469555] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 5.473553] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-plv8> server # [ 5.477082] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-plv8> server # [ 5.480674] systemd[1]: Finished Load Kernel Modules. vm-test-run-plv8> server # [ 5.484754] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-plv8> server # [ 5.492544] systemd[1]: Starting Firewall... vm-test-run-plv8> server # [ 5.502687] systemd[1]: Starting Apply Kernel Variables... vm-test-run-plv8> server # [ 5.510369] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-plv8> server # [ 5.568813] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-plv8> server # [ 5.575618] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-plv8> server # [ 5.581483] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-plv8> server # [ 5.583355] systemd[1]: Reached target First Boot Complete. vm-test-run-plv8> server # [ 5.610906] systemd[1]: Finished Apply Kernel Variables. vm-test-run-plv8> server # [ 5.483729] systemd-modules-load[413]: Inserted module 'loop' vm-test-run-plv8> server # [ 5.630717] systemd[1]: Started Journal Service. vm-test-run-plv8> server # [ 5.486335] systemd-oomd[414]: No swap; memory pressure usage will be degraded vm-test-run-plv8> server # [ 5.495254] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-plv8> server # [ 5.551087] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-plv8> server # [ 5.552478] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-plv8> server # [ 5.703406] systemd-journald[412]: Received client request to flush runtime journal. vm-test-run-plv8> server # [ 5.605520] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-plv8> server # [ 5.607219] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-plv8> server # [ 5.612974] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-plv8> server # [ 5.641385] systemd-udevd[452]: Using default interface naming scheme 'v258'. vm-test-run-plv8> server # [ 5.820231] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-plv8> server # [ 5.908427] systemd[1]: Load Kernel Module fuse was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!fuse). vm-test-run-plv8> server # [ 5.934864] systemd[1]: Load Kernel Module fuse was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!fuse). vm-test-run-plv8> server # [ 5.992713] systemd[1]: Found device /dev/hvc0. vm-test-run-plv8> server # [ 5.998598] systemd[1]: Found device /dev/ttyS0. vm-test-run-plv8> server # [ 6.051450] (udev-worker)[485]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-plv8> server # [ 6.053712] (udev-worker)[485]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 6.077228] (udev-worker)[499]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 6.289189] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 vm-test-run-plv8> server # [ 6.148836] systemd[1]: Found device Virtio network device. vm-test-run-plv8> server # [ 6.308718] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 vm-test-run-plv8> server # [ 6.313259] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD vm-test-run-plv8> server # [ 6.330216] ACPI: button: Power Button [PWRF] vm-test-run-plv8> server # [ 6.336177] mousedev: PS/2 mouse device common for all mice vm-test-run-plv8> server # [ 6.344414] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console vm-test-run-plv8> server # [ 6.205369] systemd[1]: Mounting /run/wrappers... vm-test-run-plv8> server # [ 6.208954] systemd[1]: Mounting FUSE Control File System... vm-test-run-plv8> server # [ 6.372660] parport_pc 00:03: reported by Plug and Play ACPI vm-test-run-plv8> server # [ 6.376727] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] vm-test-run-plv8> server # [ 6.244870] systemd[1]: Mounted FUSE Control File System. vm-test-run-plv8> server # [ 6.255900] systemd[1]: Mounted /run/wrappers. vm-test-run-plv8> server # [ 6.260508] systemd[1]: Reached target Local File Systems. vm-test-run-plv8> server # [ 6.389459] rtc_cmos 00:05: RTC can wake from S4 vm-test-run-plv8> server # [ 6.390361] Floppy drive(s): fd0 is 2.88M AMI BIOS vm-test-run-plv8> server # [ 6.391128] rtc_cmos 00:05: registered as rtc0 vm-test-run-plv8> server # [ 6.391338] rtc_cmos 00:05: setting system clock to 2026-10-26T14:18:51 UTC (1793024331) vm-test-run-plv8> server # [ 6.274660] systemd[1]: Listening on Boot Entries Service Socket.[ 6.391663] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs vm-test-run-plv8> server # vm-test-run-plv8> server # [ 6.394166] systemd-journald[412]: Time jumped backwards, rotating. vm-test-run-plv8> server # [ 6.408805] FDC 0 is a S82078B vm-test-run-plv8> server # [ 6.413929] Console: switching to colour dummy device 80x25 vm-test-run-plv8> server # [ 6.426647] [drm] Found bochs VGA, ID 0xb0c5. vm-test-run-plv8> server # [ 6.427047] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. vm-test-run-plv8> server # [ 6.432325] [drm] Found EDID data blob. vm-test-run-plv8> server # [ 6.287627] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-plv8> server # [ 6.288721] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-plv8> server # [ 6.292043] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-plv8> server # [ 6.294421] systemd[1]: Starting Create System Files and Directories... vm-test-run-plv8> server # [ 6.446670] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 vm-test-run-plv8> server # [ 6.367472] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-plv8> server # [ 6.376637] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-plv8> server # [ 6.452806] fbcon: bochs-drmdrmfb (fb0) is primary device vm-test-run-plv8> server # [ 6.518575] Console: switching to colour frame buffer device 160x50 vm-test-run-plv8> server # [ 6.560763] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device vm-test-run-plv8> server # [ 6.430262] systemd[1]: Finished Create System Files and Directories. vm-test-run-plv8> server # [ 6.436235] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-plv8> server # [ 6.440755] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-plv8> server # [ 6.660204] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 vm-test-run-plv8> server # [ 6.665367] cryptd: max_cpu_qlen set to 1000 vm-test-run-plv8> server # [ 6.526756] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-plv8> server # [ 6.677626] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 vm-test-run-plv8> server # [ 6.679590] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 vm-test-run-plv8> server # [ 6.603256] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-plv8> server # [ 6.614879] systemd[1]: Starting Update is Completed... vm-test-run-plv8> server # [ 6.794685] ppdev: user-space parallel port driver vm-test-run-plv8> server # [ 6.671832] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 6.697175] systemd[1]: Finished Update is Completed. vm-test-run-plv8> server # [ 6.851155] AES CTR mode by8 optimization enabled vm-test-run-plv8> server # [ 6.718344] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-plv8> server # [ 6.719544] systemd[1]: Stopped Virtual Console Setup. vm-test-run-plv8> server # [ 6.726556] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 6.808695] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-plv8> server # [ 6.813469] systemd[1]: Stopped Virtual Console Setup. vm-test-run-plv8> server # [ 6.816083] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 7.114886] kvm_amd: TSC scaling supported vm-test-run-plv8> server # [ 7.115468] kvm_amd: Nested Virtualization enabled vm-test-run-plv8> server # [ 7.116186] kvm_amd: Nested Paging enabled vm-test-run-plv8> server # [ 7.116809] kvm_amd: LBR virtualization supported vm-test-run-plv8> server # [ 7.120098] kvm_amd: Virtual VMLOAD VMSAVE supported vm-test-run-plv8> server # [ 7.120855] kvm_amd: Virtual GIF supported vm-test-run-plv8> server # [ 7.205904] EDAC MC: Ver: 3.0.0 vm-test-run-plv8> server # [ 7.185522] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-plv8> server # [ 7.187341] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-plv8> server # [ 7.219260] systemd[1]: Finished Firewall. vm-test-run-plv8> server # [ 7.695286] systemd[1]: Finished Virtual Console Setup. vm-test-run-plv8> server # [ 7.696677] systemd[1]: Reached target System Initialization. vm-test-run-plv8> server # [ 7.700085] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-plv8> server # [ 7.701457] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-plv8> server # [ 7.703065] systemd[1]: Reached target Timer Units. vm-test-run-plv8> server # [ 7.704085] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-plv8> server # [ 7.705435] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-plv8> server # [ 7.706488] systemd[1]: Listening on Hostname Service Socket. vm-test-run-plv8> server # [ 7.707479] systemd[1]: Reached target Socket Units. vm-test-run-plv8> server # [ 7.708509] systemd[1]: Reached target Basic System. vm-test-run-plv8> server # [ 7.711779] systemd[1]: Started backdoor.service. vm-test-run-plv8> server # [ 7.715053] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-plv8> server # [ 7.719904] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 7.726716] systemd[1]: Started Reset console on configuration changes. vm-test-run-plv8> server # [ 7.733272] systemd[1]: Starting resolvconf update... vm-test-run-plv8> server # [ 7.739563] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-plv8> server # connecting to host... vm-test-run-plv8> server # [ 7.825339] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-plv8> server # [ 7.829992] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 7.834777] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 7.837265] nsncd[681]: Oct 26 14:18:53.083 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 7.840799] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 7.843103] 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 8.40 seconds) vm-test-run-plv8> server: (finished: waiting for the VM to finish booting, in 8.40 seconds) vm-test-run-plv8> server # [ 7.888830] dbus-daemon[684]: dbus[684]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-plv8> server # [ 7.938244] systemd[1]: Started D-Bus System Message Bus. vm-test-run-plv8> server # [ 7.953879] systemd-logind[705]: New seat seat0. vm-test-run-plv8> server # [ 7.957844] systemd-logind[705]: Watching system buttons on /dev/input/event2 (Power Button) vm-test-run-plv8> server # [ 7.959715] systemd-logind[705]: Watching system buttons on /dev/input/event4 (QEMU Virtio Keyboard) vm-test-run-plv8> server # [ 7.961437] systemd-logind[705]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) vm-test-run-plv8> server # [ 7.991540] systemd[1]: Started User Login Management. vm-test-run-plv8> server # [ 7.997225] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-plv8> server # [ 7.999096] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-plv8> server # [ 8.000452] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-plv8> server # [ 8.001638] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-plv8> server # [ 8.002927] systemd[1]: Starting linger-users.service... vm-test-run-plv8> server # [ 8.003851] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 8.013561] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-plv8> server # [ 8.016678] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 8.024048] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 8.058698] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-plv8> server # [ 8.063146] systemd[1]: Finished linger-users.service. vm-test-run-plv8> server # [ 8.089866] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 8.090875] nsncd[751]: Oct 26 14:18:53.345 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 8.092986] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 8.095873] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 8.139434] systemd[1]: Finished resolvconf update. vm-test-run-plv8> server # [ 8.141228] systemd[1]: Reached target Preparation for Network. vm-test-run-plv8> server # [ 8.146534] systemd[1]: Starting DHCP Client... vm-test-run-plv8> server # [ 8.151441] systemd[1]: Starting Address configuration of eth1... vm-test-run-plv8> server # [ 8.259620] network-addresses-eth1-start[782]: adding address 192.168.1.1/24... done vm-test-run-plv8> server # [ 8.275855] network-addresses-eth1-start[782]: adding address 2001:db8:1::1/64... done vm-test-run-plv8> server # [ 8.303754] systemd[1]: Finished Address configuration of eth1. vm-test-run-plv8> server # [ 8.308946] systemd[1]: Starting Networking Setup... vm-test-run-plv8> server # [ 8.310432] dhcpcd[788]: dhcpcd-10.2.4 starting vm-test-run-plv8> server # [ 8.322610] dhcpcd[801]: dev: loaded udev vm-test-run-plv8> server # [ 8.500943] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-plv8> server # [ 8.502053] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-plv8> server # [ 8.395411] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-plv8> server # [ 8.618544] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-plv8> server # [ 8.496058] systemd[1]: Finished Networking Setup. vm-test-run-plv8> server # [ 8.498976] systemd[1]: Reached target Network. vm-test-run-plv8> server # [ 8.502979] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-plv8> server # [ 8.506843] systemd[1]: Starting Permit User Sessions... vm-test-run-plv8> server # [ 8.671851] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-plv8> server # [ 8.674919] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-plv8> server # [ 8.681277] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-plv8> server # [ 8.682661] cfg80211: failed to load regulatory.db vm-test-run-plv8> server # [ 8.568099] systemd[1]: Finished Permit User Sessions. vm-test-run-plv8> server # [ 8.574479] systemd[1]: Started Getty on tty1. vm-test-run-plv8> server # [ 8.575611] systemd[1]: Reached target Login Prompts. vm-test-run-plv8> server # [ 8.631471] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[857]: Initializing database at /var/lib/postgresql/data vm-test-run-plv8> server # [ 8.783142] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-plv8> server # [ 8.640402] dhcpcd[801]: eth0: waiting for carrier vm-test-run-plv8> server # [ 8.892115] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: The files belonging to this database system will be owned by user "postgres". vm-test-run-plv8> server # [ 8.893653] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: This user must also own the server process. vm-test-run-plv8> server # [ 8.915487] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-plv8> server # [ 8.915821] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: The default database encoding has accordingly been set to "UTF8". vm-test-run-plv8> server # [ 8.915921] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: The default text search configuration will be set to "english". vm-test-run-plv8> server # [ 8.916441] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: Data page checksums are enabled. vm-test-run-plv8> server # [ 8.921477] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-plv8> server # [ 8.923137] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: creating subdirectories ... ok vm-test-run-plv8> server # [ 8.924769] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: selecting dynamic shared memory implementation ... posix vm-test-run-plv8> server # [ 9.061325] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: selecting default max_connections ... 100 vm-test-run-plv8> server # [ 9.166903] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: selecting default shared_buffers ... 128MB vm-test-run-plv8> server # [ 9.243454] dhcpcd[801]: eth0: carrier acquired vm-test-run-plv8> server # [ 9.267323] dhcpcd[801]: DUID 00:01:00:01:32:72:1d:ce:52:54:00:12:34:56 vm-test-run-plv8> server # [ 9.268789] dhcpcd[801]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 9.269785] dhcpcd[801]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-plv8> server # [ 10.844435] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: selecting default time zone ... UTC vm-test-run-plv8> server # [ 10.850265] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: creating configuration files ... ok vm-test-run-plv8> server # [ 11.065098] dhcpcd[801]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 11.242360] NET: Registered PF_PACKET protocol family vm-test-run-plv8> server # [ 11.104578] dhcpcd[801]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 11.110205] dhcpcd[801]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 11.140057] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: running bootstrap script ... ok vm-test-run-plv8> server # [ 11.161482] dhcpcd[801]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 11.162679] dhcpcd[801]: eth0: Router Advertisement from fe80::2 vm-test-run-plv8> server # [ 11.163671] dhcpcd[801]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-plv8> server # [ 11.164957] dhcpcd[801]: eth0: adding route to fec0::/64 vm-test-run-plv8> server # [ 11.166395] dhcpcd[801]: eth0: adding default route via fe80::2 vm-test-run-plv8> server # [ 11.940506] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: performing post-bootstrap initialization ... ok vm-test-run-plv8> server # [ 12.187367] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: syncing data to disk ... ok vm-test-run-plv8> server # [ 12.188909] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-plv8> server # [ 12.190987] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: 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 # [ 12.195282] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: Success. You can now start the database server using: vm-test-run-plv8> server # [ 12.196870] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[861]: /nix/store/3n1r120j8cgyxn404qdhyx09g2fxg3qw-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-plv8> server # [ 12.390627] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[857]: Validating PostgreSQL configuration... vm-test-run-plv8> server # [ 12.436924] 6q7wg7sr4bx8dkfg301mql1d7h4x19hf-postgresql-init[912]: 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 # [ 12.558621] postgres[914]: 2026-10-26 14:18:57.813 UTC [914] LOG: pgaudit extension initialized vm-test-run-plv8> server # [ 12.661546] postgres[914]: 2026-10-26 14:18:57.917 UTC [914] LOG: pgsodium primary server secret key loaded vm-test-run-plv8> server # [ 12.732474] postgres[914]: 2026-10-26 14:18:57.987 UTC [914] LOG: vault primary server secret key loaded vm-test-run-plv8> server # [ 12.769190] postgres[914]: 2026-10-26 14:18:58.024 UTC [914] 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 # [ 12.773419] postgres[914]: 2026-10-26 14:18:58.029 UTC [914] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-plv8> server # [ 12.773736] postgres[914]: 2026-10-26 14:18:58.029 UTC [914] LOG: listening on IPv6 address "::", port 5432 vm-test-run-plv8> server # [ 12.777454] postgres[914]: 2026-10-26 14:18:58.033 UTC [914] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-plv8> server # [ 12.785427] postgres[933]: 2026-10-26 14:18:58.040 UTC [933] LOG: database system was shut down at 2026-10-26 14:18:57 UTC vm-test-run-plv8> server # [ 12.803123] postgres[914]: 2026-10-26 14:18:58.058 UTC [914] LOG: database system is ready to accept connections vm-test-run-plv8> server # [ 12.805546] postgres[937]: 2026-10-26 14:18:58.060 UTC [937] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 12.807237] postgres[936]: 2026-10-26 14:18:58.060 UTC [936] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-plv8> server # [ 12.809370] postgres[914]: 2026-10-26 14:18:58.064 UTC [914] LOG: background worker "pg_net 0.20.4 worker" (PID 937) exited with exit code 1 vm-test-run-plv8> server # [ 12.812133] systemd[1]: Started PostgreSQL Database Server. vm-test-run-plv8> server # [ 12.817517] postgres[938]: 2026-10-26 14:18:58.073 UTC [938] LOG: pg_cron scheduler started vm-test-run-plv8> server # [ 12.819328] systemd[1]: Starting Supabase Database Initialization... vm-test-run-plv8> server # [ 12.876158] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Waiting for PostgreSQL to be ready... vm-test-run-plv8> server # [ 12.945652] postgres[944]: ::1 2026-10-26 14:18:58.200 UTC [944] root@root FATAL: role "root" does not exist vm-test-run-plv8> server # [ 12.952280] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: PostgreSQL is ready vm-test-run-plv8> server # [ 12.953864] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Creating postgres role... vm-test-run-plv8> server # [ 13.008524] postgres[946]: ::1 2026-10-26 14:18:58.263 UTC [946] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-plv8> server # [ 13.012959] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[945]: CREATE ROLE vm-test-run-plv8> server # [ 13.058243] postgres[948]: ::1 2026-10-26 14:18:58.313 UTC [948] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-plv8> server # [ 13.061579] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[947]: ALTER DATABASE vm-test-run-plv8> server # [ 13.077809] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-plv8> server # [ 13.113080] postgres[950]: ::1 2026-10-26 14:18:58.368 UTC [950] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-plv8> server # [ 13.115305] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: CREATE PUBLICATION vm-test-run-plv8> server # [ 13.116523] postgres[950]: ::1 2026-10-26 14:18:58.370 UTC [950] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-plv8> server # [ 13.119360] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: ALTER ROLE vm-test-run-plv8> server # [ 13.120644] postgres[950]: ::1 2026-10-26 14:18:58.374 UTC [950] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-plv8> server # [ 13.122531] postgres[950]: ::1 2026-10-26 14:18:58.376 UTC [950] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-plv8> server # [ 13.124221] postgres[950]: ::1 2026-10-26 14:18:58.377 UTC [950] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-plv8> server # [ 13.125836] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: CREATE ROLE vm-test-run-plv8> server # [ 13.126660] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: CREATE ROLE vm-test-run-plv8> server # [ 13.127531] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: GRANT ROLE vm-test-run-plv8> server # [ 13.128692] postgres[950]: ::1 2026-10-26 14:18:58.379 UTC [950] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-plv8> server # [ 13.130185] postgres[950]: ::1 2026-10-26 14:18:58.383 UTC [950] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-plv8> server # [ 13.131955] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: GRANT vm-test-run-plv8> server # [ 13.132859] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: CREATE ROLE vm-test-run-plv8> server # [ 13.133808] postgres[950]: ::1 2026-10-26 14:18:58.388 UTC [950] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-plv8> server # [ 13.136146] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: GRANT ROLE vm-test-run-plv8> server # [ 13.138560] postgres[950]: ::1 2026-10-26 14:18:58.391 UTC [950] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-plv8> server # [ 13.140474] postgres[950]: ::1 2026-10-26 14:18:58.395 UTC [950] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-plv8> server # [ 13.141208] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: CREATE SCHEMA vm-test-run-plv8> server # [ 13.637307] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: CREATE EXTENSION vm-test-run-plv8> server # [ 13.639376] postgres[950]: ::1 2026-10-26 14:18:58.893 UTC [950] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-plv8> server # [ 13.870678] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: CREATE EXTENSION vm-test-run-plv8> server # [ 13.871877] postgres[950]: ::1 2026-10-26 14:18:59.126 UTC [950] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-plv8> server # [ 13.874199] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: CREATE ROLE vm-test-run-plv8> server # [ 13.875430] postgres[950]: ::1 2026-10-26 14:18:59.131 UTC [950] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-plv8> server # [ 13.878031] postgres[950]: ::1 2026-10-26 14:18:59.133 UTC [950] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-plv8> server # [ 13.880575] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: CREATE ROLE vm-test-run-plv8> server # [ 13.881774] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: CREATE ROLE vm-test-run-plv8> server # [ 13.883557] postgres[950]: ::1 2026-10-26 14:18:59.135 UTC [950] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-plv8> server # [ 13.885205] postgres[950]: ::1 2026-10-26 14:18:59.138 UTC [950] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-plv8> server # [ 13.886701] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: CREATE ROLE vm-test-run-plv8> server # [ 13.888734] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: GRANT ROLE vm-test-run-plv8> server # [ 13.890673] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: GRANT ROLE vm-test-run-plv8> server # [ 13.892367] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: GRANT ROLE vm-test-run-plv8> server # [ 13.894110] postgres[950]: ::1 2026-10-26 14:18:59.143 UTC [950] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-plv8> server # [ 13.895943] postgres[950]: ::1 2026-10-26 14:18:59.144 UTC [950] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-plv8> server # [ 13.897865] postgres[950]: ::1 2026-10-26 14:18:59.146 UTC [950] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-plv8> server # [ 13.899659] postgres[950]: ::1 2026-10-26 14:18:59.147 UTC [950] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.902397] postgres[950]: ::1 2026-10-26 14:18:59.149 UTC [950] 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 # [ 13.904583] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: GRANT ROLE vm-test-run-plv8> server # [ 13.905789] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: GRANT vm-test-run-plv8> server # [ 13.906906] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 13.908679] postgres[950]: ::1 2026-10-26 14:18:59.157 UTC [950] 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 # [ 13.911043] postgres[950]: ::1 2026-10-26 14:18:59.161 UTC [950] 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 # [ 13.913531] postgres[950]: ::1 2026-10-26 14:18:59.162 UTC [950] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.916812] postgres[950]: ::1 2026-10-26 14:18:59.163 UTC [950] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-plv8> server # [ 13.919226] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 13.920518] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 13.922073] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: GRANT vm-test-run-plv8> server # [ 13.923212] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: ALTER ROLE vm-test-run-plv8> server # [ 13.925103] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 13.926097] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 13.927975] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 13.929405] postgres[950]: ::1 2026-10-26 14:18:59.164 UTC [950] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 13.932141] postgres[950]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.934164] postgres[950]: ::1 2026-10-26 14:18:59.166 UTC [950] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 13.936892] postgres[950]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.938271] postgres[950]: ::1 2026-10-26 14:18:59.172 UTC [950] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 13.940469] postgres[950]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.942107] postgres[950]: ::1 2026-10-26 14:18:59.174 UTC [950] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-plv8> server # [ 13.944177] postgres[950]: ::1 2026-10-26 14:18:59.177 UTC [950] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-plv8> server # [ 13.946180] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: ALTER ROLE vm-test-run-plv8> server # [ 13.947714] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[949]: ALTER ROLE vm-test-run-plv8> server # [ 13.949202] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-plv8> server # [ 13.983300] postgres[958]: ::1 2026-10-26 14:18:59.238 UTC [958] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 13.986308] postgres[958]: ::1 2026-10-26 14:18:59.240 UTC [958] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-plv8> server # [ 13.988124] postgres[958]: instance_id uuid NULL, vm-test-run-plv8> server # [ 13.989216] postgres[958]: id uuid NOT NULL UNIQUE, vm-test-run-plv8> server # [ 13.990170] postgres[958]: aud varchar(255) NULL, vm-test-run-plv8> server # [ 13.991540] postgres[958]: "role" varchar(255) NULL, vm-test-run-plv8> server # [ 13.991672] postgres[958]: email varchar(255) NULL UNIQUE, vm-test-run-plv8> server # [ 13.991754] postgres[958]: encrypted_password varchar(255) NULL, vm-test-run-plv8> server # [ 13.991894] postgres[958]: confirmed_at timestamptz NULL, vm-test-run-plv8> server # [ 13.991987] postgres[958]: invited_at timestamptz NULL, vm-test-run-plv8> server # [ 13.992135] postgres[958]: confirmation_token varchar(255) NULL, vm-test-run-plv8> server # [ 13.992245] postgres[958]: confirmation_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 13.993438] postgres[958]: recovery_token varchar(255) NULL, vm-test-run-plv8> server # [ 13.995426] postgres[958]: recovery_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 13.995996] postgres[958]: email_change_token varchar(255) NULL, vm-test-run-plv8> server # [ 13.996994] postgres[958]: email_change varchar(255) NULL, vm-test-run-plv8> server # [ 13.999366] postgres[958]: email_change_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 14.001908] postgres[958]: last_sign_in_at timestamptz NULL, vm-test-run-plv8> server # [ 14.003070] postgres[958]: raw_app_meta_data jsonb NULL, vm-test-run-plv8> server # [ 14.003829] postgres[958]: raw_user_meta_data jsonb NULL, vm-test-run-plv8> server # [ 14.004956] postgres[958]: is_super_admin bool NULL, vm-test-run-plv8> server # [ 14.005881] postgres[958]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 14.006769] postgres[958]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 14.007714] postgres[958]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 14.008859] postgres[958]: ); vm-test-run-plv8> server # [ 14.010047] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE SCHEMA vm-test-run-plv8> server # [ 14.020705] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE TABLE vm-test-run-plv8> server # [ 14.022456] postgres[958]: ::1 2026-10-26 14:18:59.277 UTC [958] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-plv8> server # [ 14.027442] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE INDEX vm-test-run-plv8> server # [ 14.029155] postgres[958]: ::1 2026-10-26 14:18:59.284 UTC [958] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-plv8> server # [ 14.032797] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE INDEX vm-test-run-plv8> server # [ 14.033994] postgres[958]: ::1 2026-10-26 14:18:59.289 UTC [958] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-plv8> server # [ 14.038117] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: COMMENT vm-test-run-plv8> server # [ 14.039361] postgres[958]: ::1 2026-10-26 14:18:59.292 UTC [958] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-plv8> server # [ 14.041160] postgres[958]: instance_id uuid NULL, vm-test-run-plv8> server # [ 14.042169] postgres[958]: id bigserial NOT NULL, vm-test-run-plv8> server # [ 14.042499] postgres[958]: "token" varchar(255) NULL, vm-test-run-plv8> server # [ 14.043261] postgres[958]: user_id varchar(255) NULL, vm-test-run-plv8> server # [ 14.043843] postgres[958]: revoked bool NULL, vm-test-run-plv8> server # [ 14.044742] postgres[958]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 14.045577] postgres[958]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 14.046292] postgres[958]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 14.047256] postgres[958]: ); vm-test-run-plv8> server # [ 14.052374] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE TABLE vm-test-run-plv8> server # [ 14.053863] postgres[958]: ::1 2026-10-26 14:18:59.309 UTC [958] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-plv8> server # [ 14.060225] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE INDEX vm-test-run-plv8> server # [ 14.063110] postgres[958]: ::1 2026-10-26 14:18:59.316 UTC [958] 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 # [ 14.073256] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE INDEX vm-test-run-plv8> server # [ 14.074355] postgres[958]: ::1 2026-10-26 14:18:59.329 UTC [958] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-plv8> server # [ 14.081775] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE INDEX vm-test-run-plv8> server # [ 14.083335] postgres[958]: ::1 2026-10-26 14:18:59.338 UTC [958] 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 # [ 14.086332] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: COMMENT vm-test-run-plv8> server # [ 14.087824] postgres[958]: ::1 2026-10-26 14:18:59.343 UTC [958] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-plv8> server # [ 14.089440] postgres[958]: id uuid NOT NULL, vm-test-run-plv8> server # [ 14.090371] postgres[958]: uuid uuid NULL, vm-test-run-plv8> server # [ 14.090688] postgres[958]: raw_base_config text NULL, vm-test-run-plv8> server # [ 14.090795] postgres[958]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 14.090867] postgres[958]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 14.090960] postgres[958]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 14.091070] postgres[958]: ); vm-test-run-plv8> server # [ 14.105333] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE TABLE vm-test-run-plv8> server # [ 14.106350] postgres[958]: ::1 2026-10-26 14:18:59.360 UTC [958] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-plv8> server # [ 14.111621] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: COMMENT vm-test-run-plv8> server # [ 14.112930] postgres[958]: ::1 2026-10-26 14:18:59.365 UTC [958] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-plv8> server # [ 14.113648] postgres[958]: instance_id uuid NULL, vm-test-run-plv8> server # [ 14.114461] postgres[958]: id uuid NOT NULL, vm-test-run-plv8> server # [ 14.115145] postgres[958]: payload json NULL, vm-test-run-plv8> server # [ 14.116612] postgres[958]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 14.117489] postgres[958]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 14.118484] postgres[958]: ); vm-test-run-plv8> server # [ 14.121842] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE TABLE vm-test-run-plv8> server # [ 14.123210] postgres[958]: ::1 2026-10-26 14:18:59.377 UTC [958] 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 # [ 14.126694] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE INDEX vm-test-run-plv8> server # [ 14.128035] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: COMMENT vm-test-run-plv8> server # [ 14.129137] postgres[958]: ::1 2026-10-26 14:18:59.382 UTC [958] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-plv8> server # [ 14.129781] postgres[958]: ::1 2026-10-26 14:18:59.383 UTC [958] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-plv8> server # [ 14.130507] postgres[958]: "version" varchar(255) NOT NULL, vm-test-run-plv8> server # [ 14.131195] postgres[958]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-plv8> server # [ 14.131858] postgres[958]: ); vm-test-run-plv8> server # [ 14.140233] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE TABLE vm-test-run-plv8> server # [ 14.141722] postgres[958]: ::1 2026-10-26 14:18:59.396 UTC [958] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-plv8> server # [ 14.144497] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: COMMENT vm-test-run-plv8> server # [ 14.147294] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: INSERT 0 7 vm-test-run-plv8> server # [ 14.148385] postgres[958]: ::1 2026-10-26 14:18:59.403 UTC [958] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-plv8> server # [ 14.149326] postgres[958]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-plv8> server # [ 14.150221] postgres[958]: $$ language sql stable; vm-test-run-plv8> server # [ 14.153388] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.154436] postgres[958]: ::1 2026-10-26 14:18:59.409 UTC [958] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-plv8> server # [ 14.155329] postgres[958]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-plv8> server # [ 14.156242] postgres[958]: $$ language sql stable; vm-test-run-plv8> server # [ 14.159435] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.160902] postgres[958]: ::1 2026-10-26 14:18:59.414 UTC [958] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-plv8> server # [ 14.161751] postgres[958]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-plv8> server # [ 14.164266] postgres[958]: $$ language sql stable; vm-test-run-plv8> server # [ 14.165417] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.166155] postgres[958]: ::1 2026-10-26 14:18:59.420 UTC [958] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-plv8> server # [ 14.169036] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: GRANT vm-test-run-plv8> server # [ 14.170287] postgres[958]: ::1 2026-10-26 14:18:59.425 UTC [958] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 14.172435] postgres[958]: ::1 2026-10-26 14:18:59.428 UTC [958] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.174540] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: CREATE ROLE vm-test-run-plv8> server # [ 14.176376] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: GRANT vm-test-run-plv8> server # [ 14.176649] postgres[958]: ::1 2026-10-26 14:18:59.431 UTC [958] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.179922] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: GRANT vm-test-run-plv8> server # [ 14.181264] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: GRANT vm-test-run-plv8> server # [ 14.182490] postgres[958]: ::1 2026-10-26 14:18:59.435 UTC [958] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.184828] postgres[958]: ::1 2026-10-26 14:18:59.436 UTC [958] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-plv8> server # [ 14.185492] postgres[958]: ::1 2026-10-26 14:18:59.437 UTC [958] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.186099] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: ALTER ROLE vm-test-run-plv8> server # [ 14.186723] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: ALTER TABLE vm-test-run-plv8> server # [ 14.187306] postgres[958]: ::1 2026-10-26 14:18:59.439 UTC [958] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.191110] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: ALTER TABLE vm-test-run-plv8> server # [ 14.192174] postgres[958]: ::1 2026-10-26 14:18:59.446 UTC [958] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.195648] postgres[958]: ::1 2026-10-26 14:18:59.448 UTC [958] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.198714] postgres[958]: ::1 2026-10-26 14:18:59.449 UTC [958] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.200558] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: ALTER TABLE vm-test-run-plv8> server # [ 14.202271] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: ALTER TABLE vm-test-run-plv8> server # [ 14.203444] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[957]: ALTER TABLE vm-test-run-plv8> server # [ 14.210179] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-plv8> server # [ 14.243274] postgres[960]: ::1 2026-10-26 14:18:59.497 UTC [960] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 14.246052] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[959]: CREATE SCHEMA vm-test-run-plv8> server # [ 14.247480] postgres[960]: ::1 2026-10-26 14:18:59.501 UTC [960] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 14.250269] postgres[960]: ::1 2026-10-26 14:18:59.504 UTC [960] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-plv8> server # [ 14.251810] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[959]: CREATE ROLE vm-test-run-plv8> server # [ 14.252832] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[959]: ALTER ROLE vm-test-run-plv8> server # [ 14.253912] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[959]: GRANT vm-test-run-plv8> server # [ 14.256178] postgres[960]: ::1 2026-10-26 14:18:59.507 UTC [960] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-plv8> server # [ 14.259215] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[959]: DO vm-test-run-plv8> server # [ 14.266991] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-plv8> server # [ 14.298852] postgres[962]: ::1 2026-10-26 14:18:59.553 UTC [962] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-plv8> server # [ 14.301730] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: ALTER ROLE vm-test-run-plv8> server # [ 14.302759] postgres[962]: ::1 2026-10-26 14:18:59.558 UTC [962] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-plv8> server # [ 14.305550] postgres[962]: ::1 2026-10-26 14:18:59.561 UTC [962] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-plv8> server # [ 14.306634] postgres[962]: RETURNS event_trigger vm-test-run-plv8> server # [ 14.307255] postgres[962]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 14.307922] postgres[962]: AS $$ vm-test-run-plv8> server # [ 14.308656] postgres[962]: DECLARE vm-test-run-plv8> server # [ 14.309520] postgres[962]: schema_is_cron bool; vm-test-run-plv8> server # [ 14.310230] postgres[962]: BEGIN vm-test-run-plv8> server # [ 14.310751] postgres[962]: schema_is_cron = ( vm-test-run-plv8> server # [ 14.311464] postgres[962]: SELECT n.nspname = 'cron' vm-test-run-plv8> server # [ 14.312264] postgres[962]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 14.313160] postgres[962]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-plv8> server # [ 14.314062] postgres[962]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 14.314808] postgres[962]: ); vm-test-run-plv8> server # [ 14.315441] postgres[962]: vm-test-run-plv8> server # [ 14.315909] postgres[962]: IF schema_is_cron vm-test-run-plv8> server # [ 14.316605] postgres[962]: THEN vm-test-run-plv8> server # [ 14.317106] postgres[962]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 14.317970] postgres[962]: vm-test-run-plv8> server # [ 14.318586] postgres[962]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 14.319557] postgres[962]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 14.320197] postgres[962]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 14.320873] postgres[962]: vm-test-run-plv8> server # [ 14.321712] postgres[962]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 14.322750] postgres[962]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 14.323582] postgres[962]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 14.324210] postgres[962]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 14.325161] postgres[962]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 14.327678] postgres[962]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 14.328745] postgres[962]: vm-test-run-plv8> server # [ 14.329635] postgres[962]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 14.330674] postgres[962]: vm-test-run-plv8> server # [ 14.331660] postgres[962]: END IF; vm-test-run-plv8> server # [ 14.332745] postgres[962]: vm-test-run-plv8> server # [ 14.333267] postgres[962]: END; vm-test-run-plv8> server # [ 14.333473] postgres[962]: $$; vm-test-run-plv8> server # [ 14.333580] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: ALTER ROLE vm-test-run-plv8> server # [ 14.336479] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.337448] postgres[962]: ::1 2026-10-26 14:18:59.591 UTC [962] 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 # [ 14.338264] postgres[962]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 14.341384] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 14.342673] postgres[962]: ::1 2026-10-26 14:18:59.598 UTC [962] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-plv8> server # [ 14.345517] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: COMMENT vm-test-run-plv8> server # [ 14.346714] postgres[962]: ::1 2026-10-26 14:18:59.602 UTC [962] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-plv8> server # [ 14.349189] postgres[962]: RETURNS event_trigger vm-test-run-plv8> server # [ 14.349455] postgres[962]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 14.349529] postgres[962]: AS $$ vm-test-run-plv8> server # [ 14.349598] postgres[962]: BEGIN vm-test-run-plv8> server # [ 14.349667] postgres[962]: IF EXISTS ( vm-test-run-plv8> server # [ 14.349736] postgres[962]: SELECT 1 vm-test-run-plv8> server # [ 14.349806] postgres[962]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 14.349875] postgres[962]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 14.349945] postgres[962]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 14.350060] postgres[962]: WHERE ext.extname = 'pg_net' vm-test-run-plv8> server # [ 14.350855] postgres[962]: ) vm-test-run-plv8> server # [ 14.351874] postgres[962]: THEN vm-test-run-plv8> server # [ 14.352725] postgres[962]: IF NOT EXISTS ( vm-test-run-plv8> server # [ 14.353277] postgres[962]: SELECT 1 vm-test-run-plv8> server # [ 14.353398] postgres[962]: FROM pg_roles vm-test-run-plv8> server # [ 14.354139] postgres[962]: WHERE rolname = 'supabase_functions_admin' vm-test-run-plv8> server # [ 14.355924] postgres[962]: ) vm-test-run-plv8> server # [ 14.356975] postgres[962]: THEN vm-test-run-plv8> server # [ 14.358069] postgres[962]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 14.359832] postgres[962]: END IF; vm-test-run-plv8> server # [ 14.360845] postgres[962]: vm-test-run-plv8> server # [ 14.361604] postgres[962]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 14.362550] postgres[962]: vm-test-run-plv8> server # [ 14.363221] postgres[962]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 14.363846] postgres[962]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 14.364658] postgres[962]: vm-test-run-plv8> server # [ 14.365569] postgres[962]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plv8> server # [ 14.366461] postgres[962]: 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 # [ 14.367131] postgres[962]: vm-test-run-plv8> server # [ 14.367832] postgres[962]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plv8> server # [ 14.368728] postgres[962]: 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 # [ 14.369567] postgres[962]: vm-test-run-plv8> server # [ 14.370277] postgres[962]: 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 # [ 14.370969] postgres[962]: 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 # [ 14.371817] postgres[962]: END IF; vm-test-run-plv8> server # [ 14.372716] postgres[962]: END; vm-test-run-plv8> server # [ 14.373544] postgres[962]: $$; vm-test-run-plv8> server # [ 14.374542] postgres[962]: ::1 2026-10-26 14:18:59.604 UTC [962] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-plv8> server # [ 14.375054] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.384061] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: COMMENT vm-test-run-plv8> server # [ 14.389719] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: DO vm-test-run-plv8> server # [ 14.390945] postgres[962]: ::1 2026-10-26 14:18:59.645 UTC [962] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-plv8> server # [ 14.392277] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: CREATE ROLE vm-test-run-plv8> server # [ 14.392734] postgres[962]: ::1 2026-10-26 14:18:59.648 UTC [962] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-plv8> server # [ 14.394068] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: GRANT vm-test-run-plv8> server # [ 14.395497] postgres[962]: ::1 2026-10-26 14:18:59.650 UTC [962] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 14.398351] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: GRANT vm-test-run-plv8> server # [ 14.402151] postgres[962]: ::1 2026-10-26 14:18:59.657 UTC [962] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 14.404610] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: GRANT vm-test-run-plv8> server # [ 14.405467] postgres[962]: ::1 2026-10-26 14:18:59.660 UTC [962] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 14.408515] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: GRANT vm-test-run-plv8> server # [ 14.409552] postgres[962]: ::1 2026-10-26 14:18:59.665 UTC [962] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 14.411580] postgres[962]: ::1 2026-10-26 14:18:59.665 UTC [962] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 14.412644] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: GRANT vm-test-run-plv8> server # [ 14.415113] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: GRANT vm-test-run-plv8> server # [ 14.416386] postgres[962]: ::1 2026-10-26 14:18:59.670 UTC [962] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 14.418970] postgres[962]: ::1 2026-10-26 14:18:59.671 UTC [962] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 14.421255] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: GRANT vm-test-run-plv8> server # [ 14.421873] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: GRANT vm-test-run-plv8> server # [ 14.422634] postgres[962]: ::1 2026-10-26 14:18:59.673 UTC [962] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 14.423307] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: GRANT vm-test-run-plv8> server # [ 14.427216] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[961]: DO vm-test-run-plv8> server # [ 14.432871] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running pgbouncer auth schema... vm-test-run-plv8> server # [ 14.460423] postgres[964]: ::1 2026-10-26 14:18:59.715 UTC [964] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-plv8> server # [ 14.462360] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[963]: CREATE ROLE vm-test-run-plv8> server # [ 14.462651] postgres[964]: ::1 2026-10-26 14:18:59.717 UTC [964] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-plv8> server # [ 14.466373] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[963]: REVOKE vm-test-run-plv8> server # [ 14.467454] postgres[964]: ::1 2026-10-26 14:18:59.722 UTC [964] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-plv8> server # [ 14.470689] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[963]: CREATE SCHEMA vm-test-run-plv8> server # [ 14.472718] postgres[964]: ::1 2026-10-26 14:18:59.726 UTC [964] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-plv8> server # [ 14.474911] postgres[964]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-plv8> server # [ 14.475872] postgres[964]: $$ vm-test-run-plv8> server # [ 14.476568] postgres[964]: BEGIN vm-test-run-plv8> server # [ 14.477390] postgres[964]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-plv8> server # [ 14.478304] postgres[964]: vm-test-run-plv8> server # [ 14.479716] postgres[964]: RETURN QUERY vm-test-run-plv8> server # [ 14.479800] postgres[964]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-plv8> server # [ 14.481271] postgres[964]: WHERE usename = p_usename; vm-test-run-plv8> server # [ 14.483224] postgres[964]: END; vm-test-run-plv8> server # [ 14.484156] postgres[964]: $$ LANGUAGE plpgsql vm-test-run-plv8> server # [ 14.485285] postgres[964]: SET search_path = '' vm-test-run-plv8> server # [ 14.485527] postgres[964]: SECURITY DEFINER; vm-test-run-plv8> server # [ 14.485831] postgres[964]: ::1 2026-10-26 14:18:59.731 UTC [964] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-plv8> server # [ 14.486961] postgres[964]: ::1 2026-10-26 14:18:59.740 UTC [964] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-plv8> server # [ 14.487977] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[963]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.489383] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[963]: REVOKE vm-test-run-plv8> server # [ 14.492838] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[963]: GRANT vm-test-run-plv8> server # [ 14.500826] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running stat extension... vm-test-run-plv8> server # [ 14.532551] postgres[966]: ::1 2026-10-26 14:18:59.787 UTC [966] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-plv8> server # [ 14.534498] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[965]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-plv8> server # [ 14.536560] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[965]: CREATE SCHEMA vm-test-run-plv8> server # [ 14.539047] postgres[966]: ::1 2026-10-26 14:18:59.791 UTC [966] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-plv8> server # [ 14.786543] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[965]: CREATE EXTENSION vm-test-run-plv8> server # [ 14.796226] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-plv8> server # [ 14.836703] postgres[970]: ::1 2026-10-26 14:19:00.090 UTC [970] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-plv8> server # [ 14.840743] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[967]: GRANT vm-test-run-plv8> server # [ 14.841853] postgres[970]: ::1 2026-10-26 14:19:00.096 UTC [970] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 14.844728] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[967]: GRANT vm-test-run-plv8> server # [ 14.846979] postgres[970]: ::1 2026-10-26 14:19:00.100 UTC [970] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 14.847916] postgres[970]: ::1 2026-10-26 14:19:00.102 UTC [970] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 14.849164] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[967]: GRANT vm-test-run-plv8> server # [ 14.853262] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[967]: GRANT vm-test-run-plv8> server # [ 14.854565] postgres[970]: ::1 2026-10-26 14:19:00.109 UTC [970] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 14.857388] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[967]: GRANT vm-test-run-plv8> server # [ 14.857626] postgres[970]: ::1 2026-10-26 14:19:00.112 UTC [970] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 14.860986] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[967]: GRANT vm-test-run-plv8> server # [ 14.862259] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[967]: GRANT vm-test-run-plv8> server # [ 14.863255] postgres[970]: ::1 2026-10-26 14:19:00.116 UTC [970] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 14.865206] postgres[970]: ::1 2026-10-26 14:19:00.118 UTC [970] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 14.867599] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[967]: GRANT vm-test-run-plv8> server # [ 14.868861] postgres[970]: ::1 2026-10-26 14:19:00.123 UTC [970] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 14.871416] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[967]: GRANT vm-test-run-plv8> server # [ 14.874029] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[967]: DO vm-test-run-plv8> server # [ 14.875111] postgres[970]: ::1 2026-10-26 14:19:00.129 UTC [970] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-plv8> server # [ 14.877823] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[967]: ALTER ROLE vm-test-run-plv8> server # [ 14.884986] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-plv8> server # [ 14.916750] postgres[974]: ::1 2026-10-26 14:19:00.171 UTC [974] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.921065] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: GRANT vm-test-run-plv8> server # [ 14.923085] postgres[974]: ::1 2026-10-26 14:19:00.178 UTC [974] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.926359] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: GRANT vm-test-run-plv8> server # [ 14.927123] postgres[974]: ::1 2026-10-26 14:19:00.181 UTC [974] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.929936] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: GRANT vm-test-run-plv8> server # [ 14.930858] postgres[974]: ::1 2026-10-26 14:19:00.186 UTC [974] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.933257] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: ALTER TABLE vm-test-run-plv8> server # [ 14.934287] postgres[974]: ::1 2026-10-26 14:19:00.189 UTC [974] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.936765] postgres[974]: ::1 2026-10-26 14:19:00.191 UTC [974] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.939183] postgres[974]: ::1 2026-10-26 14:19:00.191 UTC [974] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.939873] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: ALTER TABLE vm-test-run-plv8> server # [ 14.940452] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: ALTER TABLE vm-test-run-plv8> server # [ 14.940970] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: ALTER TABLE vm-test-run-plv8> server # [ 14.941590] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: ALTER TABLE vm-test-run-plv8> server # [ 14.942167] postgres[974]: ::1 2026-10-26 14:19:00.193 UTC [974] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 14.943066] postgres[974]: ::1 2026-10-26 14:19:00.194 UTC [974] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 14.944538] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: GRANT vm-test-run-plv8> server # [ 14.945989] postgres[974]: ::1 2026-10-26 14:19:00.199 UTC [974] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 14.947679] postgres[974]: ::1 2026-10-26 14:19:00.201 UTC [974] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 14.948743] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: GRANT vm-test-run-plv8> server # [ 14.949804] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: GRANT vm-test-run-plv8> server # [ 14.951081] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: GRANT vm-test-run-plv8> server # [ 14.951927] postgres[974]: ::1 2026-10-26 14:19:00.202 UTC [974] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 14.952805] postgres[974]: ::1 2026-10-26 14:19:00.204 UTC [974] 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 # [ 14.953991] postgres[974]: ::1 2026-10-26 14:19:00.206 UTC [974] 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 # [ 14.957624] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 14.958278] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 14.959793] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[973]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 14.961584] postgres[974]: ::1 2026-10-26 14:19:00.209 UTC [974] 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 # [ 14.964829] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-plv8> server # [ 15.008634] postgres[976]: ::1 2026-10-26 14:19:00.262 UTC [976] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-plv8> server # [ 15.011941] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[975]: CREATE SCHEMA vm-test-run-plv8> server # [ 15.016841] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-plv8> server # [ 15.050222] postgres[978]: ::1 2026-10-26 14:19:00.305 UTC [978] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-plv8> server # [ 15.053860] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[977]: GRANT vm-test-run-plv8> server # [ 15.054563] postgres[978]: ::1 2026-10-26 14:19:00.309 UTC [978] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 15.057173] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[977]: GRANT vm-test-run-plv8> server # [ 15.058589] postgres[978]: ::1 2026-10-26 14:19:00.314 UTC [978] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 15.061197] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[977]: GRANT vm-test-run-plv8> server # [ 15.062471] postgres[978]: ::1 2026-10-26 14:19:00.315 UTC [978] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 15.064749] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[977]: GRANT vm-test-run-plv8> server # [ 15.073940] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-plv8> server # [ 15.116602] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[979]: DO vm-test-run-plv8> server # [ 15.117560] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[979]: DO vm-test-run-plv8> server # [ 15.119082] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[979]: DO vm-test-run-plv8> server # [ 15.127474] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-plv8> server # [ 15.166432] postgres[983]: ::1 2026-10-26 14:19:00.421 UTC [983] 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 # [ 15.170539] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[982]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 15.172254] postgres[983]: ::1 2026-10-26 14:19:00.426 UTC [983] 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 # [ 15.175117] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[982]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 15.176469] postgres[983]: ::1 2026-10-26 14:19:00.432 UTC [983] 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 # [ 15.179958] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[982]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 15.187123] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-plv8> server # [ 15.220761] postgres[985]: ::1 2026-10-26 14:19:00.476 UTC [985] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-plv8> server # [ 15.224674] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[984]: ALTER ROLE vm-test-run-plv8> server # [ 15.233317] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-plv8> server # [ 15.263220] postgres[987]: ::1 2026-10-26 14:19:00.518 UTC [987] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 15.265178] postgres[987]: ::1 2026-10-26 14:19:00.519 UTC [987] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 15.266980] postgres[987]: ::1 2026-10-26 14:19:00.520 UTC [987] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 15.269446] postgres[987]: DECLARE vm-test-run-plv8> server # [ 15.270036] postgres[987]: cmd record; vm-test-run-plv8> server # [ 15.270553] postgres[987]: BEGIN vm-test-run-plv8> server # [ 15.270990] postgres[987]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 15.272423] postgres[987]: LOOP vm-test-run-plv8> server # [ 15.273230] postgres[987]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 15.273915] postgres[987]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 15.275072] postgres[987]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 15.276540] postgres[987]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 15.277621] postgres[987]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 15.278442] postgres[987]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 15.279536] postgres[987]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 15.280394] postgres[987]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 15.281151] postgres[987]: , 'CREATE TYPE' vm-test-run-plv8> server # [ 15.281880] postgres[987]: , 'CREATE RULE' vm-test-run-plv8> server # [ 15.282668] postgres[987]: , 'COMMENT' vm-test-run-plv8> server # [ 15.283220] postgres[987]: ) vm-test-run-plv8> server # [ 15.283731] postgres[987]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 15.284967] postgres[987]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 15.286383] postgres[987]: THEN vm-test-run-plv8> server # [ 15.286868] postgres[987]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 15.287911] postgres[987]: END IF; vm-test-run-plv8> server # [ 15.288526] postgres[987]: END LOOP; vm-test-run-plv8> server # [ 15.289039] postgres[987]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 15.290455] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: 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 # [ 15.294191] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 15.295570] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: 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 # [ 15.299263] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: DROP FUNCTION vm-test-run-plv8> server # [ 15.300843] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: CREATE FUNCTION vm-test-run-plv8> server # [ 15.301513] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: CREATE FUNCTION vm-test-run-plv8> server # [ 15.302089] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: 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 # [ 15.302611] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 15.303176] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 15.303727] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: 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 # [ 15.304282] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 15.304796] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[986]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 15.305669] postgres[987]: ::1 2026-10-26 14:19:00.527 UTC [987] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 15.306609] postgres[987]: DECLARE vm-test-run-plv8> server # [ 15.307541] postgres[987]: obj record; vm-test-run-plv8> server # [ 15.308247] postgres[987]: BEGIN vm-test-run-plv8> server # [ 15.308961] postgres[987]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 15.309840] postgres[987]: LOOP vm-test-run-plv8> server # [ 15.311096] postgres[987]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 15.314623] postgres[987]: 'schema' vm-test-run-plv8> server # [ 15.317161] postgres[987]: , 'table' vm-test-run-plv8> server # [ 15.318288] postgres[987]: , 'foreign table' vm-test-run-plv8> server # [ 15.319304] postgres[987]: , 'view' vm-test-run-plv8> server # [ 15.320393] postgres[987]: , 'materialized view' vm-test-run-plv8> server # [ 15.321276] postgres[987]: , 'function' vm-test-run-plv8> server # [ 15.321899] postgres[987]: , 'trigger' vm-test-run-plv8> server # [ 15.322801] postgres[987]: , 'type' vm-test-run-plv8> server # [ 15.323653] postgres[987]: , 'rule' vm-test-run-plv8> server # [ 15.324456] postgres[987]: ) vm-test-run-plv8> server # [ 15.325387] postgres[987]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 15.326597] postgres[987]: THEN vm-test-run-plv8> server # [ 15.327246] postgres[987]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 15.328166] postgres[987]: END IF; vm-test-run-plv8> server # [ 15.329091] postgres[987]: END LOOP; vm-test-run-plv8> server # [ 15.329962] postgres[987]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 15.330814] postgres[987]: ::1 2026-10-26 14:19:00.529 UTC [987] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 15.331529] postgres[987]: ::1 2026-10-26 14:19:00.529 UTC [987] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 15.332271] postgres[987]: ON ddl_command_end vm-test-run-plv8> server # [ 15.332940] postgres[987]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 15.333798] postgres[987]: ::1 2026-10-26 14:19:00.530 UTC [987] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 15.334858] postgres[987]: ::1 2026-10-26 14:19:00.531 UTC [987] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 15.335900] postgres[987]: ON sql_drop vm-test-run-plv8> server # [ 15.337074] postgres[987]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 15.338112] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-plv8> server # [ 15.536308] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[988]: DO vm-test-run-plv8> server # [ 15.544755] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-plv8> server # [ 15.583389] postgres[991]: ::1 2026-10-26 14:19:00.838 UTC [991] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-plv8> server # [ 15.587119] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: CREATE SCHEMA vm-test-run-plv8> server # [ 15.587783] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: 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 # [ 15.588385] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: DROP FUNCTION vm-test-run-plv8> server # [ 15.589239] postgres[991]: ::1 2026-10-26 14:19:00.842 UTC [991] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-plv8> server # [ 15.589988] postgres[991]: ::1 2026-10-26 14:19:00.842 UTC [991] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 15.590632] postgres[991]: "operationName" text default null, vm-test-run-plv8> server # [ 15.591471] postgres[991]: query text default null, vm-test-run-plv8> server # [ 15.592151] postgres[991]: variables jsonb default null, vm-test-run-plv8> server # [ 15.592760] postgres[991]: extensions jsonb default null vm-test-run-plv8> server # [ 15.593624] postgres[991]: ) vm-test-run-plv8> server # [ 15.594339] postgres[991]: returns jsonb vm-test-run-plv8> server # [ 15.594909] postgres[991]: language plpgsql vm-test-run-plv8> server # [ 15.595755] postgres[991]: as $$ vm-test-run-plv8> server # [ 15.596377] postgres[991]: DECLARE vm-test-run-plv8> server # [ 15.596477] postgres[991]: server_version float; vm-test-run-plv8> server # [ 15.596659] postgres[991]: BEGIN vm-test-run-plv8> server # [ 15.597533] postgres[991]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 15.598135] postgres[991]: vm-test-run-plv8> server # [ 15.598736] postgres[991]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 15.599520] postgres[991]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 15.600152] postgres[991]: 'data', null::jsonb, vm-test-run-plv8> server # [ 15.600777] postgres[991]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 15.601518] postgres[991]: ); vm-test-run-plv8> server # [ 15.602221] postgres[991]: ELSE vm-test-run-plv8> server # [ 15.602828] postgres[991]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 15.604354] postgres[991]: 'data', null::jsonb, vm-test-run-plv8> server # [ 15.605105] postgres[991]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 15.605779] postgres[991]: ); vm-test-run-plv8> server # [ 15.606459] postgres[991]: END IF; vm-test-run-plv8> server # [ 15.607159] postgres[991]: END; vm-test-run-plv8> server # [ 15.607934] postgres[991]: $$; vm-test-run-plv8> server # [ 15.613271] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: CREATE FUNCTION vm-test-run-plv8> server # [ 15.614818] postgres[991]: ::1 2026-10-26 14:19:00.870 UTC [991] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 15.617331] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: GRANT vm-test-run-plv8> server # [ 15.618915] postgres[991]: ::1 2026-10-26 14:19:00.874 UTC [991] 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 # [ 15.622151] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 15.623442] postgres[991]: ::1 2026-10-26 14:19:00.877 UTC [991] 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 # [ 15.627112] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 15.628194] postgres[991]: ::1 2026-10-26 14:19:00.882 UTC [991] 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 # [ 15.631776] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 15.633566] postgres[991]: ::1 2026-10-26 14:19:00.888 UTC [991] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 15.633817] postgres[991]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 15.638594] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 15.638913] postgres[991]: ::1 2026-10-26 14:19:00.893 UTC [991] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 15.639059] postgres[991]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 15.643667] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 15.645207] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 15.646559] postgres[991]: ::1 2026-10-26 14:19:00.899 UTC [991] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 15.648654] postgres[991]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 15.649611] postgres[991]: ::1 2026-10-26 14:19:00.902 UTC [991] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 15.650232] postgres[991]: RETURNS event_trigger vm-test-run-plv8> server # [ 15.650865] postgres[991]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 15.651794] postgres[991]: AS $func$ vm-test-run-plv8> server # [ 15.652959] postgres[991]: DECLARE vm-test-run-plv8> server # [ 15.653950] postgres[991]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 15.654582] postgres[991]: BEGIN vm-test-run-plv8> server # [ 15.654690] postgres[991]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 15.654800] postgres[991]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 15.654948] postgres[991]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 15.656068] postgres[991]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 15.656669] postgres[991]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 15.657179] postgres[991]: ); vm-test-run-plv8> server # [ 15.657836] postgres[991]: vm-test-run-plv8> server # [ 15.658809] postgres[991]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 15.659690] postgres[991]: THEN vm-test-run-plv8> server # [ 15.660877] postgres[991]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 15.663151] postgres[991]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 15.664722] postgres[991]: vm-test-run-plv8> server # [ 15.665186] postgres[991]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 15.666413] postgres[991]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 15.667298] postgres[991]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 15.670417] postgres[991]: vm-test-run-plv8> server # [ 15.670867] postgres[991]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 15.671768] postgres[991]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 15.673090] postgres[991]: "operationName" text default null, vm-test-run-plv8> server # [ 15.674256] postgres[991]: query text default null, vm-test-run-plv8> server # [ 15.674892] postgres[991]: variables jsonb default null, vm-test-run-plv8> server # [ 15.675040] postgres[991]: extensions jsonb default null vm-test-run-plv8> server # [ 15.675152] postgres[991]: ) vm-test-run-plv8> server # [ 15.675264] postgres[991]: returns jsonb vm-test-run-plv8> server # [ 15.675422] postgres[991]: language sql vm-test-run-plv8> server # [ 15.678181] postgres[991]: as $$ vm-test-run-plv8> server # [ 15.679217] postgres[991]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-plv8> server # [ 15.681545] postgres[991]: $$; vm-test-run-plv8> server # [ 15.682427] postgres[991]: vm-test-run-plv8> server # [ 15.682902] postgres[991]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 15.683667] postgres[991]: END IF; vm-test-run-plv8> server # [ 15.683755] postgres[991]: vm-test-run-plv8> server # [ 15.683846] postgres[991]: END; vm-test-run-plv8> server # [ 15.683947] postgres[991]: $func$; vm-test-run-plv8> server # [ 15.687065] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: CREATE FUNCTION vm-test-run-plv8> server # [ 15.688458] postgres[991]: ::1 2026-10-26 14:19:00.942 UTC [991] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-plv8> server # [ 15.689524] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: 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 # [ 15.690143] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 15.690738] postgres[991]: ::1 2026-10-26 14:19:00.944 UTC [991] 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 # [ 15.691243] postgres[991]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-plv8> server # [ 15.697505] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 15.697761] postgres[991]: ::1 2026-10-26 14:19:00.952 UTC [991] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-plv8> server # [ 15.701304] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: COMMENT vm-test-run-plv8> server # [ 15.702490] postgres[991]: ::1 2026-10-26 14:19:00.957 UTC [991] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 15.704346] postgres[991]: RETURNS event_trigger vm-test-run-plv8> server # [ 15.705117] postgres[991]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 15.705834] postgres[991]: AS $func$ vm-test-run-plv8> server # [ 15.706443] postgres[991]: DECLARE vm-test-run-plv8> server # [ 15.706982] postgres[991]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 15.707728] postgres[991]: BEGIN vm-test-run-plv8> server # [ 15.708304] postgres[991]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 15.709051] postgres[991]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 15.710097] postgres[991]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 15.710942] postgres[991]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 15.713582] postgres[991]: ); vm-test-run-plv8> server # [ 15.714359] postgres[991]: vm-test-run-plv8> server # [ 15.714832] postgres[991]: IF graphql_is_dropped vm-test-run-plv8> server # [ 15.715667] postgres[991]: THEN vm-test-run-plv8> server # [ 15.716191] postgres[991]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 15.717385] postgres[991]: "operationName" text default null, vm-test-run-plv8> server # [ 15.717988] postgres[991]: query text default null, vm-test-run-plv8> server # [ 15.718791] postgres[991]: variables jsonb default null, vm-test-run-plv8> server # [ 15.719398] postgres[991]: extensions jsonb default null vm-test-run-plv8> server # [ 15.720376] postgres[991]: ) vm-test-run-plv8> server # [ 15.720952] postgres[991]: returns jsonb vm-test-run-plv8> server # [ 15.721377] postgres[991]: language plpgsql vm-test-run-plv8> server # [ 15.722058] postgres[991]: as $$ vm-test-run-plv8> server # [ 15.722884] postgres[991]: DECLARE vm-test-run-plv8> server # [ 15.723628] postgres[991]: server_version float; vm-test-run-plv8> server # [ 15.724405] postgres[991]: BEGIN vm-test-run-plv8> server # [ 15.725095] postgres[991]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 15.726196] postgres[991]: vm-test-run-plv8> server # [ 15.726816] postgres[991]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 15.727213] postgres[991]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 15.728502] postgres[991]: 'data', null::jsonb, vm-test-run-plv8> server # [ 15.729609] postgres[991]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 15.730349] postgres[991]: ); vm-test-run-plv8> server # [ 15.730947] postgres[991]: ELSE vm-test-run-plv8> server # [ 15.731803] postgres[991]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 15.732663] postgres[991]: 'data', null::jsonb, vm-test-run-plv8> server # [ 15.733510] postgres[991]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 15.734238] postgres[991]: ); vm-test-run-plv8> server # [ 15.734876] postgres[991]: END IF; vm-test-run-plv8> server # [ 15.735730] postgres[991]: END; vm-test-run-plv8> server # [ 15.736583] postgres[991]: $$; vm-test-run-plv8> server # [ 15.737268] postgres[991]: END IF; vm-test-run-plv8> server # [ 15.737931] postgres[991]: vm-test-run-plv8> server # [ 15.738491] postgres[991]: END; vm-test-run-plv8> server # [ 15.739077] postgres[991]: $func$; vm-test-run-plv8> server # [ 15.739724] postgres[991]: ::1 2026-10-26 14:19:00.962 UTC [991] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-plv8> server # [ 15.740466] postgres[991]: ::1 2026-10-26 14:19:00.964 UTC [991] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-plv8> server # [ 15.741074] postgres[991]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-plv8> server # [ 15.741722] postgres[991]: ::1 2026-10-26 14:19:00.970 UTC [991] 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 # [ 15.742387] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: CREATE FUNCTION vm-test-run-plv8> server # [ 15.742962] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: 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 # [ 15.743643] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 15.744172] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 15.744684] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[990]: COMMENT vm-test-run-plv8> server # [ 15.758792] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-plv8> server # [ 15.783854] dhcpcd[801]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-plv8> server # [ 15.785217] dhcpcd[801]: eth0: adding route to 10.0.2.0/24 vm-test-run-plv8> server # [ 15.786178] dhcpcd[801]: eth0: adding default route via 10.0.2.2 vm-test-run-plv8> server # [ 15.792717] postgres[993]: ::1 2026-10-26 14:19:01.047 UTC [993] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 15.795129] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[992]: 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 # [ 15.798888] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[992]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 15.800292] postgres[993]: ::1 2026-10-26 14:19:01.049 UTC [993] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 15.803333] postgres[993]: ::1 2026-10-26 14:19:01.052 UTC [993] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 15.806416] postgres[993]: DECLARE vm-test-run-plv8> server # [ 15.807040] postgres[993]: cmd record; vm-test-run-plv8> server # [ 15.808359] postgres[993]: BEGIN vm-test-run-plv8> server # [ 15.808970] postgres[993]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 15.810139] postgres[993]: LOOP vm-test-run-plv8> server # [ 15.811531] postgres[993]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 15.812745] postgres[993]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 15.814559] postgres[993]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 15.815628] postgres[993]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 15.816744] postgres[993]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 15.816846] postgres[993]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 15.816955] postgres[993]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 15.817102] postgres[993]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 15.817202] postgres[993]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-plv8> server # [ 15.817819] postgres[993]: , 'CREATE RULE' vm-test-run-plv8> server # [ 15.818869] postgres[993]: , 'COMMENT' vm-test-run-plv8> server # [ 15.819843] postgres[993]: ) vm-test-run-plv8> server # [ 15.820740] postgres[993]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 15.821689] postgres[993]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 15.822680] postgres[993]: THEN vm-test-run-plv8> server # [ 15.823593] postgres[993]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 15.824455] postgres[993]: END IF; vm-test-run-plv8> server # [ 15.825351] postgres[993]: END LOOP; vm-test-run-plv8> server # [ 15.825950] postgres[993]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 15.826813] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[992]: 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 # [ 15.827711] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[992]: DROP FUNCTION vm-test-run-plv8> server # [ 15.828184] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[992]: CREATE FUNCTION vm-test-run-plv8> server # [ 15.828714] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[992]: CREATE FUNCTION vm-test-run-plv8> server # [ 15.829616] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[992]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 15.830156] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[992]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 15.830750] postgres[993]: ::1 2026-10-26 14:19:01.058 UTC [993] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 15.831678] postgres[993]: DECLARE vm-test-run-plv8> server # [ 15.832512] postgres[993]: obj record; vm-test-run-plv8> server # [ 15.833303] postgres[993]: BEGIN vm-test-run-plv8> server # [ 15.833957] postgres[993]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 15.834873] postgres[993]: LOOP vm-test-run-plv8> server # [ 15.835769] postgres[993]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 15.837147] postgres[993]: 'schema' vm-test-run-plv8> server # [ 15.838940] postgres[993]: , 'table' vm-test-run-plv8> server # [ 15.839873] postgres[993]: , 'foreign table' vm-test-run-plv8> server # [ 15.840813] postgres[993]: , 'view' vm-test-run-plv8> server # [ 15.841879] postgres[993]: , 'materialized view' vm-test-run-plv8> server # [ 15.843247] postgres[993]: , 'function' vm-test-run-plv8> server # [ 15.843896] postgres[993]: , 'trigger' vm-test-run-plv8> server # [ 15.844729] postgres[993]: , 'type' vm-test-run-plv8> server # [ 15.845442] postgres[993]: , 'rule' vm-test-run-plv8> server # [ 15.846267] postgres[993]: ) vm-test-run-plv8> server # [ 15.847903] postgres[993]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 15.849402] postgres[993]: THEN vm-test-run-plv8> server # [ 15.850058] postgres[993]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 15.851113] postgres[993]: END IF; vm-test-run-plv8> server # [ 15.851698] postgres[993]: END LOOP; vm-test-run-plv8> server # [ 15.852276] postgres[993]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 15.852962] postgres[993]: ::1 2026-10-26 14:19:01.063 UTC [993] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 15.853800] postgres[993]: ::1 2026-10-26 14:19:01.066 UTC [993] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 15.854552] postgres[993]: ON ddl_command_end vm-test-run-plv8> server # [ 15.855252] postgres[993]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 15.856105] postgres[993]: ::1 2026-10-26 14:19:01.106 UTC [993] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 15.859862] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[992]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 15.860993] postgres[993]: ::1 2026-10-26 14:19:01.115 UTC [993] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 15.862588] postgres[993]: ON sql_drop vm-test-run-plv8> server # [ 15.863256] postgres[993]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 15.864861] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[992]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 15.872198] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-plv8> server # [ 15.916303] postgres[1009]: ::1 2026-10-26 14:19:01.171 UTC [1009] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-plv8> server # [ 15.918956] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[998]: ALTER ROLE vm-test-run-plv8> server # [ 15.928915] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-plv8> server # [ 15.980831] postgres[1035]: ::1 2026-10-26 14:19:01.236 UTC [1035] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 15.982993] postgres[1035]: returns event_trigger vm-test-run-plv8> server # [ 15.983919] postgres[1035]: language plpgsql vm-test-run-plv8> server # [ 15.985412] postgres[1035]: AS $func$ vm-test-run-plv8> server # [ 15.986587] postgres[1035]: DECLARE vm-test-run-plv8> server # [ 15.987491] postgres[1035]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 15.989245] postgres[1035]: BEGIN vm-test-run-plv8> server # [ 15.990116] postgres[1035]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 15.991179] postgres[1035]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 15.992575] postgres[1035]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 15.993928] postgres[1035]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 15.995403] postgres[1035]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 15.996404] postgres[1035]: ); vm-test-run-plv8> server # [ 15.997467] postgres[1035]: vm-test-run-plv8> server # [ 15.998070] postgres[1035]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 15.999164] postgres[1035]: THEN vm-test-run-plv8> server # [ 16.000182] postgres[1035]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.001449] postgres[1035]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.004091] postgres[1035]: vm-test-run-plv8> server # [ 16.004719] postgres[1035]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.007048] postgres[1035]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.010456] postgres[1035]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.012248] postgres[1035]: vm-test-run-plv8> server # [ 16.012851] postgres[1035]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 16.013912] postgres[1035]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 16.016587] postgres[1035]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 16.020381] postgres[1035]: "operationName" text default null, vm-test-run-plv8> server # [ 16.023675] postgres[1035]: query text default null, vm-test-run-plv8> server # [ 16.024751] postgres[1035]: variables jsonb default null, vm-test-run-plv8> server # [ 16.025722] postgres[1035]: extensions jsonb default null vm-test-run-plv8> server # [ 16.027245] postgres[1035]: ) vm-test-run-plv8> server # [ 16.027796] postgres[1035]: returns jsonb vm-test-run-plv8> server # [ 16.028440] postgres[1035]: language sql vm-test-run-plv8> server # [ 16.029286] postgres[1035]: as $$ vm-test-run-plv8> server # [ 16.031399] postgres[1035]: -- This changed vm-test-run-plv8> server # [ 16.032368] postgres[1035]: select graphql.resolve( vm-test-run-plv8> server # [ 16.033492] postgres[1035]: query := query, vm-test-run-plv8> server # [ 16.035517] postgres[1035]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 16.036612] postgres[1035]: "operationName" := "operationName", vm-test-run-plv8> server # [ 16.036862] postgres[1035]: extensions := extensions vm-test-run-plv8> server # [ 16.037169] postgres[1035]: ); vm-test-run-plv8> server # [ 16.039750] postgres[1035]: $$; vm-test-run-plv8> server # [ 16.040499] postgres[1035]: vm-test-run-plv8> server # [ 16.041345] postgres[1035]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.042186] postgres[1035]: END IF; vm-test-run-plv8> server # [ 16.043759] postgres[1035]: vm-test-run-plv8> server # [ 16.044444] postgres[1035]: END; vm-test-run-plv8> server # [ 16.045232] postgres[1035]: $func$; vm-test-run-plv8> server # [ 16.046445] postgres[1035]: ::1 2026-10-26 14:19:01.265 UTC [1035] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 16.047580] postgres[1035]: RETURNS event_trigger vm-test-run-plv8> server # [ 16.048963] postgres[1035]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 16.049842] postgres[1035]: AS $func$ vm-test-run-plv8> server # [ 16.050555] postgres[1035]: DECLARE vm-test-run-plv8> server # [ 16.051728] postgres[1035]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 16.052705] postgres[1035]: BEGIN vm-test-run-plv8> server # [ 16.053683] postgres[1035]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 16.055438] postgres[1035]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 16.056576] postgres[1035]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 16.056853] postgres[1035]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 16.056991] postgres[1035]: ); vm-test-run-plv8> server # [ 16.057224] postgres[1035]: vm-test-run-plv8> server # [ 16.057388] postgres[1035]: IF graphql_is_dropped vm-test-run-plv8> server # [ 16.057531] postgres[1035]: THEN vm-test-run-plv8> server # [ 16.058859] postgres[1035]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 16.060843] postgres[1035]: "operationName" text default null, vm-test-run-plv8> server # [ 16.062488] postgres[1035]: query text default null, vm-test-run-plv8> server # [ 16.064078] postgres[1035]: variables jsonb default null, vm-test-run-plv8> server # [ 16.065087] postgres[1035]: extensions jsonb default null vm-test-run-plv8> server # [ 16.065942] postgres[1035]: ) vm-test-run-plv8> server # [ 16.067099] postgres[1035]: returns jsonb vm-test-run-plv8> server # [ 16.068651] postgres[1035]: language plpgsql vm-test-run-plv8> server # [ 16.068945] postgres[1035]: as $$ vm-test-run-plv8> server # [ 16.069085] postgres[1035]: DECLARE vm-test-run-plv8> server # [ 16.069173] postgres[1035]: server_version float; vm-test-run-plv8> server # [ 16.069248] postgres[1035]: BEGIN vm-test-run-plv8> server # [ 16.069326] postgres[1035]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 16.069400] postgres[1035]: vm-test-run-plv8> server # [ 16.069491] postgres[1035]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 16.069564] postgres[1035]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 16.069629] postgres[1035]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 16.069699] postgres[1035]: jsonb_build_object( vm-test-run-plv8> server # [ 16.069769] postgres[1035]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 16.069838] postgres[1035]: ) vm-test-run-plv8> server # [ 16.069907] postgres[1035]: ) vm-test-run-plv8> server # [ 16.069976] postgres[1035]: ); vm-test-run-plv8> server # [ 16.070119] postgres[1035]: ELSE vm-test-run-plv8> server # [ 16.070191] postgres[1035]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 16.070256] postgres[1035]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 16.070340] postgres[1035]: jsonb_build_object( vm-test-run-plv8> server # [ 16.070412] postgres[1035]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 16.070481] postgres[1035]: ) vm-test-run-plv8> server # [ 16.070551] postgres[1035]: ) vm-test-run-plv8> server # [ 16.070619] postgres[1035]: ); vm-test-run-plv8> server # [ 16.070684] postgres[1035]: END IF; vm-test-run-plv8> server # [ 16.070752] postgres[1035]: END; vm-test-run-plv8> server # [ 16.070821] postgres[1035]: $$; vm-test-run-plv8> server # [ 16.070943] postgres[1035]: END IF; vm-test-run-plv8> server # [ 16.071038] postgres[1035]: vm-test-run-plv8> server # [ 16.071106] postgres[1035]: END; vm-test-run-plv8> server # [ 16.071774] postgres[1035]: $func$; vm-test-run-plv8> server # [ 16.072752] postgres[1035]: ::1 2026-10-26 14:19:01.277 UTC [1035] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 16.074658] postgres[1035]: "operationName" text default null, vm-test-run-plv8> server # [ 16.075841] postgres[1035]: query text default null, vm-test-run-plv8> server # [ 16.076713] postgres[1035]: variables jsonb default null, vm-test-run-plv8> server # [ 16.078189] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1021]: CREATE FUNCTION vm-test-run-plv8> server # [ 16.079228] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1021]: CREATE FUNCTION vm-test-run-plv8> server # [ 16.079949] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1021]: CREATE FUNCTION vm-test-run-plv8> server # [ 16.080543] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1021]: 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 # [ 16.081165] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1021]: DROP EXTENSION vm-test-run-plv8> server # [ 16.081827] postgres[1035]: extensions jsonb default null vm-test-run-plv8> server # [ 16.082783] postgres[1035]: ) vm-test-run-plv8> server # [ 16.085619] postgres[1035]: returns jsonb vm-test-run-plv8> server # [ 16.086765] postgres[1035]: language plpgsql vm-test-run-plv8> server # [ 16.088702] postgres[1035]: as $$ vm-test-run-plv8> server # [ 16.089867] postgres[1035]: DECLARE vm-test-run-plv8> server # [ 16.090790] postgres[1035]: server_version float; vm-test-run-plv8> server # [ 16.091864] postgres[1035]: BEGIN vm-test-run-plv8> server # [ 16.092780] postgres[1035]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 16.093699] postgres[1035]: vm-test-run-plv8> server # [ 16.094581] postgres[1035]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 16.095269] postgres[1035]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 16.095951] postgres[1035]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 16.096798] postgres[1035]: jsonb_build_object( vm-test-run-plv8> server # [ 16.097986] postgres[1035]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 16.099079] postgres[1035]: ) vm-test-run-plv8> server # [ 16.100648] postgres[1035]: ) vm-test-run-plv8> server # [ 16.101750] postgres[1035]: ); vm-test-run-plv8> server # [ 16.102553] postgres[1035]: ELSE vm-test-run-plv8> server # [ 16.103156] postgres[1035]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 16.103756] postgres[1035]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 16.104571] postgres[1035]: jsonb_build_object( vm-test-run-plv8> server # [ 16.105538] postgres[1035]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 16.106809] postgres[1035]: ) vm-test-run-plv8> server # [ 16.107937] postgres[1035]: ) vm-test-run-plv8> server # [ 16.108890] postgres[1035]: ); vm-test-run-plv8> server # [ 16.109824] postgres[1035]: END IF; vm-test-run-plv8> server # [ 16.110533] postgres[1035]: END; vm-test-run-plv8> server # [ 16.111105] postgres[1035]: $$; vm-test-run-plv8> server # [ 16.112262] postgres[1035]: ::1 2026-10-26 14:19:01.282 UTC [1035] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 16.172151] systemd[1]: Started DHCP Client. vm-test-run-plv8> server # [ 16.468149] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1021]: DO vm-test-run-plv8> server # [ 16.476524] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: 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 # [ 16.510827] postgres[1049]: ::1 2026-10-26 14:19:01.766 UTC [1049] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-plv8> server # [ 16.513688] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1048]: GRANT ROLE vm-test-run-plv8> server # [ 16.520910] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-plv8> server # [ 16.551535] postgres[1051]: ::1 2026-10-26 14:19:01.806 UTC [1051] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 16.553524] postgres[1051]: returns event_trigger vm-test-run-plv8> server # [ 16.554389] postgres[1051]: language plpgsql vm-test-run-plv8> server # [ 16.555151] postgres[1051]: AS $func$ vm-test-run-plv8> server # [ 16.555926] postgres[1051]: DECLARE vm-test-run-plv8> server # [ 16.556582] postgres[1051]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 16.557556] postgres[1051]: BEGIN vm-test-run-plv8> server # [ 16.558151] postgres[1051]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 16.558961] postgres[1051]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 16.559895] postgres[1051]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 16.560973] postgres[1051]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 16.561930] postgres[1051]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 16.562762] postgres[1051]: ); vm-test-run-plv8> server # [ 16.563414] postgres[1051]: vm-test-run-plv8> server # [ 16.564098] postgres[1051]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 16.564825] postgres[1051]: THEN vm-test-run-plv8> server # [ 16.565293] postgres[1051]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 16.566574] postgres[1051]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 16.567839] postgres[1051]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 16.570277] postgres[1051]: "operationName" text default null, vm-test-run-plv8> server # [ 16.571608] postgres[1051]: query text default null, vm-test-run-plv8> server # [ 16.573088] postgres[1051]: variables jsonb default null, vm-test-run-plv8> server # [ 16.574138] postgres[1051]: extensions jsonb default null vm-test-run-plv8> server # [ 16.575286] postgres[1051]: ) vm-test-run-plv8> server # [ 16.575891] postgres[1051]: returns jsonb vm-test-run-plv8> server # [ 16.576785] postgres[1051]: language sql vm-test-run-plv8> server # [ 16.577617] postgres[1051]: as $$ vm-test-run-plv8> server # [ 16.578531] postgres[1051]: select graphql.resolve( vm-test-run-plv8> server # [ 16.579348] postgres[1051]: query := query, vm-test-run-plv8> server # [ 16.580359] postgres[1051]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 16.581649] postgres[1051]: "operationName" := "operationName", vm-test-run-plv8> server # [ 16.583090] postgres[1051]: extensions := extensions vm-test-run-plv8> server # [ 16.583942] postgres[1051]: ); vm-test-run-plv8> server # [ 16.584664] postgres[1051]: $$; vm-test-run-plv8> server # [ 16.585423] postgres[1051]: vm-test-run-plv8> server # [ 16.585878] postgres[1051]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 16.587762] postgres[1051]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 16.589611] postgres[1051]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 16.591166] postgres[1051]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.592665] postgres[1051]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.594701] postgres[1051]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.596584] postgres[1051]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.598389] postgres[1051]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.600120] postgres[1051]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.602420] postgres[1051]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 16.605138] postgres[1051]: END IF; vm-test-run-plv8> server # [ 16.605652] postgres[1051]: vm-test-run-plv8> server # [ 16.606295] postgres[1051]: END; vm-test-run-plv8> server # [ 16.606854] postgres[1051]: $func$; vm-test-run-plv8> server # [ 16.607654] postgres[1051]: ::1 2026-10-26 14:19:01.822 UTC [1051] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 16.609758] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1050]: CREATE FUNCTION vm-test-run-plv8> server # [ 16.610940] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1050]: DROP EXTENSION vm-test-run-plv8> server # [ 16.849168] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1050]: DO vm-test-run-plv8> server # [ 16.854656] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-plv8> server # [ 17.010417] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1052]: DO vm-test-run-plv8> server # [ 17.153088] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1052]: DO vm-test-run-plv8> server # [ 17.159105] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-plv8> server # [ 17.199598] postgres[1059]: ::1 2026-10-26 14:19:02.454 UTC [1059] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-plv8> server # [ 17.202788] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1058]: ALTER ROLE vm-test-run-plv8> server # [ 17.208236] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-plv8> server # [ 17.237813] postgres[1061]: ::1 2026-10-26 14:19:02.492 UTC [1061] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-plv8> server # [ 17.240533] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1060]: REVOKE ROLE vm-test-run-plv8> server # [ 17.246966] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-plv8> server # [ 17.649927] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1062]: DO vm-test-run-plv8> server # [ 17.659534] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-plv8> server # [ 17.689721] postgres[1065]: ::1 2026-10-26 14:19:02.945 UTC [1065] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-plv8> server # [ 17.691958] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1064]: GRANT ROLE vm-test-run-plv8> server # [ 17.698167] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-plv8> server # [ 17.729709] postgres[1067]: ::1 2026-10-26 14:19:02.985 UTC [1067] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 17.734277] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1066]: GRANT vm-test-run-plv8> server # [ 17.735355] postgres[1067]: ::1 2026-10-26 14:19:02.989 UTC [1067] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 17.738055] postgres[1067]: ::1 2026-10-26 14:19:02.992 UTC [1067] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 17.741548] postgres[1067]: ::1 2026-10-26 14:19:02.993 UTC [1067] 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 # [ 17.744644] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1066]: GRANT vm-test-run-plv8> server # [ 17.745700] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1066]: GRANT vm-test-run-plv8> server # [ 17.746661] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1066]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 17.748075] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1066]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 17.749675] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1066]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 17.751058] postgres[1067]: ::1 2026-10-26 14:19:02.995 UTC [1067] 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 # [ 17.753711] postgres[1067]: ::1 2026-10-26 14:19:02.996 UTC [1067] 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 # [ 17.756508] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-plv8> server # [ 17.786803] postgres[1069]: ::1 2026-10-26 14:19:03.042 UTC [1069] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-plv8> server # [ 17.789572] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1068]: GRANT ROLE vm-test-run-plv8> server # [ 17.795959] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 17.823844] postgres[1071]: ::1 2026-10-26 14:19:03.079 UTC [1071] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-plv8> server # [ 17.826868] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1070]: GRANT ROLE vm-test-run-plv8> server # [ 17.832054] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-plv8> server # [ 17.860764] postgres[1073]: ::1 2026-10-26 14:19:03.115 UTC [1073] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-plv8> server # [ 17.862554] postgres[1073]: ::1 2026-10-26 14:19:03.118 UTC [1073] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-plv8> server # [ 17.864442] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1072]: ALTER ROLE vm-test-run-plv8> server # [ 17.867072] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1072]: ALTER ROLE vm-test-run-plv8> server # [ 17.867372] postgres[1073]: ::1 2026-10-26 14:19:03.122 UTC [1073] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-plv8> server # [ 17.870897] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1072]: ALTER ROLE vm-test-run-plv8> server # [ 17.874244] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1072]: DO vm-test-run-plv8> server # [ 17.881567] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 17.911273] postgres[1075]: ::1 2026-10-26 14:19:03.166 UTC [1075] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-plv8> server # [ 17.913617] postgres[1075]: ::1 2026-10-26 14:19:03.168 UTC [1075] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-plv8> server # [ 17.916225] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1074]: GRANT ROLE vm-test-run-plv8> server # [ 17.917693] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1074]: REVOKE ROLE vm-test-run-plv8> server # [ 17.920129] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-plv8> server # [ 17.948510] postgres[1077]: ::1 2026-10-26 14:19:03.203 UTC [1077] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 17.948878] postgres[1077]: returns event_trigger vm-test-run-plv8> server # [ 17.948993] postgres[1077]: language plpgsql vm-test-run-plv8> server # [ 17.949125] postgres[1077]: AS $func$ vm-test-run-plv8> server # [ 17.949287] postgres[1077]: DECLARE vm-test-run-plv8> server # [ 17.950287] postgres[1077]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 17.954733] postgres[1077]: BEGIN vm-test-run-plv8> server # [ 17.955078] postgres[1077]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 17.955169] postgres[1077]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 17.955266] postgres[1077]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 17.955364] postgres[1077]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 17.955434] postgres[1077]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 17.955500] postgres[1077]: ); vm-test-run-plv8> server # [ 17.955579] postgres[1077]: vm-test-run-plv8> server # [ 17.955667] postgres[1077]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 17.955734] postgres[1077]: THEN vm-test-run-plv8> server # [ 17.955800] postgres[1077]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 17.955867] postgres[1077]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 17.955932] postgres[1077]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 17.956028] postgres[1077]: "operationName" text default null, vm-test-run-plv8> server # [ 17.956115] postgres[1077]: query text default null, vm-test-run-plv8> server # [ 17.956205] postgres[1077]: variables jsonb default null, vm-test-run-plv8> server # [ 17.956277] postgres[1077]: extensions jsonb default null vm-test-run-plv8> server # [ 17.956357] postgres[1077]: ) vm-test-run-plv8> server # [ 17.956428] postgres[1077]: returns jsonb vm-test-run-plv8> server # [ 17.956511] postgres[1077]: language sql vm-test-run-plv8> server # [ 17.956599] postgres[1077]: as $$ vm-test-run-plv8> server # [ 17.956678] postgres[1077]: select graphql.resolve( vm-test-run-plv8> server # [ 17.956766] postgres[1077]: query := query, vm-test-run-plv8> server # [ 17.956847] postgres[1077]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 17.956915] postgres[1077]: "operationName" := "operationName", vm-test-run-plv8> server # [ 17.956980] postgres[1077]: extensions := extensions vm-test-run-plv8> server # [ 17.957073] postgres[1077]: ); vm-test-run-plv8> server # [ 17.957141] postgres[1077]: $$; vm-test-run-plv8> server # [ 17.957238] postgres[1077]: vm-test-run-plv8> server # [ 17.957903] postgres[1077]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 17.958834] postgres[1077]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 17.959812] postgres[1077]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 17.960752] postgres[1077]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 17.961458] postgres[1077]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 17.962230] postgres[1077]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 17.962817] postgres[1077]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 17.963550] postgres[1077]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 17.964412] postgres[1077]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 17.965083] postgres[1077]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 17.965841] postgres[1077]: vm-test-run-plv8> server # [ 17.966672] postgres[1077]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-plv8> server # [ 17.967475] postgres[1077]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-plv8> server # [ 17.968269] postgres[1077]: grant usage on schema graphql to postgres with grant option; vm-test-run-plv8> server # [ 17.968913] postgres[1077]: END IF; vm-test-run-plv8> server # [ 17.969757] postgres[1077]: vm-test-run-plv8> server # [ 17.970630] postgres[1077]: END; vm-test-run-plv8> server # [ 17.971633] postgres[1077]: $func$; vm-test-run-plv8> server # [ 17.981910] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1076]: CREATE FUNCTION vm-test-run-plv8> server # [ 17.985122] postgres[1077]: ::1 2026-10-26 14:19:03.238 UTC [1077] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 17.989993] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1076]: DROP EXTENSION vm-test-run-plv8> server # [ 18.245832] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1076]: DO vm-test-run-plv8> server # [ 18.254278] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-plv8> server # [ 18.289341] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1083]: DO vm-test-run-plv8> server # [ 18.290428] postgres[1084]: ::1 2026-10-26 14:19:03.544 UTC [1084] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-plv8> server # [ 18.292355] postgres[1084]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 18.293200] postgres[1084]: AS $$ vm-test-run-plv8> server # [ 18.293274] postgres[1084]: BEGIN vm-test-run-plv8> server # [ 18.293357] postgres[1084]: IF EXISTS ( vm-test-run-plv8> server # [ 18.293427] postgres[1084]: SELECT vm-test-run-plv8> server # [ 18.293505] postgres[1084]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 18.293571] postgres[1084]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 18.293674] postgres[1084]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 18.293745] postgres[1084]: WHERE ext.extname = 'pg_cron' vm-test-run-plv8> server # [ 18.293814] postgres[1084]: ) vm-test-run-plv8> server # [ 18.293883] postgres[1084]: THEN vm-test-run-plv8> server # [ 18.293948] postgres[1084]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 18.294048] postgres[1084]: vm-test-run-plv8> server # [ 18.294773] postgres[1084]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 18.295513] postgres[1084]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 18.296207] postgres[1084]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 18.296850] postgres[1084]: vm-test-run-plv8> server # [ 18.297763] postgres[1084]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 18.298801] postgres[1084]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 18.299700] postgres[1084]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 18.300534] postgres[1084]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 18.301239] postgres[1084]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 18.301939] postgres[1084]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 18.302808] postgres[1084]: vm-test-run-plv8> server # [ 18.303782] postgres[1084]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 18.304689] postgres[1084]: revoke all on table cron.job from postgres; vm-test-run-plv8> server # [ 18.305485] postgres[1084]: grant select on table cron.job to postgres with grant option; vm-test-run-plv8> server # [ 18.306175] postgres[1084]: END IF; vm-test-run-plv8> server # [ 18.306844] postgres[1084]: END; vm-test-run-plv8> server # [ 18.307877] postgres[1084]: $$; vm-test-run-plv8> server # [ 18.320737] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1083]: CREATE FUNCTION vm-test-run-plv8> server # [ 18.321911] postgres[1084]: ::1 2026-10-26 14:19:03.576 UTC [1084] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-plv8> server # [ 18.325085] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1083]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 18.326522] postgres[1084]: ::1 2026-10-26 14:19:03.580 UTC [1084] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-plv8> server # [ 18.329595] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1083]: ALTER FUNCTION vm-test-run-plv8> server # [ 18.330597] postgres[1084]: ::1 2026-10-26 14:19:03.585 UTC [1084] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-plv8> server # [ 18.331671] postgres[1084]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-plv8> server # [ 18.334080] postgres[1084]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 18.335458] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1083]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 18.342558] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-plv8> server # [ 18.363181] postgres[1086]: ::1 2026-10-26 14:19:03.618 UTC [1086] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-plv8> server # [ 18.364987] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1085]: ALTER ROLE vm-test-run-plv8> server # [ 18.369384] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-plv8> server # [ 18.389273] postgres[1088]: ::1 2026-10-26 14:19:03.644 UTC [1088] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-plv8> server # [ 18.391448] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1087]: ALTER FUNCTION vm-test-run-plv8> server # [ 18.391682] postgres[1088]: ::1 2026-10-26 14:19:03.646 UTC [1088] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-plv8> server # [ 18.394073] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1087]: ALTER FUNCTION vm-test-run-plv8> server # [ 18.395304] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1087]: ALTER FUNCTION vm-test-run-plv8> server # [ 18.396416] postgres[1088]: ::1 2026-10-26 14:19:03.649 UTC [1088] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-plv8> server # [ 18.399186] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-plv8> server # [ 18.423387] postgres[1090]: ::1 2026-10-26 14:19:03.678 UTC [1090] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-plv8> server # [ 18.425227] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1089]: GRANT ROLE vm-test-run-plv8> server # [ 18.429785] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-plv8> server # [ 18.548225] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1091]: DO vm-test-run-plv8> server # [ 18.552062] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-plv8> server # [ 18.578686] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1093]: DO vm-test-run-plv8> server # [ 18.579743] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1093]: DO vm-test-run-plv8> server # [ 18.584307] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-plv8> server # [ 18.609293] postgres[1096]: ::1 2026-10-26 14:19:03.864 UTC [1096] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-plv8> server # [ 18.611431] postgres[1096]: ::1 2026-10-26 14:19:03.866 UTC [1096] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-plv8> server # [ 18.613590] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1095]: ALTER ROLE vm-test-run-plv8> server # [ 18.614567] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1095]: ALTER ROLE vm-test-run-plv8> server # [ 18.615476] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1095]: ALTER ROLE vm-test-run-plv8> server # [ 18.616554] postgres[1096]: ::1 2026-10-26 14:19:03.867 UTC [1096] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-plv8> server # [ 18.618720] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-plv8> server # [ 18.641427] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1097]: DO vm-test-run-plv8> server # [ 18.647114] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-plv8> server # [ 18.667237] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1099]: DO vm-test-run-plv8> server # [ 18.670608] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-plv8> server # [ 18.693877] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1101]: CREATE FUNCTION vm-test-run-plv8> server # [ 18.695413] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1101]: DO vm-test-run-plv8> server # [ 18.700352] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-plv8> server # [ 18.726575] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1103]: ALTER FUNCTION vm-test-run-plv8> server # [ 18.730656] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1103]: GRANT vm-test-run-plv8> server # [ 18.733759] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-plv8> server # [ 18.764773] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1105]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 18.767430] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1105]: ALTER FUNCTION vm-test-run-plv8> server # [ 18.768992] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1105]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 18.774391] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 18.796715] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1107]: DO vm-test-run-plv8> server # [ 18.800909] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-plv8> server # [ 18.829971] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1109]: CREATE FUNCTION vm-test-run-plv8> server # [ 18.831178] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1109]: GRANT vm-test-run-plv8> server # [ 18.835132] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-plv8> server # [ 18.876150] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1111]: REVOKE ROLE vm-test-run-plv8> server # [ 18.881293] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1111]: DO vm-test-run-plv8> server # [ 18.882530] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1111]: DO vm-test-run-plv8> server # [ 18.883746] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1111]: REVOKE ROLE vm-test-run-plv8> server # [ 18.884862] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1111]: REVOKE vm-test-run-plv8> server # [ 18.886950] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1111]: DO vm-test-run-plv8> server # [ 18.894046] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 18.929441] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1113]: DO vm-test-run-plv8> server # [ 18.938909] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 18.968040] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1115]: DO vm-test-run-plv8> server # [ 18.974276] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 19.004945] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1117]: DO vm-test-run-plv8> server # [ 19.010766] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-plv8> server # [ 19.042486] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1119]: ALTER ROLE vm-test-run-plv8> server # [ 19.047591] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-plv8> server # [ 19.079973] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1121]: GRANT ROLE vm-test-run-plv8> server # [ 19.081201] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1121]: DO vm-test-run-plv8> server # [ 19.087173] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-plv8> server # [ 19.122408] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1123]: GRANT vm-test-run-plv8> server # [ 19.129253] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-plv8> server # [ 19.170803] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1125]: CREATE FUNCTION vm-test-run-plv8> server # [ 19.172318] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1125]: REVOKE vm-test-run-plv8> server # [ 19.174533] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1125]: REVOKE vm-test-run-plv8> server # [ 19.176563] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1125]: GRANT vm-test-run-plv8> server # [ 19.187370] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-plv8> server # [ 19.252389] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1127]: DO vm-test-run-plv8> server # [ 19.257702] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-plv8> server # [ 19.293717] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1129]: ALTER ROLE vm-test-run-plv8> server # [ 19.297773] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-plv8> server # [ 19.327361] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1135]: DROP EXTENSION vm-test-run-plv8> server # [ 19.336609] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-plv8> server # [ 19.374707] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1137]: CREATE FUNCTION vm-test-run-plv8> server # [ 19.376515] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1137]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 19.378173] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1137]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 19.383904] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-plv8> server # [ 19.417948] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1139]: DO vm-test-run-plv8> server # [ 19.424055] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1139]: CREATE FUNCTION vm-test-run-plv8> server # [ 19.430708] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-plv8> server # [ 19.467498] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1141]: CREATE FUNCTION vm-test-run-plv8> server # [ 19.468830] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1141]: CREATE FUNCTION vm-test-run-plv8> server # [ 19.474423] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql vm-test-run-plv8> server # [ 19.515410] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1143]: CREATE FUNCTION vm-test-run-plv8> server # [ 19.517527] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1143]: CREATE FUNCTION vm-test-run-plv8> server # [ 19.520486] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1143]: CREATE FUNCTION vm-test-run-plv8> server # [ 19.522869] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1143]: CREATE FUNCTION vm-test-run-plv8> server # [ 19.526346] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1143]: CREATE FUNCTION vm-test-run-plv8> server # [ 19.528101] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1143]: CREATE FUNCTION vm-test-run-plv8> server # [ 19.537351] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Running postgresql schema... vm-test-run-plv8> server # [ 19.565726] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER DATABASE vm-test-run-plv8> server # [ 19.566843] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER DATABASE vm-test-run-plv8> server # [ 19.572689] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER ROLE vm-test-run-plv8> server # [ 19.579125] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER ROLE vm-test-run-plv8> server # [ 19.583586] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER ROLE vm-test-run-plv8> server # [ 19.589728] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER ROLE vm-test-run-plv8> server # [ 19.594476] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER ROLE vm-test-run-plv8> server # [ 19.600062] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER ROLE vm-test-run-plv8> server # [ 19.604652] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER ROLE vm-test-run-plv8> server # [ 19.609820] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER ROLE vm-test-run-plv8> server # [ 19.615159] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER ROLE vm-test-run-plv8> server # [ 19.616283] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[1145]: ALTER ROLE vm-test-run-plv8> server # [ 19.623547] yjd9ijjd04dw8z9g1nihhr40in75lf35-supabase-db-init[941]: Database initialization complete vm-test-run-plv8> server # [ 19.627502] systemd[1]: Finished Supabase Database Initialization. vm-test-run-plv8> server # [ 19.629648] systemd[1]: Reached target Multi-User System. vm-test-run-plv8> server # [ 19.630888] systemd[1]: Startup finished in 3.054s (kernel) + 16.574s (userspace) = 19.628s. vm-test-run-plv8> server: (finished: waiting for unit supabase-db-init.service, in 20.97 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.06 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 0.96 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.06 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.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.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 0.92 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> 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.06 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.91 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.05 seconds) vm-test-run-plv8> (finished: subtest: Check upgrade path with postgresql 15, in 3.14 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.05 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.33 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.06 seconds) vm-test-run-plv8> (finished: subtest: Check the install of the last version of the extension, in 0.43 seconds) vm-test-run-plv8> (finished: run the VM test script, in 24.65 seconds) vm-test-run-plv8> test script finished in 24.71s 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.02 seconds) vm-test-run-plv8> vde_switch: Caught signal 15, cleaning up and exiting