these 23 derivations will be built: /nix/store/v667yq5f94a1mwl6p3ms55fa0mav0h58-postgresql-and-plugins-15.19.drv /nix/store/14kwzlm2vyd1z3cm13q7y9mjcyc8abv0-postgresql-and-plugins-15.19.drv /nix/store/91155k491hihvh4lg6fcryffxdr8wl93-system-path.drv /nix/store/l15nnx8x8zsyvfgz5yq3dz0i4wpxar3z-dbus-1.drv /nix/store/zw52j8iklp55vb02lwpf0djkds1s6liz-X-Restart-Triggers-dbus-broker.drv /nix/store/sl36nclsyra65fxqibdbwpl6wv8ki7vg-unit-dbus-broker.service.drv /nix/store/km9rcdi60bjwy9l5jxhwrz29z2hljm2g-user-units.drv /nix/store/k39bsnbbxi7pyh9wkfkznszq86d37asn-postgresql-init.drv /nix/store/9q6zzmvyr00zyv92zzkwbrg5q2gip547-unit-postgresql.service.drv /nix/store/pqnbmz4kd51y11ybrnma4h8rhp6ydik3-supabase-db-init.drv /nix/store/f1a9pk9a57l6izy48q7wimrddm03nbss-unit-supabase-db-init.service.drv /nix/store/l7pmrbr9dn7fjii57npmp4xcckd1lb8c-unit-dbus-broker.service.drv /nix/store/mm1r3rhdg7w5yi58j0w0mrldg3cik2sq-system-units.drv /nix/store/a1cb2snacj3w0d7y1gcgy1gf25mmxx8m-etc.drv /nix/store/rmkckwihjbg16m09lli8rff29j3michm-activate.drv /nix/store/jmq4jzps556ngb6854s18aacfrkdry9b-nixos-system-server-test.drv /nix/store/qwd161y9052zi5s3mrh9az9mm428dnj8-closure-info.drv /nix/store/46gmrgwc7qd5z9jbjffwpdfkm0533gcn-run-nixos-vm.drv /nix/store/4xnd8zxacjzi5wixng8fdsp3imxsaqxw-test-script.drv /nix/store/682c1nyvb6410h40859ab22pqnf7ij2h-nixos-vm.drv /nix/store/ikgxksawb725lp0czsdnwig9pqv9a7gr-driverConfiguration.json.drv /nix/store/ik3jciaphvl5g6yvjbz1dfblx7hmzk1p-nixos-test-driver-plv8.drv /nix/store/y1gmmrkd874w1bfjwww3090s55fahxbg-vm-test-run-plv8.drv building '/nix/store/4xnd8zxacjzi5wixng8fdsp3imxsaqxw-test-script.drv' building '/nix/store/ikgxksawb725lp0czsdnwig9pqv9a7gr-driverConfiguration.json.drv' driverConfiguration.json> structuredAttrs is enabled building '/nix/store/ik3jciaphvl5g6yvjbz1dfblx7hmzk1p-nixos-test-driver-plv8.drv' nixos-test-driver-plv8> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-plv8> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-plv8> All checks passed! nixos-test-driver-plv8> Linting test script (enable/disable: config.skipLint) nixos-test-driver-plv8> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-plv8> All checks passed! building '/nix/store/y1gmmrkd874w1bfjwww3090s55fahxbg-vm-test-run-plv8.drv' vm-test-run-plv8> Machine state will be reset. To keep it, pass --keep-machine-state vm-test-run-plv8> start all VLans 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, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh vm-test-run-plv8> start all VMs vm-test-run-plv8> server: starting vm vm-test-run-plv8> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-plv8> server: QEMU running (pid 13) vm-test-run-plv8> server # Formatting '/build/vm-state-server/tmp.aKE1riyTW6', fmt=raw size=1073741824 vm-test-run-plv8> server # mke2fs 1.47.4 (6-Mar-2025) 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: 67970647-4ebe-4900-bd5e-b5c19d5f9b64 vm-test-run-plv8> server # Superblock backups stored on blocks: vm-test-run-plv8> server # 32768, 98304, 163840, 229376 vm-test-run-plv8> server # vm-test-run-plv8> server # Allocating group tables: 0/8 done vm-test-run-plv8> server # Writing inode tables: 0/8 done vm-test-run-plv8> server # Creating journal (8192 blocks): done vm-test-run-plv8> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-plv8> server # vm-test-run-plv8> server # Virtualisation disk image created. vm-test-run-plv8> (finished: start all VMs, in 0.12 seconds) vm-test-run-plv8> server: waiting for unit supabase-db-init.service vm-test-run-plv8> server: waiting for the VM to finish booting vm-test-run-plv8> server # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) vm-test-run-plv8> server # vm-test-run-plv8> server # vm-test-run-plv8> server # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+BEFD1920+BEF31920 CA00 vm-test-run-plv8> server # Press Ctrl-B to configure iPXE (PCI 00:03.0)... vm-test-run-plv8> server # vm-test-run-plv8> server # vm-test-run-plv8> server # vm-test-run-plv8> server # vm-test-run-plv8> server # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM BEFD1920 BEF31920 CB00 vm-test-run-plv8> server # Press Ctrl-B to configure iPXE (PCI 00:09.0)... vm-test-run-plv8> server # vm-test-run-plv8> server # vm-test-run-plv8> server # Booting from ROM... vm-test-run-plv8> server # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Sep 25 14:35:54 UTC 2026 vm-test-run-plv8> server # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/hgmw5v86rlv8k2hhkynd4mn6gm5w84ja-nixos-system-server-test/init regInfo=/nix/store/bmdnrqvpf3rjxp2k9skjx0bsiy1iz50v-closure-info/registration console=ttyS0,115200n8 console=tty0 vm-test-run-plv8> server # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees. 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 429044506 cycles vm-test-run-plv8> server # [ 0.000002] 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.000803] last_pfn = 0x140000 max_arch_pfn = 0x400000000 vm-test-run-plv8> server # [ 0.000839] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs vm-test-run-plv8> server # [ 0.000841] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT vm-test-run-plv8> server # [ 0.000881] last_pfn = 0xbffdb max_arch_pfn = 0x400000000 vm-test-run-plv8> server # [ 0.002718] found SMP MP-table at [mem 0x000f5470-0x000f547f] vm-test-run-plv8> server # [ 0.002732] Using GB pages for direct mapping vm-test-run-plv8> server # [ 0.002905] RAMDISK: [mem 0xbe514000-0xbffcffff] vm-test-run-plv8> server # [ 0.002911] ACPI: Early table checksum verification disabled vm-test-run-plv8> server # [ 0.002914] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) vm-test-run-plv8> server # [ 0.002917] ACPI: RSDT 0x00000000BFFE2434 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.002922] ACPI: FACP 0x00000000BFFE22E0 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.002928] ACPI: DSDT 0x00000000BFFE0040 0022A0 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.002930] ACPI: FACS 0x00000000BFFE0000 000040 vm-test-run-plv8> server # [ 0.002931] ACPI: APIC 0x00000000BFFE2354 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.002933] ACPI: HPET 0x00000000BFFE23D4 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.002935] ACPI: WAET 0x00000000BFFE240C 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) vm-test-run-plv8> server # [ 0.002936] ACPI: Reserving FACP table memory at [mem 0xbffe22e0-0xbffe2353] vm-test-run-plv8> server # [ 0.002937] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe22df] vm-test-run-plv8> server # [ 0.002938] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f] vm-test-run-plv8> server # [ 0.002938] ACPI: Reserving APIC table memory at [mem 0xbffe2354-0xbffe23d3] vm-test-run-plv8> server # [ 0.002939] ACPI: Reserving HPET table memory at [mem 0xbffe23d4-0xbffe240b] vm-test-run-plv8> server # [ 0.002939] ACPI: Reserving WAET table memory at [mem 0xbffe240c-0xbffe2433] vm-test-run-plv8> server # [ 0.003177] No NUMA configuration found vm-test-run-plv8> server # [ 0.003178] Faking a node at [mem 0x0000000000000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.003180] NODE_DATA(0) allocated [mem 0x13fff8780-0x13fffdcff] vm-test-run-plv8> server # [ 0.003271] Zone ranges: vm-test-run-plv8> server # [ 0.003272] DMA [mem 0x0000000000001000-0x0000000000ffffff] vm-test-run-plv8> server # [ 0.003273] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] vm-test-run-plv8> server # [ 0.003274] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.003275] Device empty vm-test-run-plv8> server # [ 0.003276] Movable zone start for each node vm-test-run-plv8> server # [ 0.003277] Early memory node ranges vm-test-run-plv8> server # [ 0.003277] node 0: [mem 0x0000000000001000-0x000000000009efff] vm-test-run-plv8> server # [ 0.003278] node 0: [mem 0x0000000000100000-0x00000000bffdafff] vm-test-run-plv8> server # [ 0.003279] node 0: [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.003280] Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.003299] On node 0, zone DMA: 1 pages in unavailable ranges vm-test-run-plv8> server # [ 0.003546] On node 0, zone DMA: 97 pages in unavailable ranges vm-test-run-plv8> server # [ 0.070013] On node 0, zone Normal: 37 pages in unavailable ranges vm-test-run-plv8> server # [ 0.070466] ACPI: PM-Timer IO Port: 0x608 vm-test-run-plv8> server # [ 0.070481] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) vm-test-run-plv8> server # [ 0.070506] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 vm-test-run-plv8> server # [ 0.070509] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) vm-test-run-plv8> server # [ 0.070511] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) vm-test-run-plv8> server # [ 0.070512] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) vm-test-run-plv8> server # [ 0.070513] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) vm-test-run-plv8> server # [ 0.070514] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) vm-test-run-plv8> server # [ 0.070516] ACPI: Using ACPI (MADT) for SMP configuration information vm-test-run-plv8> server # [ 0.070517] ACPI: HPET id: 0x8086a201 base: 0xfed00000 vm-test-run-plv8> server # [ 0.070523] TSC deadline timer available vm-test-run-plv8> server # [ 0.070527] CPU topo: Max. logical packages: 1 vm-test-run-plv8> server # [ 0.070528] CPU topo: Max. logical dies: 1 vm-test-run-plv8> server # [ 0.070528] CPU topo: Max. dies per package: 1 vm-test-run-plv8> server # [ 0.070532] CPU topo: Max. threads per core: 1 vm-test-run-plv8> server # [ 0.070533] CPU topo: Num. cores per package: 2 vm-test-run-plv8> server # [ 0.070533] CPU topo: Num. threads per package: 2 vm-test-run-plv8> server # [ 0.070534] CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs vm-test-run-plv8> server # [ 0.070555] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() vm-test-run-plv8> server # [ 0.070569] kvm-guest: KVM setup pv remote TLB flush vm-test-run-plv8> server # [ 0.070572] kvm-guest: setup PV sched yield vm-test-run-plv8> server # [ 0.070582] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.070583] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] vm-test-run-plv8> server # [ 0.070584] PM: hibernation: Registered nosave memory: [mem 0xbffdb000-0xffffffff] vm-test-run-plv8> server # [ 0.070586] [mem 0xc0000000-0xfeffbfff] available for PCI devices vm-test-run-plv8> server # [ 0.070587] Booting paravirtualized kernel on KVM vm-test-run-plv8> server # [ 0.070591] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns vm-test-run-plv8> server # [ 0.075098] setup_percpu: NR_CPUS:384 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 vm-test-run-plv8> server # [ 0.077265] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u1048576 vm-test-run-plv8> server # [ 0.077311] kvm-guest: PV spinlocks enabled vm-test-run-plv8> server # [ 0.077313] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) vm-test-run-plv8> server # [ 0.077316] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/hgmw5v86rlv8k2hhkynd4mn6gm5w84ja-nixos-system-server-test/init regInfo=/nix/store/bmdnrqvpf3rjxp2k9skjx0bsiy1iz50v-closure-info/registration console=ttyS0,115200n8 console=tty0 vm-test-run-plv8> server # [ 0.077408] Unknown kernel command line parameters "regInfo=/nix/store/bmdnrqvpf3rjxp2k9skjx0bsiy1iz50v-closure-info/registration", will be passed to user space. vm-test-run-plv8> server # [ 0.077425] random: crng init done vm-test-run-plv8> server # [ 0.077426] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes vm-test-run-plv8> server # [ 0.081380] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-plv8> server # [ 0.083373] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-plv8> server # [ 0.083424] software IO TLB: area num 2. vm-test-run-plv8> server # [ 0.153085] Fallback order for Node 0: 0 vm-test-run-plv8> server # [ 0.153091] Built 1 zonelists, mobility grouping on. Total pages: 1048441 vm-test-run-plv8> server # [ 0.153093] Policy zone: Normal vm-test-run-plv8> server # [ 0.155367] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-plv8> server # [ 0.162785] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm-test-run-plv8> server # [ 0.171099] allocated 8388608 bytes of page_ext vm-test-run-plv8> server # [ 0.181026] ftrace: allocating 48712 entries in 192 pages vm-test-run-plv8> server # [ 0.181029] ftrace: allocated 192 pages with 2 groups vm-test-run-plv8> server # [ 0.181878] Dynamic Preempt: lazy vm-test-run-plv8> server # [ 0.182015] rcu: Preemptible hierarchical RCU implementation. vm-test-run-plv8> server # [ 0.182016] rcu: RCU event tracing is enabled. vm-test-run-plv8> server # [ 0.182017] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. vm-test-run-plv8> server # [ 0.182018] Trampoline variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.182019] Rude variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.182019] Tracing variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.182020] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. vm-test-run-plv8> server # [ 0.182020] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm-test-run-plv8> server # [ 0.182037] 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.182038] 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.182039] 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.186673] NR_IRQS: 24832, nr_irqs: 440, preallocated irqs: 16 vm-test-run-plv8> server # [ 0.186982] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-plv8> server # [ 0.186988] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns vm-test-run-plv8> server # [ 0.187094] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-plv8> server # [ 0.190845] Console: colour VGA+ 80x25 vm-test-run-plv8> server # [ 0.190848] printk: legacy console [tty0] enabled vm-test-run-plv8> server # [ 0.222386] printk: legacy console [ttyS0] enabled vm-test-run-plv8> server # [ 0.312399] ACPI: Core revision 20250807 vm-test-run-plv8> server # [ 0.313252] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns vm-test-run-plv8> server # [ 0.315031] APIC: Switch to symmetric I/O mode setup vm-test-run-plv8> server # [ 0.316138] x2apic enabled vm-test-run-plv8> server # [ 0.317031] APIC: Switched APIC routing to: physical x2apic vm-test-run-plv8> server # [ 0.317891] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() vm-test-run-plv8> server # [ 0.319070] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() vm-test-run-plv8> server # [ 0.320393] kvm-guest: setup PV IPIs vm-test-run-plv8> server # [ 0.321946] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 vm-test-run-plv8> server # [ 0.322869] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2b29812ce43, max_idle_ns: 440795323173 ns vm-test-run-plv8> server # [ 0.324386] Calibrating delay loop (skipped) preset value.. 5988.74 BogoMIPS (lpj=2994372) vm-test-run-plv8> server # [ 0.326471] x86/cpu: User Mode Instruction Prevention (UMIP) activated vm-test-run-plv8> server # [ 0.327508] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 vm-test-run-plv8> server # [ 0.328385] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 vm-test-run-plv8> server # [ 0.329388] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto vm-test-run-plv8> server # [ 0.330385] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl vm-test-run-plv8> server # [ 0.332384] Speculative Return Stack Overflow: IBPB-extending microcode not applied! vm-test-run-plv8> server # [ 0.333384] 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.333386] Spectre V2 : Mitigation: Retpolines vm-test-run-plv8> server # [ 0.335385] Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode vm-test-run-plv8> server # [ 0.336384] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization vm-test-run-plv8> server # [ 0.337382] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT vm-test-run-plv8> server # [ 0.338384] Spectre V2 : Enabling Restricted Speculation for firmware calls vm-test-run-plv8> server # [ 0.339386] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier vm-test-run-plv8> server # [ 0.340385] active return thunk: srso_alias_return_thunk vm-test-run-plv8> server # [ 0.341931] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' vm-test-run-plv8> server # [ 0.342385] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' vm-test-run-plv8> server # [ 0.344045] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' vm-test-run-plv8> server # [ 0.345048] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' vm-test-run-plv8> server # [ 0.346203] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 vm-test-run-plv8> server # [ 0.347024] x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8 vm-test-run-plv8> server # [ 0.348028] x86/fpu: Enabled xstate features 0x207, context size is 840 bytes, using 'compacted' format. vm-test-run-plv8> server # [ 0.376210] Freeing SMP alternatives memory: 44K vm-test-run-plv8> server # [ 0.376874] pid_max: default: 32768 minimum: 301 vm-test-run-plv8> server # [ 0.377452] LSM: initializing lsm=capability,landlock,yama,bpf,ima vm-test-run-plv8> server # [ 0.378499] landlock: Up and running. vm-test-run-plv8> server # [ 0.379385] Yama: becoming mindful. vm-test-run-plv8> server # [ 0.380166] LSM support for eBPF active vm-test-run-plv8> server # [ 0.380922] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.381468] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.384434] smpboot: CPU0: AMD EPYC 7313P 16-Core Processor (family: 0x19, model: 0x1, stepping: 0x1) vm-test-run-plv8> server # [ 0.386012] Performance Events: Fam17h+ core perfctr, AMD PMU driver. vm-test-run-plv8> server # [ 0.386394] ... version: 0 vm-test-run-plv8> server # [ 0.387057] ... bit width: 48 vm-test-run-plv8> server # [ 0.387387] ... generic counters: 6 vm-test-run-plv8> server # [ 0.388097] ... generic bitmap: 000000000000003f vm-test-run-plv8> server # [ 0.388386] ... fixed-purpose counters: 0 vm-test-run-plv8> server # [ 0.389035] ... fixed-purpose bitmap: 0000000000000000 vm-test-run-plv8> server # [ 0.389385] ... value mask: 0000ffffffffffff vm-test-run-plv8> server # [ 0.390256] ... max period: 00007fffffffffff vm-test-run-plv8> server # [ 0.391061] ... global_ctrl mask: 000000000000003f vm-test-run-plv8> server # [ 0.391505] signal: max sigframe size: 3376 vm-test-run-plv8> server # [ 0.392310] rcu: Hierarchical SRCU implementation. vm-test-run-plv8> server # [ 0.392892] rcu: Max phase no-delay instances is 400. vm-test-run-plv8> server # [ 0.393557] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-plv8> server # [ 0.398777] smp: Bringing up secondary CPUs ... vm-test-run-plv8> server # [ 0.399726] smpboot: x86: Booting SMP configuration: vm-test-run-plv8> server # [ 0.400390] .... node #0, CPUs: #1 vm-test-run-plv8> server # [ 0.400497] smp: Brought up 1 node, 2 CPUs vm-test-run-plv8> server # [ 0.402056] smpboot: Total of 2 processors activated (11977.48 BogoMIPS) vm-test-run-plv8> server # [ 0.402711] Memory: 3962780K/4193764K available (17158K kernel code, 2723K rwdata, 13604K rodata, 3648K init, 2988K bss, 216364K reserved, 0K cma-reserved) vm-test-run-plv8> server # [ 0.403856] devtmpfs: initialized vm-test-run-plv8> server # [ 0.404631] x86/mm: Memory block size: 128MB vm-test-run-plv8> server # [ 0.406647] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) vm-test-run-plv8> server # [ 0.407431] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). vm-test-run-plv8> server # [ 0.408468] pinctrl core: initialized pinctrl subsystem vm-test-run-plv8> server # [ 0.409519] PM: RTC time: 00:02:57, date: 2026-10-07 vm-test-run-plv8> server # [ 0.413106] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-plv8> server # [ 0.414165] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-plv8> server # [ 0.415226] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-plv8> server # [ 0.416848] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-plv8> server # [ 0.417398] audit: initializing netlink subsys (disabled) vm-test-run-plv8> server # [ 0.418304] audit: type=2000 audit(1791331377.879:1): state=initialized audit_enabled=0 res=1 vm-test-run-plv8> server # [ 0.418736] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-plv8> server # [ 0.419387] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-plv8> server # [ 0.420282] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-plv8> server # [ 0.421029] thermal_sys: Registered thermal governor 'user_space' vm-test-run-plv8> server # [ 0.421385] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-plv8> server # [ 0.422311] cpuidle: using governor menu vm-test-run-plv8> server # [ 0.423853] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 vm-test-run-plv8> server # [ 0.424602] PCI: Using configuration type 1 for base access vm-test-run-plv8> server # [ 0.425386] PCI: Using configuration type 1 for extended access vm-test-run-plv8> server # [ 0.426464] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. vm-test-run-plv8> server # [ 0.436400] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.439386] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-plv8> server # [ 0.440386] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.443385] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-plv8> server # [ 0.448078] ACPI: Added _OSI(Module Device) vm-test-run-plv8> server # [ 0.448387] ACPI: Added _OSI(Processor Device) vm-test-run-plv8> server # [ 0.449160] ACPI: Added _OSI(Processor Aggregator Device) vm-test-run-plv8> server # [ 0.452463] ACPI: 1 ACPI AML tables successfully acquired and loaded vm-test-run-plv8> server # [ 0.456744] ACPI: Interpreter enabled vm-test-run-plv8> server # [ 0.457414] ACPI: PM: (supports S0 S3 S4 S5) vm-test-run-plv8> server # [ 0.458136] ACPI: Using IOAPIC for interrupt routing vm-test-run-plv8> server # [ 0.459403] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug vm-test-run-plv8> server # [ 0.460385] PCI: Using E820 reservations for host bridge windows vm-test-run-plv8> server # [ 0.461474] ACPI: Enabled 2 GPEs in block 00 to 0F vm-test-run-plv8> server # [ 0.467186] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) vm-test-run-plv8> server # [ 0.468113] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] vm-test-run-plv8> server # [ 0.469772] acpiphp: Slot [3] registered vm-test-run-plv8> server # [ 0.470423] acpiphp: Slot [4] registered vm-test-run-plv8> server # [ 0.471098] acpiphp: Slot [5] registered vm-test-run-plv8> server # [ 0.472427] acpiphp: Slot [6] registered vm-test-run-plv8> server # [ 0.473126] acpiphp: Slot [7] registered vm-test-run-plv8> server # [ 0.473411] acpiphp: Slot [8] registered vm-test-run-plv8> server # [ 0.474097] acpiphp: Slot [9] registered vm-test-run-plv8> server # [ 0.474416] acpiphp: Slot [10] registered vm-test-run-plv8> server # [ 0.475097] acpiphp: Slot [11] registered vm-test-run-plv8> server # [ 0.475416] acpiphp: Slot [12] registered vm-test-run-plv8> server # [ 0.476095] acpiphp: Slot [13] registered vm-test-run-plv8> server # [ 0.476419] acpiphp: Slot [14] registered vm-test-run-plv8> server # [ 0.477153] acpiphp: Slot [15] registered vm-test-run-plv8> server # [ 0.477413] acpiphp: Slot [16] registered vm-test-run-plv8> server # [ 0.478129] acpiphp: Slot [17] registered vm-test-run-plv8> server # [ 0.479417] acpiphp: Slot [18] registered vm-test-run-plv8> server # [ 0.480110] acpiphp: Slot [19] registered vm-test-run-plv8> server # [ 0.480413] acpiphp: Slot [20] registered vm-test-run-plv8> server # [ 0.481158] acpiphp: Slot [21] registered vm-test-run-plv8> server # [ 0.481945] acpiphp: Slot [22] registered vm-test-run-plv8> server # [ 0.482421] acpiphp: Slot [23] registered vm-test-run-plv8> server # [ 0.483133] acpiphp: Slot [24] registered vm-test-run-plv8> server # [ 0.484424] acpiphp: Slot [25] registered vm-test-run-plv8> server # [ 0.485461] acpiphp: Slot [26] registered vm-test-run-plv8> server # [ 0.486291] acpiphp: Slot [27] registered vm-test-run-plv8> server # [ 0.486929] acpiphp: Slot [28] registered vm-test-run-plv8> server # [ 0.487420] acpiphp: Slot [29] registered vm-test-run-plv8> server # [ 0.488296] acpiphp: Slot [30] registered vm-test-run-plv8> server # [ 0.489042] acpiphp: Slot [31] registered vm-test-run-plv8> server # [ 0.490438] PCI host bridge to bus 0000:00 vm-test-run-plv8> server # [ 0.491258] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] vm-test-run-plv8> server # [ 0.492158] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] vm-test-run-plv8> server # [ 0.493200] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] vm-test-run-plv8> server # [ 0.494209] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] vm-test-run-plv8> server # [ 0.495171] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe007fffffff window] vm-test-run-plv8> server # [ 0.497249] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-plv8> server # [ 0.498257] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.499944] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint vm-test-run-plv8> server # [ 0.501977] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint vm-test-run-plv8> server # [ 0.504420] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] vm-test-run-plv8> server # [ 0.505305] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk vm-test-run-plv8> server # [ 0.506371] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk vm-test-run-plv8> server # [ 0.508187] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk vm-test-run-plv8> server # [ 0.509324] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk vm-test-run-plv8> server # [ 0.510589] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint vm-test-run-plv8> server # [ 0.513419] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] vm-test-run-plv8> server # [ 0.515794] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.517775] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI vm-test-run-plv8> server # [ 0.519401] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB vm-test-run-plv8> server # [ 0.520637] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.527454] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] vm-test-run-plv8> server # [ 0.528401] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] vm-test-run-plv8> server # [ 0.529420] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] vm-test-run-plv8> server # [ 0.530625] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] vm-test-run-plv8> server # [ 0.532201] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.536407] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] vm-test-run-plv8> server # [ 0.539977] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] vm-test-run-plv8> server # [ 0.541422] pci 0000:00:03.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref] vm-test-run-plv8> server # [ 0.542394] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] vm-test-run-plv8> server # [ 0.545102] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.549405] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] vm-test-run-plv8> server # [ 0.550254] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] vm-test-run-plv8> server # [ 0.551092] pci 0000:00:04.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref] vm-test-run-plv8> server # [ 0.553701] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.557461] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] vm-test-run-plv8> server # [ 0.559395] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] vm-test-run-plv8> server # [ 0.560373] pci 0000:00:05.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref] vm-test-run-plv8> server # [ 0.562627] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.565344] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] vm-test-run-plv8> server # [ 0.565965] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] vm-test-run-plv8> server # [ 0.567413] pci 0000:00:06.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref] vm-test-run-plv8> server # [ 0.570314] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.574396] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] vm-test-run-plv8> server # [ 0.575398] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] vm-test-run-plv8> server # [ 0.576420] pci 0000:00:07.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref] vm-test-run-plv8> server # [ 0.579125] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.582407] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] vm-test-run-plv8> server # [ 0.583230] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] vm-test-run-plv8> server # [ 0.584084] pci 0000:00:08.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref] vm-test-run-plv8> server # [ 0.586883] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.590421] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] vm-test-run-plv8> server # [ 0.591277] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] vm-test-run-plv8> server # [ 0.592209] pci 0000:00:09.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref] vm-test-run-plv8> server # [ 0.593398] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] vm-test-run-plv8> server # [ 0.595703] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.598404] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] vm-test-run-plv8> server # [ 0.599410] pci 0000:00:0a.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref] vm-test-run-plv8> server # [ 0.602398] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.605398] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] vm-test-run-plv8> server # [ 0.606226] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] vm-test-run-plv8> server # [ 0.607081] pci 0000:00:0b.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref] vm-test-run-plv8> server # [ 0.609812] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.612414] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] vm-test-run-plv8> server # [ 0.613319] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] vm-test-run-plv8> server # [ 0.614292] pci 0000:00:0c.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref] vm-test-run-plv8> server # [ 0.620064] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 vm-test-run-plv8> server # [ 0.621529] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 vm-test-run-plv8> server # [ 0.622544] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 vm-test-run-plv8> server # [ 0.623549] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 vm-test-run-plv8> server # [ 0.624482] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 vm-test-run-plv8> server # [ 0.626700] iommu: Default domain type: Translated vm-test-run-plv8> server # [ 0.627390] iommu: DMA domain TLB invalidation policy: lazy mode vm-test-run-plv8> server # [ 0.628615] ACPI: bus type USB registered vm-test-run-plv8> server # [ 0.629341] usbcore: registered new interface driver usbfs vm-test-run-plv8> server # [ 0.630099] usbcore: registered new interface driver hub vm-test-run-plv8> server # [ 0.630399] usbcore: registered new device driver usb vm-test-run-plv8> server # [ 0.632849] NetLabel: Initializing vm-test-run-plv8> server # [ 0.633387] NetLabel: domain hash size = 128 vm-test-run-plv8> server # [ 0.634233] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO vm-test-run-plv8> server # [ 0.635141] NetLabel: unlabeled traffic allowed by default vm-test-run-plv8> server # [ 0.636166] PCI: Using ACPI for IRQ routing vm-test-run-plv8> server # [ 0.637576] pci 0000:00:02.0: vgaarb: setting as boot VGA device vm-test-run-plv8> server # [ 0.638382] pci 0000:00:02.0: vgaarb: bridge control possible vm-test-run-plv8> server # [ 0.638382] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none vm-test-run-plv8> server # [ 0.640393] vgaarb: loaded vm-test-run-plv8> server # [ 0.641166] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 vm-test-run-plv8> server # [ 0.641913] hpet0: 3 comparators, 64-bit 100.000000 MHz counter vm-test-run-plv8> server # [ 0.646496] clocksource: Switched to clocksource kvm-clock vm-test-run-plv8> server # [ 0.648167] VFS: Disk quotas dquot_6.6.0 vm-test-run-plv8> server # [ 0.648923] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-plv8> server # [ 0.650451] pnp: PnP ACPI init vm-test-run-plv8> server # [ 0.651577] pnp: PnP ACPI: found 5 devices vm-test-run-plv8> server # [ 0.660464] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns vm-test-run-plv8> server # [ 0.661873] clocksource: Switched to clocksource acpi_pm vm-test-run-plv8> server # [ 0.662845] NET: Registered PF_INET protocol family vm-test-run-plv8> server # [ 0.664332] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-plv8> server # [ 0.684254] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.686088] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.687696] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.689344] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-plv8> server # [ 0.690880] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-plv8> server # [ 0.692267] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-plv8> server # [ 0.693630] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) vm-test-run-plv8> server # [ 0.694876] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) vm-test-run-plv8> server # [ 0.696123] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-plv8> server # [ 0.697045] NET: Registered PF_XDP protocol family vm-test-run-plv8> server # [ 0.697913] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] vm-test-run-plv8> server # [ 0.698872] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] vm-test-run-plv8> server # [ 0.699873] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] vm-test-run-plv8> server # [ 0.700964] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] vm-test-run-plv8> server # [ 0.702015] pci_bus 0000:00: resource 8 [mem 0xe0000000000-0xe007fffffff window] vm-test-run-plv8> server # [ 0.703361] pci 0000:00:01.0: PIIX3: Enabling Passive Release vm-test-run-plv8> server # [ 0.704300] pci 0000:00:00.0: Limiting direct PCI/PCI transfers vm-test-run-plv8> server # [ 0.706930] ACPI: \_SB_.LNKD: Enabled at IRQ 11 vm-test-run-plv8> server # [ 0.709566] PCI: CLS 0 bytes, default 64 vm-test-run-plv8> server # [ 0.710284] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) vm-test-run-plv8> server # [ 0.710479] Trying to unpack rootfs image as initramfs... vm-test-run-plv8> server # [ 0.710565] software IO TLB: mapped [mem 0x00000000ba514000-0x00000000be514000] (64MB) vm-test-run-plv8> server # [ 0.713785] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2b29812ce43, max_idle_ns: 440795323173 ns vm-test-run-plv8> server # [ 0.741266] Initialise system trusted keyrings vm-test-run-plv8> server # [ 0.743500] workingset: timestamp_bits=40 max_order=20 bucket_order=0 vm-test-run-plv8> server # [ 0.756590] Key type asymmetric registered vm-test-run-plv8> server # [ 0.757272] Asymmetric key parser 'x509' registered vm-test-run-plv8> server # [ 0.758061] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) vm-test-run-plv8> server # [ 0.759383] io scheduler mq-deadline registered vm-test-run-plv8> server # [ 0.760108] io scheduler kyber registered vm-test-run-plv8> server # [ 0.764891] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-plv8> server # [ 0.766558] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A vm-test-run-plv8> server # [ 0.769341] Linux agpgart interface v0.103 vm-test-run-plv8> server # [ 0.770287] ACPI: bus type drm_connector registered vm-test-run-plv8> server # [ 0.772936] usbcore: registered new interface driver usbserial_generic vm-test-run-plv8> server # [ 0.774266] usbserial: USB Serial support registered for generic vm-test-run-plv8> server # [ 0.775567] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled vm-test-run-plv8> server # [ 0.777295] drop_monitor: Initializing network drop monitor service vm-test-run-plv8> server # [ 0.778818] NET: Registered PF_INET6 protocol family vm-test-run-plv8> server # [ 0.780928] Segment Routing with IPv6 vm-test-run-plv8> server # [ 0.781793] In-situ OAM (IOAM) with IPv6 vm-test-run-plv8> server # [ 0.784818] IPI shorthand broadcast: enabled vm-test-run-plv8> server # [ 0.790909] sched_clock: Marking stable (661022899, 129394597)->(814102606, -23685110) vm-test-run-plv8> server # [ 0.792947] registered taskstats version 1 vm-test-run-plv8> server # [ 0.794322] Loading compiled-in X.509 certificates vm-test-run-plv8> server # [ 0.807903] Demotion targets for Node 0: null vm-test-run-plv8> server # [ 0.809037] Key type .fscrypt registered vm-test-run-plv8> server # [ 0.809965] Key type fscrypt-provisioning registered vm-test-run-plv8> server # [ 0.811241] ima: No TPM chip found, activating TPM-bypass! vm-test-run-plv8> server # [ 0.812441] ima: Allocated hash algorithm: sha1 vm-test-run-plv8> server # [ 0.813471] ima: No architecture policies found vm-test-run-plv8> server # [ 0.814459] PM: Magic number: 14:507:0 vm-test-run-plv8> server # [ 0.815109] PM: hash matches drivers/base/power/main.c:724 vm-test-run-plv8> server # [ 0.816996] RAS: Correctable Errors collector initialized. vm-test-run-plv8> server # [ 0.822006] clk: Disabling unused clocks vm-test-run-plv8> server # [ 0.822681] PM: genpd: Disabling unused power domains vm-test-run-plv8> server # [ 0.960090] Freeing initrd memory: 27376K vm-test-run-plv8> server # [ 0.964100] Freeing unused decrypted memory: 2028K vm-test-run-plv8> server # [ 0.966831] Freeing unused kernel image (initmem) memory: 3648K vm-test-run-plv8> server # [ 0.967838] Write protecting the kernel read-only data: 32768k vm-test-run-plv8> server # [ 0.969841] Freeing unused kernel image (text/rodata gap) memory: 1272K vm-test-run-plv8> server # [ 0.971318] Freeing unused kernel image (rodata/data gap) memory: 732K vm-test-run-plv8> server # [ 1.021220] x86/mm: Checked W+X mappings: passed, no W+X pages found. vm-test-run-plv8> server # [ 1.022268] Run /init as init process vm-test-run-plv8> server # [ 1.035929] systemd[1]: Inserted module 'autofs4' vm-test-run-plv8> server # [ 1.056810] fuse: init (API version 7.45) vm-test-run-plv8> server # [ 1.064696] ACPI: \_SB_.LNKC: Enabled at IRQ 10 vm-test-run-plv8> server # [ 1.071686] ACPI: \_SB_.LNKA: Enabled at IRQ 10 vm-test-run-plv8> server # [ 1.075282] ACPI: \_SB_.LNKB: Enabled at IRQ 11 vm-test-run-plv8> server # [ 1.103930] systemd[1]: Successfully made /usr/ read-only. vm-test-run-plv8> server # [ 1.440282] systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) vm-test-run-plv8> server # [ 1.449985] systemd[1]: Detected virtualization kvm. vm-test-run-plv8> server # [ 1.451025] systemd[1]: Detected architecture x86-64. vm-test-run-plv8> server # [ 1.451938] systemd[1]: Running in initrd. vm-test-run-plv8> server # [ 1.453079] systemd[1]: Initializing machine ID from random generator. vm-test-run-plv8> server # [ 1.454211] systemd[1]: Hostname set to . vm-test-run-plv8> server # [ 1.504887] systemd[1]: Queued start job for default target Initrd Default Target. vm-test-run-plv8> server # [ 1.519982] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-plv8> server # [ 1.521186] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-plv8> server # [ 1.522531] systemd[1]: Expecting device /dev/disk/by-label/nixos... vm-test-run-plv8> server # [ 1.523656] systemd[1]: Reached target Path Units. vm-test-run-plv8> server # [ 1.524526] systemd[1]: Reached target Slice Units. vm-test-run-plv8> server # [ 1.525355] systemd[1]: Reached target Swaps. vm-test-run-plv8> server # [ 1.526107] systemd[1]: Reached target Timer Units. vm-test-run-plv8> server # [ 1.527092] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-plv8> server # [ 1.528264] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-plv8> server # [ 1.529431] systemd[1]: Listening on Journal Sockets. vm-test-run-plv8> server # [ 1.530383] systemd[1]: Listening on udev Control Socket. vm-test-run-plv8> server # [ 1.531369] systemd[1]: Listening on udev Kernel Socket. vm-test-run-plv8> server # [ 1.532282] systemd[1]: Reached target Socket Units. vm-test-run-plv8> server # [ 1.534075] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-plv8> server # [ 1.536497] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-plv8> server # [ 1.542640] systemd[1]: Starting Load Kernel Module configfs... vm-test-run-plv8> server # [ 1.548243] systemd[1]: Starting Journal Service... vm-test-run-plv8> server # [ 1.554502] systemd[1]: Starting Load Kernel Modules... vm-test-run-plv8> server # [ 1.555731] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-plv8> server # [ 1.565597] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-plv8> server # [ 1.576891] netfs: FS-Cache loaded vm-test-run-plv8> server # [ 1.577885] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-plv8> server # [ 1.585342] systemd[1]: modprobe@configfs.service: Deactivated successfully. vm-test-run-plv8> server # [ 1.590390] 9pnet: Installing 9P2000 support vm-test-run-plv8> server # [ 1.595630] systemd[1]: Finished Load Kernel Module configfs. vm-test-run-plv8> server # [ 1.599021] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config vm-test-run-plv8> server # [ 1.602265] systemd-journald[75]: Collecting audit messages is disabled. vm-test-run-plv8> server # [ 1.608373] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-plv8> server # [ 1.613055] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. vm-test-run-plv8> server # [ 1.616625] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-plv8> server # [ 1.619623] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev vm-test-run-plv8> server # [ 1.623849] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-plv8> server # [ 1.632711] systemd[1]: Finished Load Kernel Modules. vm-test-run-plv8> server # [ 1.636770] systemd[1]: Starting Apply Kernel Variables... vm-test-run-plv8> server # [ 1.647516] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-plv8> server # [ 1.655149] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-plv8> server # [ 1.674018] systemd[1]: Finished Apply Kernel Variables. vm-test-run-plv8> server # [ 1.675638] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-plv8> server # [ 1.677079] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-plv8> server # [ 1.682506] systemd[1]: Reached target Local File Systems. vm-test-run-plv8> server # [ 1.687511] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-plv8> server # [ 1.573350] systemd-modules-load[76]: Using 2 probe threads vm-test-run-plv8> server # [ 1.703738] systemd[1]: Started Journal Service. vm-test-run-plv8> server # [ 1.576405] systemd-modules-load[76]: Inserted module 'virtio_balloon' vm-test-run-plv8> server # [ 1.577755] systemd-modules-load[76]: Inserted module 'virtio_gpu' vm-test-run-plv8> server # [ 1.580343] systemd-modules-load[76]: Inserted module 'dm_mod' vm-test-run-plv8> server # [ 1.582657] systemd[1]: Starting Create System Files and Directories... vm-test-run-plv8> server # [ 1.604098] systemd[1]: Finished Create System Files and Directories. vm-test-run-plv8> server # [ 1.606616] systemd-udevd[85]: Using default interface naming scheme 'v260'. vm-test-run-plv8> server # [ 1.626074] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-plv8> server # [ 1.658671] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-plv8> server # [ 1.660328] systemd[1]: Reached target System Initialization. vm-test-run-plv8> server # [ 1.661458] systemd[1]: Reached target Basic System. vm-test-run-plv8> server # [ 1.948837] uhci_hcd 0000:00:01.2: UHCI Host Controller vm-test-run-plv8> server # [ 1.949592] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 vm-test-run-plv8> server # [ 1.952377] uhci_hcd 0000:00:01.2: detected 2 ports vm-test-run-plv8> server # [ 1.953352] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 vm-test-run-plv8> server # [ 1.956737] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 vm-test-run-plv8> server # [ 1.958451] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 vm-test-run-plv8> server # [ 1.958492] SCSI subsystem initialized vm-test-run-plv8> server # [ 1.958835] usb usb1: Product: UHCI Host Controller vm-test-run-plv8> server # [ 1.961244] usb usb1: Manufacturer: Linux 6.18.54 uhci_hcd vm-test-run-plv8> server # [ 1.961950] usb usb1: SerialNumber: 0000:00:01.2 vm-test-run-plv8> server # [ 1.997968] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-plv8> server # [ 2.000306] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-plv8> server # [ 2.001735] scsi host0: ata_piix vm-test-run-plv8> server # [ 2.011012] hub 1-0:1.0: USB hub found vm-test-run-plv8> server # [ 2.011093] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 vm-test-run-plv8> server # [ 2.011251] hub 1-0:1.0: 2 ports detected vm-test-run-plv8> server # [ 2.013572] scsi host1: ata_piix vm-test-run-plv8> server # [ 2.015281] serio: i8042 KBD port at 0x60,0x64 irq 1 vm-test-run-plv8> server # [ 2.016123] serio: i8042 AUX port at 0x60,0x64 irq 12 vm-test-run-plv8> server # [ 2.028169] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 vm-test-run-plv8> server # [ 2.029588] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 vm-test-run-plv8> server # [ 1.932843] (udev-worker)[114]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 1.940691] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 1.945184] (udev-worker)[102]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-plv8> server # [ 1.946851] (udev-worker)[102]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 1.959647] systemd[1]: Found device /dev/disk/by-label/nixos. vm-test-run-plv8> server # [ 1.961209] systemd[1]: Reached target Initrd Root Device. vm-test-run-plv8> server # [ 1.963219] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... vm-test-run-plv8> server # [ 1.967197] systemd-vconsole-setup[128]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-plv8> server # [ 1.975112] systemd[1]: Finished Virtual Console Setup. vm-test-run-plv8> server # [ 1.984663] systemd-fsck[134]: nixos: clean, 12/65536 files, 13019/262144 blocks vm-test-run-plv8> server # [ 1.988888] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. vm-test-run-plv8> server # [ 2.188568] ata2: found unknown device (class 0) vm-test-run-plv8> server # [ 2.190025] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 vm-test-run-plv8> server # [ 2.191804] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 vm-test-run-plv8> server # [ 2.209274] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 vm-test-run-plv8> server # [ 2.237027] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray vm-test-run-plv8> server # [ 2.262765] cdrom: Uniform CD-ROM driver Revision: 3.20 vm-test-run-plv8> server # [ 2.276461] usb 1-1: new full-speed USB device number 2 using uhci_hcd vm-test-run-plv8> server # [ 2.441359] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 vm-test-run-plv8> server # [ 2.442452] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 vm-test-run-plv8> server # [ 2.443315] usb 1-1: Product: QEMU USB Tablet vm-test-run-plv8> server # [ 2.444044] usb 1-1: Manufacturer: QEMU vm-test-run-plv8> server # [ 2.444627] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 vm-test-run-plv8> server # [ 2.476931] hid: raw HID events driver (C) Jiri Kosina vm-test-run-plv8> server # [ 2.484942] usbcore: registered new interface driver usbhid vm-test-run-plv8> server # [ 2.485814] usbhid: USB HID core driver vm-test-run-plv8> server # [ 2.490382] 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 # [ 2.491854] 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 # [ 2.446125] systemd[1]: Mounting /sysroot... vm-test-run-plv8> server # [ 2.667993] EXT4-fs (vda): mounted filesystem 67970647-4ebe-4900-bd5e-b5c19d5f9b64 r/w with ordered data mode. Quota mode: none. vm-test-run-plv8> server # [ 2.541657] systemd[1]: Mounted /sysroot. vm-test-run-plv8> server # [ 2.542827] systemd[1]: Reached target Initrd Root File System. vm-test-run-plv8> server # [ 2.545894] systemd[1]: Mounting /sysroot/nix/.ro-store... vm-test-run-plv8> server # [ 2.547665] systemd[1]: Mounting /sysroot/nix/.rw-store... vm-test-run-plv8> server # [ 2.550173] systemd[1]: Mounting /sysroot/run... vm-test-run-plv8> server # [ 2.553406] systemd[1]: Mounting /sysroot/tmp/shared... vm-test-run-plv8> server # [ 2.560131] systemd[1]: Mounting /sysroot/tmp/xchg... vm-test-run-plv8> server # [ 2.566071] systemd[1]: Starting Mountpoints Configured in the Real Root... vm-test-run-plv8> server # [ 2.702611] 9p: Installing v9fs 9p2000 file system support vm-test-run-plv8> server # [ 2.574061] systemd[1]: Mounted /sysroot/nix/.rw-store. vm-test-run-plv8> server # [ 2.574767] systemd[1]: Mounted /sysroot/run. vm-test-run-plv8> server # [ 2.580961] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-plv8> server # [ 2.583207] systemd[1]: Mounted /sysroot/nix/.ro-store. vm-test-run-plv8> server # [ 2.586814] systemd[1]: Mounted /sysroot/tmp/shared. vm-test-run-plv8> server # [ 2.590225] systemd-sysroot-fstab-check[154]: /sysroot should be mounted in the initrd, will request daemon-reload. vm-test-run-plv8> server # [ 2.591958] systemd[1]: Mounted /sysroot/tmp/xchg. vm-test-run-plv8> server # [ 2.594531] systemd[1]: Reload requested from client PID 154 ('systemd-sysroot') (unit initrd-parse-etc.service)... vm-test-run-plv8> server # [ 2.595835] systemd[1]: Reloading... vm-test-run-plv8> server # [ 2.666673] systemd[1]: Reloading finished in 70 ms. vm-test-run-plv8> server # [ 2.672894] systemd-sysroot-fstab-check[154]: Requesting initrd-fs.target/start/replace... vm-test-run-plv8> server # [ 2.674923] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-plv8> server # [ 2.676195] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-plv8> server # [ 2.679343] systemd-sysroot-fstab-check[154]: Requesting swap.target/start/replace... vm-test-run-plv8> server # [ 2.683067] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-plv8> server # [ 2.683778] systemd[1]: initrd-parse-etc.service: Deactivated successfully. vm-test-run-plv8> server # [ 2.684787] systemd[1]: Finished Mountpoints Configured in the Real Root. vm-test-run-plv8> server # [ 2.685685] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. vm-test-run-plv8> server # [ 2.696957] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-plv8> server # [ 2.698099] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-plv8> server # [ 3.446891] systemd[1]: Mounting /sysroot/nix/store... vm-test-run-plv8> server # [ 3.470529] systemd[1]: Mounted /sysroot/nix/store. vm-test-run-plv8> server # [ 3.471871] systemd[1]: Reached target Initrd File Systems. vm-test-run-plv8> server # [ 3.474082] systemd[1]: Starting Find NixOS closure... vm-test-run-plv8> server # [ 3.475154] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... vm-test-run-plv8> server # [ 3.488980] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. vm-test-run-plv8> server # [ 3.490443] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. vm-test-run-plv8> server # [ 3.498132] systemd[1]: Finished Find NixOS closure. vm-test-run-plv8> server # [ 3.498993] systemd[1]: Reached target Initrd Default Target. vm-test-run-plv8> server # [ 3.501100] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... vm-test-run-plv8> server # [ 3.519257] systemd[1]: Stopped target Initrd Default Target. vm-test-run-plv8> server # [ 3.520281] systemd[1]: Stopped target Basic System. vm-test-run-plv8> server # [ 3.520893] systemd[1]: Stopped target Initrd Root Device. vm-test-run-plv8> server # [ 3.521534] systemd[1]: Stopped target Path Units. vm-test-run-plv8> server # [ 3.522276] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. vm-test-run-plv8> server # [ 3.523297] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. vm-test-run-plv8> server # [ 3.524391] systemd[1]: Stopped target Slice Units. vm-test-run-plv8> server # [ 3.525158] systemd[1]: Stopped target Socket Units. vm-test-run-plv8> server # [ 3.525736] systemd[1]: Stopped target System Initialization. vm-test-run-plv8> server # [ 3.526402] systemd[1]: Stopped target Swaps. vm-test-run-plv8> server # [ 3.526986] systemd[1]: Stopped target Timer Units. vm-test-run-plv8> server # [ 3.527627] systemd[1]: dbus.socket: Deactivated successfully. vm-test-run-plv8> server # [ 3.528402] systemd[1]: Closed D-Bus System Message Bus Socket. vm-test-run-plv8> server # [ 3.529146] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.529976] systemd[1]: Stopped Find NixOS closure. vm-test-run-plv8> server # [ 3.530620] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio vm-test-run-plv8> server # [ 3.532290] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-plv8> server # [ 3.534418] systemd[1]: systemd-sysctl.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.535712] systemd[1]: Stopped Apply Kernel Variables. vm-test-run-plv8> server # [ 3.537666] systemd[1]: systemd-modules-load.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.539571] systemd[1]: Stopped Load Kernel Modules. vm-test-run-plv8> server # [ 3.541116] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.542981] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. vm-test-run-plv8> server # [ 3.545167] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.546687] systemd[1]: Stopped Create System Files and Directories. vm-test-run-plv8> server # [ 3.548592] systemd[1]: Stopped target Local File Systems. vm-test-run-plv8> server # [ 3.550320] systemd[1]: Stopped target Preparation for Local File Systems. vm-test-run-plv8> server # [ 3.551925] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.554170] systemd[1]: Stopped Coldplug All udev Devices. vm-test-run-plv8> server # [ 3.554878] systemd[1]: Stopping Rule-based Manager for Device Events and Files... vm-test-run-plv8> server # [ 3.556550] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.557465] systemd[1]: Stopped Virtual Console Setup. vm-test-run-plv8> server # [ 3.558319] systemd[1]: systemd-udevd.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.559485] systemd[1]: Stopped Rule-based Manager for Device Events and Files. vm-test-run-plv8> server # [ 3.561253] systemd[1]: initrd-cleanup.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.562156] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. vm-test-run-plv8> server # [ 3.562961] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.563877] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-plv8> server # [ 3.565191] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. vm-test-run-plv8> server # [ 3.566046] systemd[1]: Closed udev Control Socket. vm-test-run-plv8> server # [ 3.566655] systemd[1]: Starting Cleanup udev Database... vm-test-run-plv8> server # [ 3.567483] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.568638] systemd[1]: Stopped Create Static Device Nodes in /dev. vm-test-run-plv8> server # [ 3.569622] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.570894] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. vm-test-run-plv8> server # [ 3.571901] systemd[1]: kmod-static-nodes.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.572785] systemd[1]: Stopped Create List of Static Device Nodes. vm-test-run-plv8> server # [ 3.584872] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. vm-test-run-plv8> server # [ 3.587603] systemd[1]: Finished Cleanup udev Database. vm-test-run-plv8> server # [ 3.588367] systemd[1]: Reached target Switch Root. vm-test-run-plv8> server # [ 3.589313] systemd[1]: Starting NixOS Activation... vm-test-run-plv8> server # [ 3.711246] initrd-nixos-activation-start[203]: booting system configuration /nix/store/hgmw5v86rlv8k2hhkynd4mn6gm5w84ja-nixos-system-server-test vm-test-run-plv8> server # [ 3.752661] initrd-nixos-activation-start[203]: running activation script... vm-test-run-plv8> server # [ 4.090245] initrd-nixos-activation-start[226]: setting up /etc... vm-test-run-plv8> server # [ 4.300517] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. vm-test-run-plv8> server # [ 4.301935] systemd[1]: Finished NixOS Activation. vm-test-run-plv8> server # [ 4.304096] systemd[1]: Starting Switch Root... vm-test-run-plv8> server # [ 4.319988] systemd[1]: Switching root. vm-test-run-plv8> server # [ 4.466789] systemd-journald[75]: Received SIGTERM from PID 1 (systemd). vm-test-run-plv8> server # [ 4.595388] NET: Registered PF_VSOCK protocol family vm-test-run-plv8> server # [ 4.974171] systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) vm-test-run-plv8> server # [ 4.984251] systemd[1]: Detected virtualization kvm. vm-test-run-plv8> server # [ 4.986289] systemd[1]: Detected architecture x86-64. vm-test-run-plv8> server # [ 4.988394] systemd[1]: Detected first boot. vm-test-run-plv8> server # [ 4.995326] systemd[1]: Initializing machine ID from random generator. vm-test-run-plv8> server # [ 5.173800] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-plv8> server # [ 5.248722] systemd[1]: Applying preset policy. vm-test-run-plv8> server # [ 5.659239] systemd[1]: Populated /etc with preset unit settings. vm-test-run-plv8> server # [ 6.108511] systemd[1]: initrd-switch-root.service: Deactivated successfully. vm-test-run-plv8> server # [ 6.109875] systemd[1]: Stopped initrd-switch-root.service. vm-test-run-plv8> server # [ 6.112125] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. vm-test-run-plv8> server # [ 6.114243] systemd[1]: Created slice Slice /system/getty. vm-test-run-plv8> server # [ 6.115652] systemd[1]: Created slice User and Session Slice. vm-test-run-plv8> server # [ 6.116548] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-plv8> server # [ 6.117733] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-plv8> server # [ 6.118796] systemd[1]: Expecting device /dev/hvc0... vm-test-run-plv8> server # [ 6.119566] systemd[1]: Expecting device /dev/ttyS0... vm-test-run-plv8> server # [ 6.120281] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-plv8> server # [ 6.121104] systemd[1]: Stopped target initrd-fs.target. vm-test-run-plv8> server # [ 6.121873] systemd[1]: Stopped target initrd-root-fs.target. vm-test-run-plv8> server # [ 6.122675] systemd[1]: Stopped target initrd-switch-root.target. vm-test-run-plv8> server # [ 6.123519] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-plv8> server # [ 6.124403] systemd[1]: Reached target Path Units. vm-test-run-plv8> server # [ 6.125119] systemd[1]: Reached target Remote File Systems. vm-test-run-plv8> server # [ 6.125931] systemd[1]: Reached target Slice Units. vm-test-run-plv8> server # [ 6.126651] systemd[1]: Reached target Swaps. vm-test-run-plv8> server # [ 6.129745] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-plv8> server # [ 6.132125] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-plv8> server # [ 6.135504] systemd[1]: Starting Journal Log Access Socket... vm-test-run-plv8> server # [ 6.136814] systemd[1]: Listening on Journal Audit Socket. vm-test-run-plv8> server # [ 6.137811] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-plv8> server # [ 6.139097] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-plv8> server # [ 6.140679] systemd[1]: Listening on udev Control Socket. vm-test-run-plv8> server # [ 6.144657] systemd[1]: Mounting Huge Pages File System... vm-test-run-plv8> server # [ 6.147785] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-plv8> server # [ 6.153518] systemd[1]: Mounting Kernel Debug File System... vm-test-run-plv8> server # [ 6.158525] systemd[1]: Mounting Kernel Trace File System... vm-test-run-plv8> server # [ 6.164513] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-plv8> server # [ 6.165762] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio vm-test-run-plv8> server # [ 6.173355] systemd[1]: Starting Load Kernel Module configfs... vm-test-run-plv8> server # [ 6.174544] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm vm-test-run-plv8> server # [ 6.176129] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-plv8> server # [ 6.177932] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse vm-test-run-plv8> server # [ 6.184520] systemd[1]: Mounting FUSE Control File System... vm-test-run-plv8> server # [ 6.185747] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 vm-test-run-plv8> server # [ 6.202071] systemd[1]: Starting Journal Service... vm-test-run-plv8> server # [ 6.212203] systemd[1]: Starting Load Kernel Modules... vm-test-run-plv8> server # [ 6.217182] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-plv8> server # [ 6.223977] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-plv8> server # [ 6.229313] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-plv8> server # [ 6.241446] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-plv8> server # [ 6.248115] systemd[1]: Listening on Journal Log Access Socket. vm-test-run-plv8> server # [ 6.250952] systemd[1]: Mounted Huge Pages File System. vm-test-run-plv8> server # [ 6.267079] loop: module loaded vm-test-run-plv8> server # [ 6.267334] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-plv8> server # [ 6.269602] systemd-journald[295]: Collecting audit messages is enabled. vm-test-run-plv8> server # [ 6.270656] systemd[1]: Mounted Kernel Debug File System. vm-test-run-plv8> server # [ 6.274681] systemd[1]: Mounted Kernel Trace File System. vm-test-run-plv8> server # [ 6.276515] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-plv8> server # [ 6.277397] EXT4-fs (vda): re-mounted 67970647-4ebe-4900-bd5e-b5c19d5f9b64. vm-test-run-plv8> server # [ 6.281866] systemd[1]: modprobe@configfs.service: Deactivated successfully. vm-test-run-plv8> server # [ 6.285577] systemd[1]: Finished Load Kernel Module configfs. vm-test-run-plv8> server # [ 6.157398] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-plv8> server # [ 6.288202] systemd[1]: Started Journal Service. vm-test-run-plv8> server # [ 6.159198] systemd[1]: systemd-journald.service: Deactivated successfully. vm-test-run-plv8> server # [ 6.161506] systemd-modules-load[296]: Using 2 probe threads vm-test-run-plv8> server # [ 6.165213] systemd-modules-load[296]: Inserted module 'loop' vm-test-run-plv8> server # [ 6.166534] systemd[1]: Mounted FUSE Control File System. vm-test-run-plv8> server # [ 6.169329] systemd[1]: Finished Load Kernel Modules. vm-test-run-plv8> server # [ 6.170473] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-plv8> server # [ 6.178767] systemd-oomd[297]: No swap; memory pressure usage will be degraded vm-test-run-plv8> server # [ 6.183124] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-plv8> server # [ 6.185533] systemd[1]: Starting Firewall... vm-test-run-plv8> server # [ 6.190526] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-plv8> server # [ 6.192601] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-plv8> server # [ 6.194710] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-plv8> server # [ 6.199702] systemd[1]: Starting Apply Kernel Variables... vm-test-run-plv8> server # [ 6.205403] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-plv8> server # [ 6.208121] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-plv8> server # [ 6.210285] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-plv8> server # [ 6.245659] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-plv8> server # [ 6.383697] systemd-journald[295]: Received client request to flush runtime journal. vm-test-run-plv8> server # [ 6.324775] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-plv8> server # [ 6.326093] systemd[1]: Reached target First Boot Complete. vm-test-run-plv8> server # [ 6.326962] systemd[1]: Finished Apply Kernel Variables. vm-test-run-plv8> server # [ 6.328078] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-plv8> server # [ 6.329330] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-plv8> server # [ 6.330379] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-plv8> server # [ 6.365362] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-plv8> server # [ 6.366952] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-plv8> server # [ 6.369547] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-plv8> server # [ 6.406507] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-plv8> server # [ 6.426422] systemd-udevd[339]: Using default interface naming scheme 'v260'. vm-test-run-plv8> server # [ 6.506025] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-plv8> server # [ 6.630439] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse vm-test-run-plv8> server # [ 6.681339] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. vm-test-run-plv8> server # [ 6.700790] (udev-worker)[389]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 6.724191] (udev-worker)[380]: 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.727161] (udev-worker)[380]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 6.735454] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. vm-test-run-plv8> server # [ 6.785109] systemd[1]: Condition check resulted in Virtio network device being skipped. vm-test-run-plv8> server # [ 6.786286] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-plv8> server # [ 6.788194] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 vm-test-run-plv8> server # [ 6.790479] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-plv8> server # [ 6.792929] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-plv8> server # [ 6.795397] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-plv8> server # [ 6.938071] rtc_cmos PNP0B00:00: RTC can wake from S4 vm-test-run-plv8> server # [ 6.941398] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 vm-test-run-plv8> server # [ 6.943547] rtc_cmos PNP0B00:00: registered as rtc0 vm-test-run-plv8> server # [ 6.945839] rtc_cmos PNP0B00:00: setting system clock to 2026-10-07T00:03:04 UTC (1791331384) vm-test-run-plv8> server # [ 6.949059] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs vm-test-run-plv8> server # [ 6.955785] ACPI: button: Power Button [PWRF] vm-test-run-plv8> server # [ 6.963575] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console vm-test-run-plv8> server # [ 6.972318] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 vm-test-run-plv8> server # [ 6.972367] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD vm-test-run-plv8> server # [ 6.985868] Console: switching to colour dummy device 80x25 vm-test-run-plv8> server # [ 6.996191] [drm] Found bochs VGA, ID 0xb0c5. vm-test-run-plv8> server # [ 6.996193] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. vm-test-run-plv8> server # [ 7.011712] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic vm-test-run-plv8> server # [ 7.012479] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 vm-test-run-plv8> server # [ 7.013902] mousedev: PS/2 mouse device common for all mice vm-test-run-plv8> server # [ 7.023481] Floppy drive(s): fd0 is 2.88M AMI BIOS vm-test-run-plv8> server # [ 7.027236] Console: switching to colour frame buffer device 160x50 vm-test-run-plv8> server # [ 7.028639] parport_pc 00:03: reported by Plug and Play ACPI vm-test-run-plv8> server # [ 7.029557] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] vm-test-run-plv8> server # [ 7.030280] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device vm-test-run-plv8> server # [ 7.035886] FDC 0 is a S82078B vm-test-run-plv8> server # [ 7.079505] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 vm-test-run-plv8> server # [ 7.082212] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 vm-test-run-plv8> server # [ 7.091890] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input6 vm-test-run-plv8> server # [ 6.982628] systemd[1]: Mounting /run/wrappers... vm-test-run-plv8> server # [ 7.012639] systemd[1]: Mounted /run/wrappers. vm-test-run-plv8> server # [ 7.018580] systemd[1]: Reached target Local File Systems. vm-test-run-plv8> server # [ 7.023170] systemd[1]: Listening on Boot Loader Control Service Socket. vm-test-run-plv8> server # [ 7.028826] systemd[1]: Starting register-nix-paths.service... vm-test-run-plv8> server # [ 7.032229] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-plv8> server # [ 7.034639] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. vm-test-run-plv8> server # [ 7.044191] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-plv8> server # [ 7.051337] systemd[1]: Starting Create System Files and Directories... vm-test-run-plv8> server # [ 7.063084] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 7.094361] systemd[1]: Finished Firewall. vm-test-run-plv8> server # [ 7.113497] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-plv8> server # [ 7.117568] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-plv8> server # [ 7.257326] ppdev: user-space parallel port driver vm-test-run-plv8> server # [ 7.134322] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-plv8> server # [ 7.136708] systemd[1]: Stopped Virtual Console Setup. vm-test-run-plv8> server # [ 7.147370] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 7.160970] systemd[1]: Finished Create System Files and Directories. vm-test-run-plv8> server # [ 7.163923] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-plv8> server # [ 7.168372] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-plv8> server # [ 7.214446] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-plv8> server # [ 7.224331] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-plv8> server # [ 7.226221] systemd[1]: Stopped Virtual Console Setup. vm-test-run-plv8> server # [ 7.231457] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 7.257343] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-plv8> server # [ 7.263283] systemd[1]: Starting Update is Completed... vm-test-run-plv8> server # [ 7.315613] systemd[1]: Finished Update is Completed. vm-test-run-plv8> server # [ 7.476118] kvm_amd: TSC scaling supported vm-test-run-plv8> server # [ 7.477104] kvm_amd: Nested Virtualization enabled vm-test-run-plv8> server # [ 7.477996] kvm_amd: Nested Paging enabled vm-test-run-plv8> server # [ 7.478823] kvm_amd: LBR virtualization supported vm-test-run-plv8> server # [ 7.479510] kvm_amd: Virtual VMLOAD VMSAVE supported vm-test-run-plv8> server # [ 7.480189] kvm_amd: Virtual GIF supported vm-test-run-plv8> server # [ 7.512806] EDAC MC: Ver: 3.0.0 vm-test-run-plv8> server # [ 7.492264] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-plv8> server # [ 7.493547] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-plv8> server # [ 7.591932] systemd-vconsole-setup[502]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-plv8> server # [ 7.595857] systemd[1]: Finished Virtual Console Setup. vm-test-run-plv8> server # [ 7.629048] systemd[1]: Finished register-nix-paths.service. vm-test-run-plv8> server # [ 7.629890] systemd[1]: Reached target System Initialization. vm-test-run-plv8> server # [ 7.631147] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-plv8> server # [ 7.632053] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-plv8> server # [ 7.632912] systemd[1]: Reached target Timer Units. vm-test-run-plv8> server # [ 7.633696] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-plv8> server # [ 7.635126] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-plv8> server # [ 7.636140] systemd[1]: Listening on Hostname Service Socket. vm-test-run-plv8> server # [ 7.636862] systemd[1]: Reached target Socket Units. vm-test-run-plv8> server # [ 7.637533] systemd[1]: Reached target Basic System. vm-test-run-plv8> server # [ 7.639398] systemd[1]: Started backdoor.service. vm-test-run-plv8> server # [ 7.642703] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-plv8> server # [ 7.644492] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 7.648439] systemd[1]: Starting Post-Boot Actions... vm-test-run-plv8> server # [ 7.654428] systemd[1]: Started Reset console on configuration changes. vm-test-run-plv8> server # [ 7.657850] systemd[1]: Starting resolvconf update... vm-test-run-plv8> server # [ 7.668134] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-plv8> server # [ 7.696310] systemd[1]: Finished Post-Boot Actions. vm-test-run-plv8> server # [ 7.706758] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 7.711137] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 7.712697] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 7.715248] nsncd[555]: Oct 07 00:03:05.391 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # connecting to host... vm-test-run-plv8> server # [ 7.718255] systemd[1]: Starting User Login Management... vm-test-run-plv8> server # [ 7.722808] systemd[1]: Finished Import lastlog data into lastlog2 database. 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.33 seconds) vm-test-run-plv8> server: (finished: waiting for the VM to finish booting, in 8.33 seconds) vm-test-run-plv8> server # [ 7.768872] dbus-broker-launch[560]: Looking up NSS user entry for 'systemd-timesync'... vm-test-run-plv8> server # [ 7.784063] dbus-broker-launch[560]: NSS returned no entry for 'systemd-timesync' vm-test-run-plv8> server # [ 7.784686] dbus-broker-launch[560]: Invalid user-name in /nix/store/0rm0lxx39mrp6jrm85fgnnhwxslyn3cc-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" vm-test-run-plv8> server # [ 7.800864] systemd-logind[578]: New seat seat0. vm-test-run-plv8> server # [ 7.806034] systemd-logind[578]: Watching system buttons on /dev/input/event2 (Power Button) vm-test-run-plv8> server # [ 7.807442] systemd-logind[578]: Watching system buttons on /dev/input/event5 (QEMU Virtio Keyboard) vm-test-run-plv8> server # [ 7.808834] systemd-logind[578]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) vm-test-run-plv8> server # [ 7.824188] systemd[1]: Started User Login Management. vm-test-run-plv8> server # [ 7.826559] systemd[1]: Started D-Bus System Message Bus. vm-test-run-plv8> server # [ 7.830840] systemd[1]: Starting linger-users.service... vm-test-run-plv8> server # [ 7.833273] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-plv8> server # [ 7.836395] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-plv8> server # [ 7.838113] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-plv8> server # [ 7.839125] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-plv8> server # [ 7.839670] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 7.841208] dbus-broker-launch[560]: Ready vm-test-run-plv8> server # [ 7.843563] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-plv8> server # [ 7.845348] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 7.860810] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 7.875427] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-plv8> server # [ 7.876590] systemd[1]: Finished linger-users.service. vm-test-run-plv8> server # [ 7.897498] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 7.898319] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 7.899065] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 7.900182] nsncd[640]: Oct 07 00:03:05.580 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 7.909677] systemd[1]: Finished resolvconf update. vm-test-run-plv8> server # [ 7.911154] systemd[1]: Reached target Preparation for Network. vm-test-run-plv8> server # [ 7.914379] systemd[1]: Starting DHCP Client... vm-test-run-plv8> server # [ 7.917064] systemd[1]: Starting Address configuration of eth1... vm-test-run-plv8> server # [ 7.921139] systemd[1]: Starting Extra networking commands.... vm-test-run-plv8> server # [ 7.996875] network-addresses-eth1-start[664]: adding address 192.168.1.1/24... done vm-test-run-plv8> server # [ 8.009071] network-addresses-eth1-start[664]: adding address 2001:db8:1::1/64... done vm-test-run-plv8> server # [ 8.023838] systemd[1]: Finished Address configuration of eth1. vm-test-run-plv8> server # [ 8.028187] dhcpcd[671]: dhcpcd-10.3.1 starting vm-test-run-plv8> server # [ 8.034563] dhcpcd[723]: dev: loaded udev vm-test-run-plv8> server # [ 8.044725] systemd[1]: Finished Extra networking commands.. vm-test-run-plv8> server # [ 8.045679] systemd[1]: Reached target Network. vm-test-run-plv8> server # [ 8.047711] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-plv8> server # [ 8.049957] systemd[1]: Starting Permit User Sessions... vm-test-run-plv8> server # [ 8.183251] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-plv8> server # [ 8.183761] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-plv8> server # [ 8.080578] systemd[1]: Finished Permit User Sessions. vm-test-run-plv8> server # [ 8.081959] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-plv8> server # [ 8.086439] systemd[1]: Started Getty on tty1. vm-test-run-plv8> server # [ 8.087937] systemd[1]: Reached target Login Prompts. vm-test-run-plv8> server # [ 8.137904] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[739]: Initializing database at /var/lib/postgresql/data vm-test-run-plv8> server # [ 8.282622] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-plv8> server # [ 8.303970] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-plv8> server # [ 8.304689] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-plv8> server # [ 8.307305] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 vm-test-run-plv8> server # [ 8.308789] cfg80211: failed to load regulatory.db vm-test-run-plv8> server # [ 8.350636] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-plv8> server # [ 8.222176] dhcpcd[723]: eth0: waiting for carrier vm-test-run-plv8> server # [ 8.222870] dhcpcd[723]: eth0: carrier acquired vm-test-run-plv8> server # [ 8.230157] dhcpcd[723]: DUID 00:01:00:01:32:58:48:b9:52:54:00:12:34:56 vm-test-run-plv8> server # [ 8.231238] dhcpcd[723]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 8.232033] dhcpcd[723]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-plv8> server # [ 8.252492] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: The files belonging to this database system will be owned by user "postgres". vm-test-run-plv8> server # [ 8.254589] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: This user must also own the server process. vm-test-run-plv8> server # [ 8.260080] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-plv8> server # [ 8.261704] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: The default database encoding has accordingly been set to "UTF8". vm-test-run-plv8> server # [ 8.263708] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: The default text search configuration will be set to "english". vm-test-run-plv8> server # [ 8.265538] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: Data page checksums are enabled. vm-test-run-plv8> server # [ 8.266687] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-plv8> server # [ 8.268438] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: creating subdirectories ... ok vm-test-run-plv8> server # [ 8.269935] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: selecting dynamic shared memory implementation ... posix vm-test-run-plv8> server # [ 8.319834] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: selecting default max_connections ... 100 vm-test-run-plv8> server # [ 8.378310] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: selecting default shared_buffers ... 128MB vm-test-run-plv8> server # [ 9.153871] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: selecting default time zone ... UTC vm-test-run-plv8> server # [ 9.159100] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: creating configuration files ... ok vm-test-run-plv8> server # [ 9.323500] dhcpcd[723]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 9.467110] NET: Registered PF_PACKET protocol family vm-test-run-plv8> server # [ 9.343386] dhcpcd[723]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 9.346213] dhcpcd[723]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 9.394183] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: running bootstrap script ... ok vm-test-run-plv8> server # [ 9.954086] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: performing post-bootstrap initialization ... ok vm-test-run-plv8> server # [ 10.093039] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: syncing data to disk ... ok vm-test-run-plv8> server # [ 10.094097] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-plv8> server # [ 10.095490] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: 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 # [ 10.098885] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: Success. You can now start the database server using: vm-test-run-plv8> server # [ 10.100549] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[740]: /nix/store/is16cl10cr4j0m8sn83svpbnkbmjfyal-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-plv8> server # [ 10.176781] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[739]: Validating PostgreSQL configuration... vm-test-run-plv8> server # [ 10.208895] mdmb45x5hq001zqqkx4jfbs91f5a31k8-postgresql-init[791]: 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 # [ 10.268391] postgres[793]: 2026-10-07 00:03:07.951 UTC [793] LOG: pgaudit extension initialized vm-test-run-plv8> server # [ 10.315579] postgres[793]: 2026-10-07 00:03:07.999 UTC [793] LOG: pgsodium primary server secret key loaded vm-test-run-plv8> server # [ 10.346136] postgres[793]: 2026-10-07 00:03:08.029 UTC [793] LOG: vault primary server secret key loaded vm-test-run-plv8> server # [ 10.395136] postgres[793]: 2026-10-07 00:03:08.078 UTC [793] LOG: starting PostgreSQL 15.19 on x86_64-pc-linux-gnu, compiled by gcc (GCC) 15.3.0, 64-bit vm-test-run-plv8> server # [ 10.397451] postgres[793]: 2026-10-07 00:03:08.080 UTC [793] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-plv8> server # [ 10.398747] postgres[793]: 2026-10-07 00:03:08.081 UTC [793] LOG: listening on IPv6 address "::", port 5432 vm-test-run-plv8> server # [ 10.400041] postgres[793]: 2026-10-07 00:03:08.082 UTC [793] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-plv8> server # [ 10.404168] postgres[798]: 2026-10-07 00:03:08.087 UTC [798] LOG: database system was shut down at 2026-10-07 00:03:07 UTC vm-test-run-plv8> server # [ 10.412234] postgres[793]: 2026-10-07 00:03:08.095 UTC [793] LOG: database system is ready to accept connections vm-test-run-plv8> server # [ 10.416254] postgres[801]: 2026-10-07 00:03:08.097 UTC [801] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-plv8> server # [ 10.417809] postgres[802]: 2026-10-07 00:03:08.098 UTC [802] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 10.421138] systemd[1]: Started PostgreSQL Database Server. vm-test-run-plv8> server # [ 10.422133] postgres[793]: 2026-10-07 00:03:08.101 UTC [793] LOG: background worker "pg_net 0.20.4 worker" (PID 802) exited with exit code 1 vm-test-run-plv8> server # [ 10.424091] systemd[1]: Starting Supabase Database Initialization... vm-test-run-plv8> server # [ 10.427358] postgres[803]: 2026-10-07 00:03:08.110 UTC [803] LOG: pg_cron scheduler started vm-test-run-plv8> server # [ 10.459065] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Waiting for PostgreSQL to be ready... vm-test-run-plv8> server # [ 10.490237] postgres[809]: ::1 2026-10-07 00:03:08.171 UTC [809] root@root FATAL: role "root" does not exist vm-test-run-plv8> server # [ 10.494817] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: PostgreSQL is ready vm-test-run-plv8> server # [ 10.496381] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Creating postgres role... vm-test-run-plv8> server # [ 10.516926] postgres[811]: ::1 2026-10-07 00:03:08.200 UTC [811] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-plv8> server # [ 10.519586] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[810]: CREATE ROLE vm-test-run-plv8> server # [ 10.540820] postgres[813]: ::1 2026-10-07 00:03:08.224 UTC [813] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-plv8> server # [ 10.543153] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[812]: ALTER DATABASE vm-test-run-plv8> server # [ 10.547510] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-plv8> server # [ 10.562973] postgres[815]: ::1 2026-10-07 00:03:08.246 UTC [815] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-plv8> server # [ 10.565363] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: CREATE PUBLICATION vm-test-run-plv8> server # [ 10.565883] postgres[815]: ::1 2026-10-07 00:03:08.248 UTC [815] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-plv8> server # [ 10.567465] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: ALTER ROLE vm-test-run-plv8> server # [ 10.568255] postgres[815]: ::1 2026-10-07 00:03:08.251 UTC [815] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-plv8> server # [ 10.569242] postgres[815]: ::1 2026-10-07 00:03:08.252 UTC [815] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-plv8> server # [ 10.570175] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: CREATE ROLE vm-test-run-plv8> server # [ 10.570652] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: CREATE ROLE vm-test-run-plv8> server # [ 10.571151] postgres[815]: ::1 2026-10-07 00:03:08.253 UTC [815] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-plv8> server # [ 10.571923] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: GRANT ROLE vm-test-run-plv8> server # [ 10.572600] postgres[815]: ::1 2026-10-07 00:03:08.256 UTC [815] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-plv8> server # [ 10.573265] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: GRANT vm-test-run-plv8> server # [ 10.573897] postgres[815]: ::1 2026-10-07 00:03:08.257 UTC [815] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-plv8> server # [ 10.574754] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: CREATE ROLE vm-test-run-plv8> server # [ 10.575943] postgres[815]: ::1 2026-10-07 00:03:08.258 UTC [815] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-plv8> server # [ 10.576558] postgres[815]: ::1 2026-10-07 00:03:08.259 UTC [815] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-plv8> server # [ 10.577277] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: GRANT ROLE vm-test-run-plv8> server # [ 10.577856] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: CREATE SCHEMA vm-test-run-plv8> server # [ 10.578356] postgres[815]: ::1 2026-10-07 00:03:08.260 UTC [815] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-plv8> server # [ 10.812599] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: CREATE EXTENSION vm-test-run-plv8> server # [ 10.813659] postgres[815]: ::1 2026-10-07 00:03:08.497 UTC [815] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-plv8> server # [ 10.844835] dhcpcd[723]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 10.845513] dhcpcd[723]: eth0: Router Advertisement from fe80::2 vm-test-run-plv8> server # [ 10.846631] dhcpcd[723]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-plv8> server # [ 10.847470] dhcpcd[723]: eth0: adding route to fec0::/64 vm-test-run-plv8> server # [ 10.848414] dhcpcd[723]: eth0: adding default route via fe80::2 vm-test-run-plv8> server # [ 10.937309] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: CREATE EXTENSION vm-test-run-plv8> server # [ 10.938383] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: CREATE ROLE vm-test-run-plv8> server # [ 10.939415] postgres[815]: ::1 2026-10-07 00:03:08.621 UTC [815] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-plv8> server # [ 10.941130] postgres[815]: ::1 2026-10-07 00:03:08.621 UTC [815] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-plv8> server # [ 10.942781] postgres[815]: ::1 2026-10-07 00:03:08.622 UTC [815] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-plv8> server # [ 10.944544] postgres[815]: ::1 2026-10-07 00:03:08.622 UTC [815] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-plv8> server # [ 10.946157] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: CREATE ROLE vm-test-run-plv8> server # [ 10.947150] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: CREATE ROLE vm-test-run-plv8> server # [ 10.948192] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: CREATE ROLE vm-test-run-plv8> server # [ 10.949047] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: GRANT ROLE vm-test-run-plv8> server # [ 10.949907] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: GRANT ROLE vm-test-run-plv8> server # [ 10.950889] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: GRANT ROLE vm-test-run-plv8> server # [ 10.951722] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: GRANT ROLE vm-test-run-plv8> server # [ 10.952944] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: GRANT vm-test-run-plv8> server # [ 10.953914] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 10.955316] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 10.956807] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 10.958403] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: GRANT vm-test-run-plv8> server # [ 10.959596] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: ALTER ROLE vm-test-run-plv8> server # [ 10.960904] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 10.961908] postgres[815]: ::1 2026-10-07 00:03:08.623 UTC [815] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-plv8> server # [ 10.963461] postgres[815]: ::1 2026-10-07 00:03:08.623 UTC [815] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-plv8> server # [ 10.964909] postgres[815]: ::1 2026-10-07 00:03:08.624 UTC [815] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-plv8> server # [ 10.966430] postgres[815]: ::1 2026-10-07 00:03:08.625 UTC [815] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-plv8> server # [ 10.968320] postgres[815]: ::1 2026-10-07 00:03:08.625 UTC [815] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 10.970253] postgres[815]: ::1 2026-10-07 00:03:08.626 UTC [815] 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 # [ 10.972195] postgres[815]: ::1 2026-10-07 00:03:08.627 UTC [815] 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 # [ 10.974392] postgres[815]: ::1 2026-10-07 00:03:08.627 UTC [815] 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 # [ 10.977042] postgres[815]: ::1 2026-10-07 00:03:08.627 UTC [815] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 10.979096] postgres[815]: ::1 2026-10-07 00:03:08.628 UTC [815] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-plv8> server # [ 10.980788] postgres[815]: ::1 2026-10-07 00:03:08.629 UTC [815] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 10.982560] postgres[815]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 10.983728] postgres[815]: ::1 2026-10-07 00:03:08.629 UTC [815] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 10.985245] postgres[815]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 10.986167] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 10.987189] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 10.988182] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: ALTER ROLE vm-test-run-plv8> server # [ 10.989166] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[814]: ALTER ROLE vm-test-run-plv8> server # [ 10.990074] postgres[815]: ::1 2026-10-07 00:03:08.630 UTC [815] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 10.992082] postgres[815]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 10.993088] postgres[815]: ::1 2026-10-07 00:03:08.630 UTC [815] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-plv8> server # [ 10.994663] postgres[815]: ::1 2026-10-07 00:03:08.631 UTC [815] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-plv8> server # [ 10.996514] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-plv8> server # [ 10.998886] postgres[817]: ::1 2026-10-07 00:03:08.660 UTC [817] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 11.000796] postgres[817]: ::1 2026-10-07 00:03:08.661 UTC [817] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-plv8> server # [ 11.002623] postgres[817]: instance_id uuid NULL, vm-test-run-plv8> server # [ 11.003461] postgres[817]: id uuid NOT NULL UNIQUE, vm-test-run-plv8> server # [ 11.004255] postgres[817]: aud varchar(255) NULL, vm-test-run-plv8> server # [ 11.005064] postgres[817]: "role" varchar(255) NULL, vm-test-run-plv8> server # [ 11.005843] postgres[817]: email varchar(255) NULL UNIQUE, vm-test-run-plv8> server # [ 11.006688] postgres[817]: encrypted_password varchar(255) NULL, vm-test-run-plv8> server # [ 11.007570] postgres[817]: confirmed_at timestamptz NULL, vm-test-run-plv8> server # [ 11.008371] postgres[817]: invited_at timestamptz NULL, vm-test-run-plv8> server # [ 11.009208] postgres[817]: confirmation_token varchar(255) NULL, vm-test-run-plv8> server # [ 11.010153] postgres[817]: confirmation_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 11.010977] postgres[817]: recovery_token varchar(255) NULL, vm-test-run-plv8> server # [ 11.011740] postgres[817]: recovery_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 11.012649] postgres[817]: email_change_token varchar(255) NULL, vm-test-run-plv8> server # [ 11.013722] postgres[817]: email_change varchar(255) NULL, vm-test-run-plv8> server # [ 11.014623] postgres[817]: email_change_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 11.015444] postgres[817]: last_sign_in_at timestamptz NULL, vm-test-run-plv8> server # [ 11.016281] postgres[817]: raw_app_meta_data jsonb NULL, vm-test-run-plv8> server # [ 11.017120] postgres[817]: raw_user_meta_data jsonb NULL, vm-test-run-plv8> server # [ 11.017888] postgres[817]: is_super_admin bool NULL, vm-test-run-plv8> server # [ 11.018658] postgres[817]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 11.019402] postgres[817]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 11.020125] postgres[817]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 11.020886] postgres[817]: ); vm-test-run-plv8> server # [ 11.021381] postgres[817]: ::1 2026-10-07 00:03:08.674 UTC [817] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-plv8> server # [ 11.021914] postgres[817]: ::1 2026-10-07 00:03:08.678 UTC [817] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-plv8> server # [ 11.022470] postgres[817]: ::1 2026-10-07 00:03:08.680 UTC [817] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-plv8> server # [ 11.023053] postgres[817]: ::1 2026-10-07 00:03:08.681 UTC [817] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-plv8> server # [ 11.023560] postgres[817]: instance_id uuid NULL, vm-test-run-plv8> server # [ 11.024411] postgres[817]: id bigserial NOT NULL, vm-test-run-plv8> server # [ 11.025115] postgres[817]: "token" varchar(255) NULL, vm-test-run-plv8> server # [ 11.025748] postgres[817]: user_id varchar(255) NULL, vm-test-run-plv8> server # [ 11.026557] postgres[817]: revoked bool NULL, vm-test-run-plv8> server # [ 11.027371] postgres[817]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 11.028075] postgres[817]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 11.028711] postgres[817]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 11.029517] postgres[817]: ); vm-test-run-plv8> server # [ 11.030400] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE SCHEMA vm-test-run-plv8> server # [ 11.030890] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE TABLE vm-test-run-plv8> server # [ 11.031436] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE INDEX vm-test-run-plv8> server # [ 11.031863] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE INDEX vm-test-run-plv8> server # [ 11.032361] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: COMMENT vm-test-run-plv8> server # [ 11.032770] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE TABLE vm-test-run-plv8> server # [ 11.033317] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE INDEX vm-test-run-plv8> server # [ 11.033766] postgres[817]: ::1 2026-10-07 00:03:08.688 UTC [817] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-plv8> server # [ 11.034429] postgres[817]: ::1 2026-10-07 00:03:08.702 UTC [817] 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 # [ 11.042767] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE INDEX vm-test-run-plv8> server # [ 11.043057] postgres[817]: ::1 2026-10-07 00:03:08.726 UTC [817] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-plv8> server # [ 11.048243] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE INDEX vm-test-run-plv8> server # [ 11.050383] postgres[817]: ::1 2026-10-07 00:03:08.731 UTC [817] 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 # [ 11.053350] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: COMMENT vm-test-run-plv8> server # [ 11.054509] postgres[817]: ::1 2026-10-07 00:03:08.738 UTC [817] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-plv8> server # [ 11.055131] postgres[817]: id uuid NOT NULL, vm-test-run-plv8> server # [ 11.055772] postgres[817]: uuid uuid NULL, vm-test-run-plv8> server # [ 11.056606] postgres[817]: raw_base_config text NULL, vm-test-run-plv8> server # [ 11.057475] postgres[817]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 11.058158] postgres[817]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 11.058793] postgres[817]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 11.059623] postgres[817]: ); vm-test-run-plv8> server # [ 11.064961] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE TABLE vm-test-run-plv8> server # [ 11.066666] postgres[817]: ::1 2026-10-07 00:03:08.748 UTC [817] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-plv8> server # [ 11.069069] postgres[817]: ::1 2026-10-07 00:03:08.751 UTC [817] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-plv8> server # [ 11.070821] postgres[817]: instance_id uuid NULL, vm-test-run-plv8> server # [ 11.071775] postgres[817]: id uuid NOT NULL, vm-test-run-plv8> server # [ 11.072611] postgres[817]: payload json NULL, vm-test-run-plv8> server # [ 11.073267] postgres[817]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 11.073918] postgres[817]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 11.074714] postgres[817]: ); vm-test-run-plv8> server # [ 11.075283] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: COMMENT vm-test-run-plv8> server # [ 11.075787] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE TABLE vm-test-run-plv8> server # [ 11.077396] postgres[817]: ::1 2026-10-07 00:03:08.758 UTC [817] 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 # [ 11.081537] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE INDEX vm-test-run-plv8> server # [ 11.082696] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: COMMENT vm-test-run-plv8> server # [ 11.084425] postgres[817]: ::1 2026-10-07 00:03:08.765 UTC [817] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-plv8> server # [ 11.086527] postgres[817]: ::1 2026-10-07 00:03:08.765 UTC [817] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-plv8> server # [ 11.088269] postgres[817]: "version" varchar(255) NOT NULL, vm-test-run-plv8> server # [ 11.090214] postgres[817]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-plv8> server # [ 11.091120] postgres[817]: ); vm-test-run-plv8> server # [ 11.091699] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE TABLE vm-test-run-plv8> server # [ 11.092771] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: COMMENT vm-test-run-plv8> server # [ 11.093757] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: INSERT 0 7 vm-test-run-plv8> server # [ 11.094537] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE FUNCTION vm-test-run-plv8> server # [ 11.095552] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE FUNCTION vm-test-run-plv8> server # [ 11.096668] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE FUNCTION vm-test-run-plv8> server # [ 11.097484] postgres[817]: ::1 2026-10-07 00:03:08.768 UTC [817] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-plv8> server # [ 11.097958] postgres[817]: ::1 2026-10-07 00:03:08.771 UTC [817] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-plv8> server # [ 11.098814] postgres[817]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-plv8> server # [ 11.099176] postgres[817]: $$ language sql stable; vm-test-run-plv8> server # [ 11.099829] postgres[817]: ::1 2026-10-07 00:03:08.772 UTC [817] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-plv8> server # [ 11.100485] postgres[817]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-plv8> server # [ 11.101357] postgres[817]: $$ language sql stable; vm-test-run-plv8> server # [ 11.102301] postgres[817]: ::1 2026-10-07 00:03:08.772 UTC [817] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-plv8> server # [ 11.103469] postgres[817]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-plv8> server # [ 11.104634] postgres[817]: $$ language sql stable; vm-test-run-plv8> server # [ 11.105435] postgres[817]: ::1 2026-10-07 00:03:08.773 UTC [817] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-plv8> server # [ 11.106030] postgres[817]: ::1 2026-10-07 00:03:08.776 UTC [817] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 11.106545] postgres[817]: ::1 2026-10-07 00:03:08.777 UTC [817] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.106961] postgres[817]: ::1 2026-10-07 00:03:08.778 UTC [817] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.107567] postgres[817]: ::1 2026-10-07 00:03:08.780 UTC [817] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.108377] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: GRANT vm-test-run-plv8> server # [ 11.109172] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: CREATE ROLE vm-test-run-plv8> server # [ 11.109546] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: GRANT vm-test-run-plv8> server # [ 11.110422] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: GRANT vm-test-run-plv8> server # [ 11.111286] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: GRANT vm-test-run-plv8> server # [ 11.119904] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: ALTER ROLE vm-test-run-plv8> server # [ 11.122794] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: ALTER TABLE vm-test-run-plv8> server # [ 11.123480] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: ALTER TABLE vm-test-run-plv8> server # [ 11.124140] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: ALTER TABLE vm-test-run-plv8> server # [ 11.124623] postgres[817]: ::1 2026-10-07 00:03:08.781 UTC [817] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-plv8> server # [ 11.125038] postgres[817]: ::1 2026-10-07 00:03:08.785 UTC [817] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.125543] postgres[817]: ::1 2026-10-07 00:03:08.787 UTC [817] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.125966] postgres[817]: ::1 2026-10-07 00:03:08.790 UTC [817] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.126518] postgres[817]: ::1 2026-10-07 00:03:08.791 UTC [817] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.126991] postgres[817]: ::1 2026-10-07 00:03:08.793 UTC [817] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.127549] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: ALTER TABLE vm-test-run-plv8> server # [ 11.127950] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[816]: ALTER TABLE vm-test-run-plv8> server # [ 11.136693] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-plv8> server # [ 11.164922] postgres[823]: ::1 2026-10-07 00:03:08.848 UTC [823] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 11.167027] postgres[823]: ::1 2026-10-07 00:03:08.849 UTC [823] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 11.168901] postgres[823]: ::1 2026-10-07 00:03:08.849 UTC [823] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-plv8> server # [ 11.170485] postgres[823]: ::1 2026-10-07 00:03:08.850 UTC [823] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-plv8> server # [ 11.172340] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[822]: CREATE SCHEMA vm-test-run-plv8> server # [ 11.173650] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[822]: CREATE ROLE vm-test-run-plv8> server # [ 11.175290] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[822]: ALTER ROLE vm-test-run-plv8> server # [ 11.176933] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[822]: GRANT vm-test-run-plv8> server # [ 11.178368] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[822]: DO vm-test-run-plv8> server # [ 11.178962] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-plv8> server # [ 11.195194] postgres[825]: ::1 2026-10-07 00:03:08.878 UTC [825] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-plv8> server # [ 11.198318] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: ALTER ROLE vm-test-run-plv8> server # [ 11.199248] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: ALTER ROLE vm-test-run-plv8> server # [ 11.200195] postgres[825]: ::1 2026-10-07 00:03:08.881 UTC [825] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-plv8> server # [ 11.201969] postgres[825]: ::1 2026-10-07 00:03:08.882 UTC [825] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-plv8> server # [ 11.203610] postgres[825]: RETURNS event_trigger vm-test-run-plv8> server # [ 11.204316] postgres[825]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 11.204912] postgres[825]: AS $$ vm-test-run-plv8> server # [ 11.205459] postgres[825]: DECLARE vm-test-run-plv8> server # [ 11.205959] postgres[825]: schema_is_cron bool; vm-test-run-plv8> server # [ 11.206575] postgres[825]: BEGIN vm-test-run-plv8> server # [ 11.207083] postgres[825]: schema_is_cron = ( vm-test-run-plv8> server # [ 11.207647] postgres[825]: SELECT n.nspname = 'cron' vm-test-run-plv8> server # [ 11.208296] postgres[825]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 11.209082] postgres[825]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-plv8> server # [ 11.209804] postgres[825]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 11.210457] postgres[825]: ); vm-test-run-plv8> server # [ 11.210910] postgres[825]: vm-test-run-plv8> server # [ 11.211320] postgres[825]: IF schema_is_cron vm-test-run-plv8> server # [ 11.211891] postgres[825]: THEN vm-test-run-plv8> server # [ 11.212384] postgres[825]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 11.213161] postgres[825]: vm-test-run-plv8> server # [ 11.213640] postgres[825]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 11.214406] postgres[825]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 11.214920] postgres[825]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 11.215535] postgres[825]: vm-test-run-plv8> server # [ 11.216085] postgres[825]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 11.216620] postgres[825]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 11.217328] postgres[825]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 11.217890] postgres[825]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 11.218434] postgres[825]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 11.219039] postgres[825]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 11.219567] postgres[825]: vm-test-run-plv8> server # [ 11.220144] postgres[825]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 11.220675] postgres[825]: vm-test-run-plv8> server # [ 11.221367] postgres[825]: END IF; vm-test-run-plv8> server # [ 11.221929] postgres[825]: vm-test-run-plv8> server # [ 11.222619] postgres[825]: END; vm-test-run-plv8> server # [ 11.223191] postgres[825]: $$; vm-test-run-plv8> server # [ 11.223724] postgres[825]: ::1 2026-10-07 00:03:08.883 UTC [825] 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 # [ 11.224180] postgres[825]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 11.224745] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: CREATE FUNCTION vm-test-run-plv8> server # [ 11.225167] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 11.225550] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: COMMENT vm-test-run-plv8> server # [ 11.225989] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: CREATE FUNCTION vm-test-run-plv8> server # [ 11.226532] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: COMMENT vm-test-run-plv8> server # [ 11.226943] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: DO vm-test-run-plv8> server # [ 11.227508] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: CREATE ROLE vm-test-run-plv8> server # [ 11.228059] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: GRANT vm-test-run-plv8> server # [ 11.228441] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: GRANT vm-test-run-plv8> server # [ 11.228862] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: GRANT vm-test-run-plv8> server # [ 11.229445] postgres[825]: ::1 2026-10-07 00:03:08.884 UTC [825] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-plv8> server # [ 11.229853] postgres[825]: ::1 2026-10-07 00:03:08.884 UTC [825] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-plv8> server # [ 11.230396] postgres[825]: RETURNS event_trigger vm-test-run-plv8> server # [ 11.230939] postgres[825]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 11.231606] postgres[825]: AS $$ vm-test-run-plv8> server # [ 11.232178] postgres[825]: BEGIN vm-test-run-plv8> server # [ 11.232689] postgres[825]: IF EXISTS ( vm-test-run-plv8> server # [ 11.233141] postgres[825]: SELECT 1 vm-test-run-plv8> server # [ 11.233639] postgres[825]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 11.234317] postgres[825]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 11.234855] postgres[825]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 11.235641] postgres[825]: WHERE ext.extname = 'pg_net' vm-test-run-plv8> server # [ 11.236315] postgres[825]: ) vm-test-run-plv8> server # [ 11.236795] postgres[825]: THEN vm-test-run-plv8> server # [ 11.237494] postgres[825]: IF NOT EXISTS ( vm-test-run-plv8> server # [ 11.238114] postgres[825]: SELECT 1 vm-test-run-plv8> server # [ 11.238649] postgres[825]: FROM pg_roles vm-test-run-plv8> server # [ 11.239351] postgres[825]: WHERE rolname = 'supabase_functions_admin' vm-test-run-plv8> server # [ 11.239898] postgres[825]: ) vm-test-run-plv8> server # [ 11.240594] postgres[825]: THEN vm-test-run-plv8> server # [ 11.241175] postgres[825]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 11.241707] postgres[825]: END IF; vm-test-run-plv8> server # [ 11.242422] postgres[825]: vm-test-run-plv8> server # [ 11.242987] postgres[825]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 11.243838] postgres[825]: vm-test-run-plv8> server # [ 11.244523] postgres[825]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 11.245124] postgres[825]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 11.245645] postgres[825]: vm-test-run-plv8> server # [ 11.246359] postgres[825]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plv8> server # [ 11.246919] postgres[825]: 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 # [ 11.247638] postgres[825]: vm-test-run-plv8> server # [ 11.248351] postgres[825]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plv8> server # [ 11.248905] postgres[825]: 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 # [ 11.249620] postgres[825]: vm-test-run-plv8> server # [ 11.250330] postgres[825]: 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 # [ 11.250890] postgres[825]: 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 # [ 11.251595] postgres[825]: END IF; vm-test-run-plv8> server # [ 11.252187] postgres[825]: END; vm-test-run-plv8> server # [ 11.252717] postgres[825]: $$; vm-test-run-plv8> server # [ 11.253457] postgres[825]: ::1 2026-10-07 00:03:08.885 UTC [825] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-plv8> server # [ 11.253841] postgres[825]: ::1 2026-10-07 00:03:08.886 UTC [825] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-plv8> server # [ 11.254399] postgres[825]: ::1 2026-10-07 00:03:08.887 UTC [825] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-plv8> server # [ 11.254821] postgres[825]: ::1 2026-10-07 00:03:08.887 UTC [825] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 11.255379] postgres[825]: ::1 2026-10-07 00:03:08.888 UTC [825] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 11.255798] postgres[825]: ::1 2026-10-07 00:03:08.891 UTC [825] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 11.271396] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: GRANT vm-test-run-plv8> server # [ 11.271972] postgres[825]: ::1 2026-10-07 00:03:08.954 UTC [825] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 11.273939] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: GRANT vm-test-run-plv8> server # [ 11.274719] postgres[825]: ::1 2026-10-07 00:03:08.958 UTC [825] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 11.276661] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: GRANT vm-test-run-plv8> server # [ 11.277474] postgres[825]: ::1 2026-10-07 00:03:08.961 UTC [825] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 11.279150] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: GRANT vm-test-run-plv8> server # [ 11.280069] postgres[825]: ::1 2026-10-07 00:03:08.963 UTC [825] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 11.281886] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: GRANT vm-test-run-plv8> server # [ 11.282706] postgres[825]: ::1 2026-10-07 00:03:08.966 UTC [825] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 11.286901] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: GRANT vm-test-run-plv8> server # [ 11.288925] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[824]: DO vm-test-run-plv8> server # [ 11.293333] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running pgbouncer auth schema... vm-test-run-plv8> server # [ 11.313370] postgres[827]: ::1 2026-10-07 00:03:08.996 UTC [827] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-plv8> server # [ 11.314856] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[826]: CREATE ROLE vm-test-run-plv8> server # [ 11.315710] postgres[827]: ::1 2026-10-07 00:03:08.999 UTC [827] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-plv8> server # [ 11.317342] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[826]: REVOKE vm-test-run-plv8> server # [ 11.318229] postgres[827]: ::1 2026-10-07 00:03:09.001 UTC [827] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-plv8> server # [ 11.322212] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[826]: CREATE SCHEMA vm-test-run-plv8> server # [ 11.323714] postgres[827]: ::1 2026-10-07 00:03:09.007 UTC [827] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-plv8> server # [ 11.324368] postgres[827]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-plv8> server # [ 11.324956] postgres[827]: $$ vm-test-run-plv8> server # [ 11.325696] postgres[827]: BEGIN vm-test-run-plv8> server # [ 11.326022] postgres[827]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-plv8> server # [ 11.326567] postgres[827]: vm-test-run-plv8> server # [ 11.327171] postgres[827]: RETURN QUERY vm-test-run-plv8> server # [ 11.327752] postgres[827]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-plv8> server # [ 11.328512] postgres[827]: WHERE usename = p_usename; vm-test-run-plv8> server # [ 11.329127] postgres[827]: END; vm-test-run-plv8> server # [ 11.329658] postgres[827]: $$ LANGUAGE plpgsql vm-test-run-plv8> server # [ 11.330353] postgres[827]: SET search_path = '' vm-test-run-plv8> server # [ 11.330903] postgres[827]: SECURITY DEFINER; vm-test-run-plv8> server # [ 11.332390] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[826]: CREATE FUNCTION vm-test-run-plv8> server # [ 11.333387] postgres[827]: ::1 2026-10-07 00:03:09.016 UTC [827] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-plv8> server # [ 11.336025] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[826]: REVOKE vm-test-run-plv8> server # [ 11.336560] postgres[827]: ::1 2026-10-07 00:03:09.019 UTC [827] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-plv8> server # [ 11.339764] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[826]: GRANT vm-test-run-plv8> server # [ 11.342952] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running stat extension... vm-test-run-plv8> server # [ 11.364662] postgres[829]: ::1 2026-10-07 00:03:09.047 UTC [829] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-plv8> server # [ 11.366382] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[828]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-plv8> server # [ 11.368874] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[828]: CREATE SCHEMA vm-test-run-plv8> server # [ 11.370663] postgres[829]: ::1 2026-10-07 00:03:09.052 UTC [829] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-plv8> server # [ 11.522446] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[828]: CREATE EXTENSION vm-test-run-plv8> server # [ 11.528545] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-plv8> server # [ 11.546196] postgres[833]: ::1 2026-10-07 00:03:09.229 UTC [833] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-plv8> server # [ 11.548191] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[832]: GRANT vm-test-run-plv8> server # [ 11.549074] postgres[833]: ::1 2026-10-07 00:03:09.231 UTC [833] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 11.551091] postgres[833]: ::1 2026-10-07 00:03:09.232 UTC [833] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 11.552994] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[832]: GRANT vm-test-run-plv8> server # [ 11.554121] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[832]: GRANT vm-test-run-plv8> server # [ 11.555227] postgres[833]: ::1 2026-10-07 00:03:09.236 UTC [833] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 11.557179] postgres[833]: ::1 2026-10-07 00:03:09.236 UTC [833] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 11.559246] postgres[833]: ::1 2026-10-07 00:03:09.237 UTC [833] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 11.561261] postgres[833]: ::1 2026-10-07 00:03:09.238 UTC [833] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 11.563278] postgres[833]: ::1 2026-10-07 00:03:09.238 UTC [833] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 11.565640] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[832]: GRANT vm-test-run-plv8> server # [ 11.566697] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[832]: GRANT vm-test-run-plv8> server # [ 11.568301] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[832]: GRANT vm-test-run-plv8> server # [ 11.569635] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[832]: GRANT vm-test-run-plv8> server # [ 11.571072] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[832]: GRANT vm-test-run-plv8> server # [ 11.572506] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[832]: GRANT vm-test-run-plv8> server # [ 11.573916] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[832]: DO vm-test-run-plv8> server # [ 11.575217] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[832]: ALTER ROLE vm-test-run-plv8> server # [ 11.576393] postgres[833]: ::1 2026-10-07 00:03:09.239 UTC [833] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 11.578545] postgres[833]: ::1 2026-10-07 00:03:09.242 UTC [833] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-plv8> server # [ 11.580753] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-plv8> server # [ 11.590477] postgres[835]: ::1 2026-10-07 00:03:09.273 UTC [835] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.592752] postgres[835]: ::1 2026-10-07 00:03:09.274 UTC [835] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.595383] postgres[835]: ::1 2026-10-07 00:03:09.275 UTC [835] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.595953] postgres[835]: ::1 2026-10-07 00:03:09.275 UTC [835] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.596637] postgres[835]: ::1 2026-10-07 00:03:09.276 UTC [835] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.597586] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: GRANT vm-test-run-plv8> server # [ 11.598135] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: GRANT vm-test-run-plv8> server # [ 11.598598] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: GRANT vm-test-run-plv8> server # [ 11.599901] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: ALTER TABLE vm-test-run-plv8> server # [ 11.600691] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: ALTER TABLE vm-test-run-plv8> server # [ 11.601383] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: ALTER TABLE vm-test-run-plv8> server # [ 11.601898] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: ALTER TABLE vm-test-run-plv8> server # [ 11.603068] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: ALTER TABLE vm-test-run-plv8> server # [ 11.603897] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: GRANT vm-test-run-plv8> server # [ 11.604605] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: GRANT vm-test-run-plv8> server # [ 11.605448] postgres[835]: ::1 2026-10-07 00:03:09.276 UTC [835] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.606268] postgres[835]: ::1 2026-10-07 00:03:09.277 UTC [835] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.606918] postgres[835]: ::1 2026-10-07 00:03:09.277 UTC [835] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 11.616153] postgres[835]: ::1 2026-10-07 00:03:09.277 UTC [835] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 11.616763] postgres[835]: ::1 2026-10-07 00:03:09.278 UTC [835] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 11.617665] postgres[835]: ::1 2026-10-07 00:03:09.280 UTC [835] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 11.618182] postgres[835]: ::1 2026-10-07 00:03:09.283 UTC [835] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 11.618835] postgres[835]: ::1 2026-10-07 00:03:09.285 UTC [835] 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 # [ 11.619540] postgres[835]: ::1 2026-10-07 00:03:09.286 UTC [835] 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 # [ 11.620260] postgres[835]: ::1 2026-10-07 00:03:09.288 UTC [835] 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 # [ 11.620950] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: GRANT vm-test-run-plv8> server # [ 11.621574] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: GRANT vm-test-run-plv8> server # [ 11.622130] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 11.622606] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 11.623387] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[834]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 11.636502] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-plv8> server # [ 11.658259] postgres[837]: ::1 2026-10-07 00:03:09.341 UTC [837] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-plv8> server # [ 11.660166] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[836]: CREATE SCHEMA vm-test-run-plv8> server # [ 11.666413] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-plv8> server # [ 11.684607] postgres[839]: ::1 2026-10-07 00:03:09.367 UTC [839] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-plv8> server # [ 11.686935] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[838]: GRANT vm-test-run-plv8> server # [ 11.687978] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[838]: GRANT vm-test-run-plv8> server # [ 11.688989] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[838]: GRANT vm-test-run-plv8> server # [ 11.689976] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[838]: GRANT vm-test-run-plv8> server # [ 11.691532] postgres[839]: ::1 2026-10-07 00:03:09.370 UTC [839] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 11.691936] postgres[839]: ::1 2026-10-07 00:03:09.370 UTC [839] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 11.692557] postgres[839]: ::1 2026-10-07 00:03:09.370 UTC [839] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 11.693129] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-plv8> server # [ 11.715673] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[840]: DO vm-test-run-plv8> server # [ 11.717177] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[840]: DO vm-test-run-plv8> server # [ 11.718421] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[840]: DO vm-test-run-plv8> server # [ 11.721496] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-plv8> server # [ 11.742738] postgres[843]: ::1 2026-10-07 00:03:09.425 UTC [843] 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 # [ 11.746252] postgres[843]: ::1 2026-10-07 00:03:09.426 UTC [843] 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 # [ 11.749540] postgres[843]: ::1 2026-10-07 00:03:09.427 UTC [843] 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 # [ 11.750280] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[842]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 11.750869] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[842]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 11.751564] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[842]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 11.752137] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-plv8> server # [ 11.771764] postgres[845]: ::1 2026-10-07 00:03:09.455 UTC [845] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-plv8> server # [ 11.774551] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[844]: ALTER ROLE vm-test-run-plv8> server # [ 11.779437] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-plv8> server # [ 11.798331] postgres[847]: ::1 2026-10-07 00:03:09.481 UTC [847] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 11.800284] postgres[847]: ::1 2026-10-07 00:03:09.482 UTC [847] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 11.802462] postgres[847]: ::1 2026-10-07 00:03:09.483 UTC [847] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 11.803080] postgres[847]: DECLARE vm-test-run-plv8> server # [ 11.803737] postgres[847]: cmd record; vm-test-run-plv8> server # [ 11.804686] postgres[847]: BEGIN vm-test-run-plv8> server # [ 11.806221] postgres[847]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 11.807216] postgres[847]: LOOP vm-test-run-plv8> server # [ 11.807948] postgres[847]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 11.808707] postgres[847]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 11.809670] postgres[847]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 11.810736] postgres[847]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 11.811761] postgres[847]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 11.812572] postgres[847]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 11.813534] postgres[847]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 11.814793] postgres[847]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 11.815551] postgres[847]: , 'CREATE TYPE' vm-test-run-plv8> server # [ 11.816330] postgres[847]: , 'CREATE RULE' vm-test-run-plv8> server # [ 11.817262] postgres[847]: , 'COMMENT' vm-test-run-plv8> server # [ 11.817894] postgres[847]: ) vm-test-run-plv8> server # [ 11.818574] postgres[847]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 11.819869] postgres[847]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 11.821054] postgres[847]: THEN vm-test-run-plv8> server # [ 11.821729] postgres[847]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 11.822674] postgres[847]: END IF; vm-test-run-plv8> server # [ 11.823440] postgres[847]: END LOOP; vm-test-run-plv8> server # [ 11.823929] postgres[847]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 11.824753] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-plv8> server # [ 11.825472] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 11.826525] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-plv8> server # [ 11.827621] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: DROP FUNCTION vm-test-run-plv8> server # [ 11.828593] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: CREATE FUNCTION vm-test-run-plv8> server # [ 11.828856] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: CREATE FUNCTION vm-test-run-plv8> server # [ 11.829768] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-plv8> server # [ 11.830348] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 11.831027] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 11.831896] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-plv8> server # [ 11.832650] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 11.833422] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[846]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 11.834159] postgres[847]: ::1 2026-10-07 00:03:09.484 UTC [847] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 11.836485] postgres[847]: DECLARE vm-test-run-plv8> server # [ 11.837673] postgres[847]: obj record; vm-test-run-plv8> server # [ 11.838616] postgres[847]: BEGIN vm-test-run-plv8> server # [ 11.839180] postgres[847]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 11.839719] postgres[847]: LOOP vm-test-run-plv8> server # [ 11.840540] postgres[847]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 11.841114] postgres[847]: 'schema' vm-test-run-plv8> server # [ 11.841647] postgres[847]: , 'table' vm-test-run-plv8> server # [ 11.842354] postgres[847]: , 'foreign table' vm-test-run-plv8> server # [ 11.842909] postgres[847]: , 'view' vm-test-run-plv8> server # [ 11.843594] postgres[847]: , 'materialized view' vm-test-run-plv8> server # [ 11.844167] postgres[847]: , 'function' vm-test-run-plv8> server # [ 11.844720] postgres[847]: , 'trigger' vm-test-run-plv8> server # [ 11.845412] postgres[847]: , 'type' vm-test-run-plv8> server # [ 11.845955] postgres[847]: , 'rule' vm-test-run-plv8> server # [ 11.846647] postgres[847]: ) vm-test-run-plv8> server # [ 11.847480] postgres[847]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 11.848066] postgres[847]: THEN vm-test-run-plv8> server # [ 11.848588] postgres[847]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 11.849164] postgres[847]: END IF; vm-test-run-plv8> server # [ 11.849728] postgres[847]: END LOOP; vm-test-run-plv8> server # [ 11.850406] postgres[847]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 11.850950] postgres[847]: ::1 2026-10-07 00:03:09.484 UTC [847] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 11.851504] postgres[847]: ::1 2026-10-07 00:03:09.485 UTC [847] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 11.851912] postgres[847]: ON ddl_command_end vm-test-run-plv8> server # [ 11.852601] postgres[847]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 11.853193] postgres[847]: ::1 2026-10-07 00:03:09.485 UTC [847] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 11.853580] postgres[847]: ::1 2026-10-07 00:03:09.485 UTC [847] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 11.854037] postgres[847]: ON sql_drop vm-test-run-plv8> server # [ 11.854570] postgres[847]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 11.855176] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-plv8> server # [ 11.954552] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[848]: DO vm-test-run-plv8> server # [ 11.958125] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-plv8> server # [ 11.978737] postgres[851]: ::1 2026-10-07 00:03:09.661 UTC [851] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-plv8> server # [ 11.980978] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: CREATE SCHEMA vm-test-run-plv8> server # [ 11.981613] postgres[851]: ::1 2026-10-07 00:03:09.664 UTC [851] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-plv8> server # [ 11.983130] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-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 # [ 11.985779] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: DROP FUNCTION vm-test-run-plv8> server # [ 11.986850] postgres[851]: ::1 2026-10-07 00:03:09.669 UTC [851] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 11.988575] postgres[851]: "operationName" text default null, vm-test-run-plv8> server # [ 11.989495] postgres[851]: query text default null, vm-test-run-plv8> server # [ 11.990273] postgres[851]: variables jsonb default null, vm-test-run-plv8> server # [ 11.991151] postgres[851]: extensions jsonb default null vm-test-run-plv8> server # [ 11.991992] postgres[851]: ) vm-test-run-plv8> server # [ 11.992442] postgres[851]: returns jsonb vm-test-run-plv8> server # [ 11.993153] postgres[851]: language plpgsql vm-test-run-plv8> server # [ 11.993804] postgres[851]: as $$ vm-test-run-plv8> server # [ 11.994302] postgres[851]: DECLARE vm-test-run-plv8> server # [ 11.994826] postgres[851]: server_version float; vm-test-run-plv8> server # [ 11.995650] postgres[851]: BEGIN vm-test-run-plv8> server # [ 11.996294] postgres[851]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 11.997568] postgres[851]: vm-test-run-plv8> server # [ 11.998064] postgres[851]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 11.998817] postgres[851]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 11.999594] postgres[851]: 'data', null::jsonb, vm-test-run-plv8> server # [ 12.000497] postgres[851]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 12.001832] postgres[851]: ); vm-test-run-plv8> server # [ 12.002546] postgres[851]: ELSE vm-test-run-plv8> server # [ 12.003106] postgres[851]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 12.003858] postgres[851]: 'data', null::jsonb, vm-test-run-plv8> server # [ 12.004844] postgres[851]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 12.006660] postgres[851]: ); vm-test-run-plv8> server # [ 12.007386] postgres[851]: END IF; vm-test-run-plv8> server # [ 12.008165] postgres[851]: END; vm-test-run-plv8> server # [ 12.008874] postgres[851]: $$; vm-test-run-plv8> server # [ 12.009553] postgres[851]: ::1 2026-10-07 00:03:09.670 UTC [851] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.011680] postgres[851]: ::1 2026-10-07 00:03:09.671 UTC [851] 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 # [ 12.014522] postgres[851]: ::1 2026-10-07 00:03:09.672 UTC [851] 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 # [ 12.016902] postgres[851]: ::1 2026-10-07 00:03:09.672 UTC [851] 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 # [ 12.019914] postgres[851]: ::1 2026-10-07 00:03:09.673 UTC [851] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 12.022113] postgres[851]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.023408] postgres[851]: ::1 2026-10-07 00:03:09.673 UTC [851] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 12.025865] postgres[851]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.027095] postgres[851]: ::1 2026-10-07 00:03:09.674 UTC [851] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 12.029932] postgres[851]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.031568] postgres[851]: ::1 2026-10-07 00:03:09.674 UTC [851] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 12.034348] postgres[851]: RETURNS event_trigger vm-test-run-plv8> server # [ 12.035425] postgres[851]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 12.036346] postgres[851]: AS $func$ vm-test-run-plv8> server # [ 12.036974] postgres[851]: DECLARE vm-test-run-plv8> server # [ 12.037650] postgres[851]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 12.038849] postgres[851]: BEGIN vm-test-run-plv8> server # [ 12.039721] postgres[851]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 12.040458] postgres[851]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 12.041496] postgres[851]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 12.042499] postgres[851]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 12.043567] postgres[851]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 12.044270] postgres[851]: ); vm-test-run-plv8> server # [ 12.044923] postgres[851]: vm-test-run-plv8> server # [ 12.045466] postgres[851]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 12.046178] postgres[851]: THEN vm-test-run-plv8> server # [ 12.046659] postgres[851]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.047458] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: CREATE FUNCTION vm-test-run-plv8> server # [ 12.047982] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: GRANT vm-test-run-plv8> server # [ 12.048593] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 12.049146] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 12.049670] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 12.050383] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 12.050884] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 12.051583] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 12.052140] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: CREATE FUNCTION vm-test-run-plv8> server # [ 12.052627] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping vm-test-run-plv8> server # [ 12.053204] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 12.053686] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 12.054381] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: COMMENT vm-test-run-plv8> server # [ 12.054915] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: CREATE FUNCTION vm-test-run-plv8> server # [ 12.055604] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping vm-test-run-plv8> server # [ 12.056072] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 12.056480] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 12.056987] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[850]: COMMENT vm-test-run-plv8> server # [ 12.057701] postgres[851]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.058551] postgres[851]: vm-test-run-plv8> server # [ 12.059431] postgres[851]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.060152] postgres[851]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.060837] postgres[851]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.061845] postgres[851]: vm-test-run-plv8> server # [ 12.062677] postgres[851]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 12.063526] postgres[851]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 12.064354] postgres[851]: "operationName" text default null, vm-test-run-plv8> server # [ 12.064935] postgres[851]: query text default null, vm-test-run-plv8> server # [ 12.065631] postgres[851]: variables jsonb default null, vm-test-run-plv8> server # [ 12.066324] postgres[851]: extensions jsonb default null vm-test-run-plv8> server # [ 12.067056] postgres[851]: ) vm-test-run-plv8> server # [ 12.067585] postgres[851]: returns jsonb vm-test-run-plv8> server # [ 12.068166] postgres[851]: language sql vm-test-run-plv8> server # [ 12.068699] postgres[851]: as $$ vm-test-run-plv8> server # [ 12.069546] postgres[851]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-plv8> server # [ 12.070229] postgres[851]: $$; vm-test-run-plv8> server # [ 12.070875] postgres[851]: vm-test-run-plv8> server # [ 12.071838] postgres[851]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.072629] postgres[851]: END IF; vm-test-run-plv8> server # [ 12.073469] postgres[851]: vm-test-run-plv8> server # [ 12.074042] postgres[851]: END; vm-test-run-plv8> server # [ 12.074672] postgres[851]: $func$; vm-test-run-plv8> server # [ 12.075697] postgres[851]: ::1 2026-10-07 00:03:09.675 UTC [851] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-plv8> server # [ 12.076449] postgres[851]: ::1 2026-10-07 00:03:09.675 UTC [851] 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 # [ 12.077056] postgres[851]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-plv8> server # [ 12.077675] postgres[851]: ::1 2026-10-07 00:03:09.676 UTC [851] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-plv8> server # [ 12.078388] postgres[851]: ::1 2026-10-07 00:03:09.677 UTC [851] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 12.078912] postgres[851]: RETURNS event_trigger vm-test-run-plv8> server # [ 12.079751] postgres[851]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 12.080629] postgres[851]: AS $func$ vm-test-run-plv8> server # [ 12.081524] postgres[851]: DECLARE vm-test-run-plv8> server # [ 12.082539] postgres[851]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 12.083523] postgres[851]: BEGIN vm-test-run-plv8> server # [ 12.084135] postgres[851]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 12.084821] postgres[851]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 12.085696] postgres[851]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 12.086715] postgres[851]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 12.087586] postgres[851]: ); vm-test-run-plv8> server # [ 12.088470] postgres[851]: vm-test-run-plv8> server # [ 12.089185] postgres[851]: IF graphql_is_dropped vm-test-run-plv8> server # [ 12.089923] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-plv8> server # [ 12.090425] postgres[851]: THEN vm-test-run-plv8> server # [ 12.091114] postgres[851]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 12.091805] postgres[851]: "operationName" text default null, vm-test-run-plv8> server # [ 12.092661] postgres[851]: query text default null, vm-test-run-plv8> server # [ 12.093539] postgres[851]: variables jsonb default null, vm-test-run-plv8> server # [ 12.094400] postgres[851]: extensions jsonb default null vm-test-run-plv8> server # [ 12.095126] postgres[851]: ) vm-test-run-plv8> server # [ 12.095809] postgres[851]: returns jsonb vm-test-run-plv8> server # [ 12.096669] postgres[851]: language plpgsql vm-test-run-plv8> server # [ 12.097390] postgres[851]: as $$ vm-test-run-plv8> server # [ 12.098107] postgres[851]: DECLARE vm-test-run-plv8> server # [ 12.098795] postgres[851]: server_version float; vm-test-run-plv8> server # [ 12.099650] postgres[851]: BEGIN vm-test-run-plv8> server # [ 12.100676] postgres[851]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 12.101445] postgres[851]: vm-test-run-plv8> server # [ 12.101991] postgres[851]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 12.102666] postgres[851]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 12.103488] postgres[851]: 'data', null::jsonb, vm-test-run-plv8> server # [ 12.104069] postgres[851]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 12.104592] postgres[851]: ); vm-test-run-plv8> server # [ 12.105190] postgres[851]: ELSE vm-test-run-plv8> server # [ 12.105702] postgres[851]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 12.106523] postgres[851]: 'data', null::jsonb, vm-test-run-plv8> server # [ 12.107133] postgres[851]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 12.107641] postgres[851]: ); vm-test-run-plv8> server # [ 12.108335] postgres[851]: END IF; vm-test-run-plv8> server # [ 12.108882] postgres[851]: END; vm-test-run-plv8> server # [ 12.109565] postgres[851]: $$; vm-test-run-plv8> server # [ 12.110150] postgres[851]: END IF; vm-test-run-plv8> server # [ 12.110664] postgres[851]: vm-test-run-plv8> server # [ 12.111488] postgres[851]: END; vm-test-run-plv8> server # [ 12.112066] postgres[851]: $func$; vm-test-run-plv8> server # [ 12.112595] postgres[851]: ::1 2026-10-07 00:03:09.679 UTC [851] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-plv8> server # [ 12.113057] postgres[851]: ::1 2026-10-07 00:03:09.679 UTC [851] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-plv8> server # [ 12.113557] postgres[851]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-plv8> server # [ 12.113986] postgres[851]: ::1 2026-10-07 00:03:09.679 UTC [851] 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 # [ 12.114651] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[852]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-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 # [ 12.115232] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[852]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 12.115731] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[852]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-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 # [ 12.116424] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[852]: DROP FUNCTION vm-test-run-plv8> server # [ 12.116841] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[852]: CREATE FUNCTION vm-test-run-plv8> server # [ 12.117402] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[852]: CREATE FUNCTION vm-test-run-plv8> server # [ 12.117823] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[852]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 12.118382] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[852]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 12.118922] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[852]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 12.119467] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[852]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 12.119979] postgres[853]: ::1 2026-10-07 00:03:09.702 UTC [853] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 12.120452] postgres[853]: ::1 2026-10-07 00:03:09.702 UTC [853] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 12.120869] postgres[853]: ::1 2026-10-07 00:03:09.703 UTC [853] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 12.121424] postgres[853]: DECLARE vm-test-run-plv8> server # [ 12.122116] postgres[853]: cmd record; vm-test-run-plv8> server # [ 12.122647] postgres[853]: BEGIN vm-test-run-plv8> server # [ 12.123479] postgres[853]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 12.124195] postgres[853]: LOOP vm-test-run-plv8> server # [ 12.124713] postgres[853]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 12.125552] postgres[853]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 12.126261] postgres[853]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 12.126948] postgres[853]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 12.127621] postgres[853]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 12.128516] postgres[853]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 12.129378] postgres[853]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 12.130143] postgres[853]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 12.130665] postgres[853]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-plv8> server # [ 12.131557] postgres[853]: , 'CREATE RULE' vm-test-run-plv8> server # [ 12.132143] postgres[853]: , 'COMMENT' vm-test-run-plv8> server # [ 12.132674] postgres[853]: ) vm-test-run-plv8> server # [ 12.133409] postgres[853]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 12.133973] postgres[853]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 12.134670] postgres[853]: THEN vm-test-run-plv8> server # [ 12.135351] postgres[853]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 12.135855] postgres[853]: END IF; vm-test-run-plv8> server # [ 12.136547] postgres[853]: END LOOP; vm-test-run-plv8> server # [ 12.137384] postgres[853]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 12.138101] postgres[853]: ::1 2026-10-07 00:03:09.705 UTC [853] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 12.138628] postgres[853]: DECLARE vm-test-run-plv8> server # [ 12.139359] postgres[853]: obj record; vm-test-run-plv8> server # [ 12.140108] postgres[853]: BEGIN vm-test-run-plv8> server # [ 12.140756] postgres[853]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 12.141475] postgres[853]: LOOP vm-test-run-plv8> server # [ 12.142078] postgres[853]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 12.142752] postgres[853]: 'schema' vm-test-run-plv8> server # [ 12.143331] postgres[853]: , 'table' vm-test-run-plv8> server # [ 12.143891] postgres[853]: , 'foreign table' vm-test-run-plv8> server # [ 12.144483] postgres[853]: , 'view' vm-test-run-plv8> server # [ 12.145212] postgres[853]: , 'materialized view' vm-test-run-plv8> server # [ 12.145890] postgres[853]: , 'function' vm-test-run-plv8> server # [ 12.146645] postgres[853]: , 'trigger' vm-test-run-plv8> server # [ 12.147345] postgres[853]: , 'type' vm-test-run-plv8> server # [ 12.148034] postgres[853]: , 'rule' vm-test-run-plv8> server # [ 12.148639] postgres[853]: ) vm-test-run-plv8> server # [ 12.149344] postgres[853]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 12.149991] postgres[853]: THEN vm-test-run-plv8> server # [ 12.150670] postgres[853]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 12.151479] postgres[853]: END IF; vm-test-run-plv8> server # [ 12.152196] postgres[853]: END LOOP; vm-test-run-plv8> server # [ 12.152838] postgres[853]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 12.153510] postgres[853]: ::1 2026-10-07 00:03:09.706 UTC [853] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 12.154085] postgres[853]: ::1 2026-10-07 00:03:09.707 UTC [853] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 12.154620] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-plv8> server # [ 12.155270] postgres[853]: ON ddl_command_end vm-test-run-plv8> server # [ 12.155924] postgres[853]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 12.156598] postgres[853]: ::1 2026-10-07 00:03:09.707 UTC [853] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 12.157044] postgres[853]: ::1 2026-10-07 00:03:09.708 UTC [853] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 12.157549] postgres[853]: ON sql_drop vm-test-run-plv8> server # [ 12.158141] postgres[853]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 12.178484] postgres[855]: ::1 2026-10-07 00:03:09.861 UTC [855] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-plv8> server # [ 12.182357] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[854]: ALTER ROLE vm-test-run-plv8> server # [ 12.185930] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-plv8> server # [ 12.208411] postgres[863]: ::1 2026-10-07 00:03:09.891 UTC [863] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 12.209067] postgres[863]: returns event_trigger vm-test-run-plv8> server # [ 12.209626] postgres[863]: language plpgsql vm-test-run-plv8> server # [ 12.212154] postgres[863]: AS $func$ vm-test-run-plv8> server # [ 12.212692] postgres[863]: DECLARE vm-test-run-plv8> server # [ 12.213205] postgres[863]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 12.214047] postgres[863]: BEGIN vm-test-run-plv8> server # [ 12.214482] postgres[863]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 12.215165] postgres[863]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 12.215923] postgres[863]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 12.216907] postgres[863]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 12.217935] postgres[863]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 12.218692] postgres[863]: ); vm-test-run-plv8> server # [ 12.219341] postgres[863]: vm-test-run-plv8> server # [ 12.219874] postgres[863]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 12.220657] postgres[863]: THEN vm-test-run-plv8> server # [ 12.221191] postgres[863]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.222510] postgres[863]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.223677] postgres[863]: vm-test-run-plv8> server # [ 12.224200] postgres[863]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.225975] postgres[863]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.228345] postgres[863]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.229149] postgres[863]: vm-test-run-plv8> server # [ 12.229788] postgres[863]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 12.230494] postgres[863]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 12.231121] postgres[863]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 12.231764] postgres[863]: "operationName" text default null, vm-test-run-plv8> server # [ 12.232583] postgres[863]: query text default null, vm-test-run-plv8> server # [ 12.233396] postgres[863]: variables jsonb default null, vm-test-run-plv8> server # [ 12.234673] postgres[863]: extensions jsonb default null vm-test-run-plv8> server # [ 12.235570] postgres[863]: ) vm-test-run-plv8> server # [ 12.236149] postgres[863]: returns jsonb vm-test-run-plv8> server # [ 12.236679] postgres[863]: language sql vm-test-run-plv8> server # [ 12.237170] postgres[863]: as $$ vm-test-run-plv8> server # [ 12.237760] postgres[863]: -- This changed vm-test-run-plv8> server # [ 12.238640] postgres[863]: select graphql.resolve( vm-test-run-plv8> server # [ 12.239586] postgres[863]: query := query, vm-test-run-plv8> server # [ 12.240467] postgres[863]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 12.241449] postgres[863]: "operationName" := "operationName", vm-test-run-plv8> server # [ 12.242399] postgres[863]: extensions := extensions vm-test-run-plv8> server # [ 12.243176] postgres[863]: ); vm-test-run-plv8> server # [ 12.243682] postgres[863]: $$; vm-test-run-plv8> server # [ 12.244421] postgres[863]: vm-test-run-plv8> server # [ 12.244952] postgres[863]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.245724] postgres[863]: END IF; vm-test-run-plv8> server # [ 12.246736] postgres[863]: vm-test-run-plv8> server # [ 12.247250] postgres[863]: END; vm-test-run-plv8> server # [ 12.247844] postgres[863]: $func$; vm-test-run-plv8> server # [ 12.248480] postgres[863]: ::1 2026-10-07 00:03:09.899 UTC [863] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 12.249056] postgres[863]: RETURNS event_trigger vm-test-run-plv8> server # [ 12.249728] postgres[863]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 12.250551] postgres[863]: AS $func$ vm-test-run-plv8> server # [ 12.251393] postgres[863]: DECLARE vm-test-run-plv8> server # [ 12.252090] postgres[863]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 12.252845] postgres[863]: BEGIN vm-test-run-plv8> server # [ 12.253397] postgres[863]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 12.254169] postgres[863]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 12.254965] postgres[863]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 12.255842] postgres[863]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 12.256670] postgres[863]: ); vm-test-run-plv8> server # [ 12.257190] postgres[863]: vm-test-run-plv8> server # [ 12.257663] postgres[863]: IF graphql_is_dropped vm-test-run-plv8> server # [ 12.258489] postgres[863]: THEN vm-test-run-plv8> server # [ 12.259073] postgres[863]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 12.259939] postgres[863]: "operationName" text default null, vm-test-run-plv8> server # [ 12.261161] postgres[863]: query text default null, vm-test-run-plv8> server # [ 12.262843] postgres[863]: variables jsonb default null, vm-test-run-plv8> server # [ 12.263723] postgres[863]: extensions jsonb default null vm-test-run-plv8> server # [ 12.264538] postgres[863]: ) vm-test-run-plv8> server # [ 12.265154] postgres[863]: returns jsonb vm-test-run-plv8> server # [ 12.265861] postgres[863]: language plpgsql vm-test-run-plv8> server # [ 12.266621] postgres[863]: as $$ vm-test-run-plv8> server # [ 12.267261] postgres[863]: DECLARE vm-test-run-plv8> server # [ 12.267952] postgres[863]: server_version float; vm-test-run-plv8> server # [ 12.269211] postgres[863]: BEGIN vm-test-run-plv8> server # [ 12.270078] postgres[863]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 12.271036] postgres[863]: vm-test-run-plv8> server # [ 12.271725] postgres[863]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 12.272900] postgres[863]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 12.274255] postgres[863]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 12.275173] postgres[863]: jsonb_build_object( vm-test-run-plv8> server # [ 12.276358] postgres[863]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 12.277464] postgres[863]: ) vm-test-run-plv8> server # [ 12.278451] postgres[863]: ) vm-test-run-plv8> server # [ 12.279183] postgres[863]: ); vm-test-run-plv8> server # [ 12.279865] postgres[863]: ELSE vm-test-run-plv8> server # [ 12.282216] postgres[863]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 12.283176] postgres[863]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 12.284077] postgres[863]: jsonb_build_object( vm-test-run-plv8> server # [ 12.284851] postgres[863]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 12.285731] postgres[863]: ) vm-test-run-plv8> server # [ 12.286613] postgres[863]: ) vm-test-run-plv8> server # [ 12.287365] postgres[863]: ); vm-test-run-plv8> server # [ 12.287990] postgres[863]: END IF; vm-test-run-plv8> server # [ 12.288755] postgres[863]: END; vm-test-run-plv8> server # [ 12.289456] postgres[863]: $$; vm-test-run-plv8> server # [ 12.290066] postgres[863]: END IF; vm-test-run-plv8> server # [ 12.290653] postgres[863]: vm-test-run-plv8> server # [ 12.291315] postgres[863]: END; vm-test-run-plv8> server # [ 12.291885] postgres[863]: $func$; vm-test-run-plv8> server # [ 12.292472] postgres[863]: ::1 2026-10-07 00:03:09.901 UTC [863] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 12.292947] postgres[863]: "operationName" text default null, vm-test-run-plv8> server # [ 12.293652] postgres[863]: query text default null, vm-test-run-plv8> server # [ 12.294165] postgres[863]: variables jsonb default null, vm-test-run-plv8> server # [ 12.295163] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[860]: CREATE FUNCTION vm-test-run-plv8> server # [ 12.295852] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[860]: CREATE FUNCTION vm-test-run-plv8> server # [ 12.296517] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[860]: CREATE FUNCTION vm-test-run-plv8> server # [ 12.297045] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[860]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping vm-test-run-plv8> server # [ 12.297514] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[860]: DROP EXTENSION vm-test-run-plv8> server # [ 12.298095] postgres[863]: extensions jsonb default null vm-test-run-plv8> server # [ 12.298704] postgres[863]: ) vm-test-run-plv8> server # [ 12.299313] postgres[863]: returns jsonb vm-test-run-plv8> server # [ 12.299860] postgres[863]: language plpgsql vm-test-run-plv8> server # [ 12.300543] postgres[863]: as $$ vm-test-run-plv8> server # [ 12.301186] postgres[863]: DECLARE vm-test-run-plv8> server # [ 12.301757] postgres[863]: server_version float; vm-test-run-plv8> server # [ 12.302300] postgres[863]: BEGIN vm-test-run-plv8> server # [ 12.302913] postgres[863]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 12.303695] postgres[863]: vm-test-run-plv8> server # [ 12.304395] postgres[863]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 12.304942] postgres[863]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 12.305668] postgres[863]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 12.306380] postgres[863]: jsonb_build_object( vm-test-run-plv8> server # [ 12.307096] postgres[863]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 12.307705] postgres[863]: ) vm-test-run-plv8> server # [ 12.308670] postgres[863]: ) vm-test-run-plv8> server # [ 12.309404] postgres[863]: ); vm-test-run-plv8> server # [ 12.309955] postgres[863]: ELSE vm-test-run-plv8> server # [ 12.310636] postgres[863]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 12.311339] postgres[863]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 12.311895] postgres[863]: jsonb_build_object( vm-test-run-plv8> server # [ 12.312485] postgres[863]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 12.313073] postgres[863]: ) vm-test-run-plv8> server # [ 12.313616] postgres[863]: ) vm-test-run-plv8> server # [ 12.314350] postgres[863]: ); vm-test-run-plv8> server # [ 12.314931] postgres[863]: END IF; vm-test-run-plv8> server # [ 12.315785] postgres[863]: END; vm-test-run-plv8> server # [ 12.316467] postgres[863]: $$; vm-test-run-plv8> server # [ 12.317183] postgres[863]: ::1 2026-10-07 00:03:09.903 UTC [863] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 12.517371] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[860]: DO vm-test-run-plv8> server # [ 12.521929] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql vm-test-run-plv8> server # [ 12.542367] postgres[868]: ::1 2026-10-07 00:03:10.225 UTC [868] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-plv8> server # [ 12.544513] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[867]: GRANT ROLE vm-test-run-plv8> server # [ 12.547760] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-plv8> server # [ 12.566166] postgres[870]: ::1 2026-10-07 00:03:10.248 UTC [870] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 12.566410] postgres[870]: returns event_trigger vm-test-run-plv8> server # [ 12.566509] postgres[870]: language plpgsql vm-test-run-plv8> server # [ 12.566591] postgres[870]: AS $func$ vm-test-run-plv8> server # [ 12.566670] postgres[870]: DECLARE vm-test-run-plv8> server # [ 12.566759] postgres[870]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 12.566848] postgres[870]: BEGIN vm-test-run-plv8> server # [ 12.566927] postgres[870]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 12.567034] postgres[870]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 12.567116] postgres[870]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 12.567195] postgres[870]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 12.567274] postgres[870]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 12.567353] postgres[870]: ); vm-test-run-plv8> server # [ 12.567431] postgres[870]: vm-test-run-plv8> server # [ 12.567517] postgres[870]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 12.567595] postgres[870]: THEN vm-test-run-plv8> server # [ 12.567675] postgres[870]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 12.567764] postgres[870]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 12.567844] postgres[870]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 12.567923] postgres[870]: "operationName" text default null, vm-test-run-plv8> server # [ 12.568026] postgres[870]: query text default null, vm-test-run-plv8> server # [ 12.568116] postgres[870]: variables jsonb default null, vm-test-run-plv8> server # [ 12.568198] postgres[870]: extensions jsonb default null vm-test-run-plv8> server # [ 12.568277] postgres[870]: ) vm-test-run-plv8> server # [ 12.568356] postgres[870]: returns jsonb vm-test-run-plv8> server # [ 12.568435] postgres[870]: language sql vm-test-run-plv8> server # [ 12.568513] postgres[870]: as $$ vm-test-run-plv8> server # [ 12.568590] postgres[870]: select graphql.resolve( vm-test-run-plv8> server # [ 12.568672] postgres[870]: query := query, vm-test-run-plv8> server # [ 12.568789] postgres[870]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 12.569840] postgres[870]: "operationName" := "operationName", vm-test-run-plv8> server # [ 12.570674] postgres[870]: extensions := extensions vm-test-run-plv8> server # [ 12.571507] postgres[870]: ); vm-test-run-plv8> server # [ 12.572208] postgres[870]: $$; vm-test-run-plv8> server # [ 12.572848] postgres[870]: vm-test-run-plv8> server # [ 12.573674] postgres[870]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 12.574531] postgres[870]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 12.575223] postgres[870]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 12.575879] postgres[870]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.576541] postgres[870]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.577249] postgres[870]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.577906] postgres[870]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.578697] postgres[870]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.579410] postgres[870]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.580095] postgres[870]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 12.580736] postgres[870]: END IF; vm-test-run-plv8> server # [ 12.581586] postgres[870]: vm-test-run-plv8> server # [ 12.582436] postgres[870]: END; vm-test-run-plv8> server # [ 12.583144] postgres[870]: $func$; vm-test-run-plv8> server # [ 12.606039] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[869]: CREATE FUNCTION vm-test-run-plv8> server # [ 12.607316] postgres[870]: ::1 2026-10-07 00:03:10.289 UTC [870] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 12.609197] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[869]: DROP EXTENSION vm-test-run-plv8> server # [ 12.776858] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[869]: DO vm-test-run-plv8> server # [ 12.780081] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-plv8> server # [ 12.904331] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[871]: DO vm-test-run-plv8> server # [ 12.990157] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[871]: DO vm-test-run-plv8> server # [ 12.993291] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-plv8> server # [ 13.010719] postgres[874]: ::1 2026-10-07 00:03:10.693 UTC [874] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-plv8> server # [ 13.012971] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[873]: ALTER ROLE vm-test-run-plv8> server # [ 13.015981] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-plv8> server # [ 13.034182] postgres[876]: ::1 2026-10-07 00:03:10.717 UTC [876] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-plv8> server # [ 13.036300] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[875]: REVOKE ROLE vm-test-run-plv8> server # [ 13.039173] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-plv8> server # [ 13.296738] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[877]: DO vm-test-run-plv8> server # [ 13.304029] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-plv8> server # [ 13.323627] postgres[884]: ::1 2026-10-07 00:03:11.006 UTC [884] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-plv8> server # [ 13.325500] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[883]: GRANT ROLE vm-test-run-plv8> server # [ 13.328123] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-plv8> server # [ 13.343494] postgres[886]: ::1 2026-10-07 00:03:11.026 UTC [886] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 13.345858] postgres[886]: ::1 2026-10-07 00:03:11.028 UTC [886] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 13.348531] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[885]: GRANT vm-test-run-plv8> server # [ 13.349394] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[885]: GRANT vm-test-run-plv8> server # [ 13.350302] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[885]: GRANT vm-test-run-plv8> server # [ 13.351333] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[885]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 13.352784] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[885]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 13.354217] postgres[886]: ::1 2026-10-07 00:03:11.030 UTC [886] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 13.357163] postgres[886]: ::1 2026-10-07 00:03:11.030 UTC [886] 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 # [ 13.359645] postgres[886]: ::1 2026-10-07 00:03:11.031 UTC [886] 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 # [ 13.361705] postgres[886]: ::1 2026-10-07 00:03:11.031 UTC [886] 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 # [ 13.363898] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[885]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 13.365093] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-plv8> server # [ 13.373385] postgres[888]: ::1 2026-10-07 00:03:11.056 UTC [888] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-plv8> server # [ 13.375538] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[887]: GRANT ROLE vm-test-run-plv8> server # [ 13.379433] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 13.398563] postgres[890]: ::1 2026-10-07 00:03:11.081 UTC [890] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-plv8> server # [ 13.400474] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[889]: GRANT ROLE vm-test-run-plv8> server # [ 13.404110] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-plv8> server # [ 13.422234] postgres[892]: ::1 2026-10-07 00:03:11.105 UTC [892] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-plv8> server # [ 13.424368] postgres[892]: ::1 2026-10-07 00:03:11.106 UTC [892] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-plv8> server # [ 13.426131] postgres[892]: ::1 2026-10-07 00:03:11.107 UTC [892] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-plv8> server # [ 13.426918] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[891]: ALTER ROLE vm-test-run-plv8> server # [ 13.427458] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[891]: ALTER ROLE vm-test-run-plv8> server # [ 13.427877] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[891]: ALTER ROLE vm-test-run-plv8> server # [ 13.428551] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[891]: DO vm-test-run-plv8> server # [ 13.432418] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 13.449731] postgres[894]: ::1 2026-10-07 00:03:11.133 UTC [894] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-plv8> server # [ 13.451433] postgres[894]: ::1 2026-10-07 00:03:11.134 UTC [894] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-plv8> server # [ 13.452184] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[893]: GRANT ROLE vm-test-run-plv8> server # [ 13.452701] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[893]: REVOKE ROLE vm-test-run-plv8> server # [ 13.456698] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-plv8> server # [ 13.477186] postgres[896]: ::1 2026-10-07 00:03:11.160 UTC [896] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 13.479219] postgres[896]: returns event_trigger vm-test-run-plv8> server # [ 13.479957] postgres[896]: language plpgsql vm-test-run-plv8> server # [ 13.480581] postgres[896]: AS $func$ vm-test-run-plv8> server # [ 13.481236] postgres[896]: DECLARE vm-test-run-plv8> server # [ 13.481826] postgres[896]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 13.482637] postgres[896]: BEGIN vm-test-run-plv8> server # [ 13.483238] postgres[896]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 13.484369] postgres[896]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 13.485135] postgres[896]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 13.486102] postgres[896]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 13.486923] postgres[896]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 13.487733] postgres[896]: ); vm-test-run-plv8> server # [ 13.488291] postgres[896]: vm-test-run-plv8> server # [ 13.488840] postgres[896]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 13.489521] postgres[896]: THEN vm-test-run-plv8> server # [ 13.490063] postgres[896]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 13.490789] postgres[896]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 13.491486] postgres[896]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 13.492148] postgres[896]: "operationName" text default null, vm-test-run-plv8> server # [ 13.492821] postgres[896]: query text default null, vm-test-run-plv8> server # [ 13.493506] postgres[896]: variables jsonb default null, vm-test-run-plv8> server # [ 13.494614] postgres[896]: extensions jsonb default null vm-test-run-plv8> server # [ 13.495652] postgres[896]: ) vm-test-run-plv8> server # [ 13.496572] postgres[896]: returns jsonb vm-test-run-plv8> server # [ 13.497471] postgres[896]: language sql vm-test-run-plv8> server # [ 13.498231] postgres[896]: as $$ vm-test-run-plv8> server # [ 13.498871] postgres[896]: select graphql.resolve( vm-test-run-plv8> server # [ 13.499703] postgres[896]: query := query, vm-test-run-plv8> server # [ 13.500559] postgres[896]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 13.501433] postgres[896]: "operationName" := "operationName", vm-test-run-plv8> server # [ 13.502452] postgres[896]: extensions := extensions vm-test-run-plv8> server # [ 13.503382] postgres[896]: ); vm-test-run-plv8> server # [ 13.504060] postgres[896]: $$; vm-test-run-plv8> server # [ 13.504668] postgres[896]: vm-test-run-plv8> server # [ 13.505200] postgres[896]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 13.506304] postgres[896]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 13.506999] postgres[896]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 13.507721] postgres[896]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.508789] postgres[896]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.509703] postgres[896]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.510645] postgres[896]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.511595] postgres[896]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.512032] postgres[896]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.512710] postgres[896]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 13.513634] postgres[896]: vm-test-run-plv8> server # [ 13.514493] postgres[896]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-plv8> server # [ 13.515453] postgres[896]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-plv8> server # [ 13.516254] postgres[896]: grant usage on schema graphql to postgres with grant option; vm-test-run-plv8> server # [ 13.516969] postgres[896]: END IF; vm-test-run-plv8> server # [ 13.517891] postgres[896]: vm-test-run-plv8> server # [ 13.518830] postgres[896]: END; vm-test-run-plv8> server # [ 13.519821] postgres[896]: $func$; vm-test-run-plv8> server # [ 13.520532] postgres[896]: ::1 2026-10-07 00:03:11.164 UTC [896] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 13.521550] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[895]: CREATE FUNCTION vm-test-run-plv8> server # [ 13.522223] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[895]: DROP EXTENSION vm-test-run-plv8> server # [ 13.690189] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[895]: DO vm-test-run-plv8> server # [ 13.695601] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-plv8> server # [ 13.713158] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[897]: DO vm-test-run-plv8> server # [ 13.714084] postgres[898]: ::1 2026-10-07 00:03:11.396 UTC [898] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-plv8> server # [ 13.714654] postgres[898]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 13.715427] postgres[898]: AS $$ vm-test-run-plv8> server # [ 13.716087] postgres[898]: BEGIN vm-test-run-plv8> server # [ 13.716637] postgres[898]: IF EXISTS ( vm-test-run-plv8> server # [ 13.717466] postgres[898]: SELECT vm-test-run-plv8> server # [ 13.718174] postgres[898]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 13.719192] postgres[898]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 13.719948] postgres[898]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 13.720726] postgres[898]: WHERE ext.extname = 'pg_cron' vm-test-run-plv8> server # [ 13.721547] postgres[898]: ) vm-test-run-plv8> server # [ 13.722112] postgres[898]: THEN vm-test-run-plv8> server # [ 13.722697] postgres[898]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 13.723671] postgres[898]: vm-test-run-plv8> server # [ 13.724336] postgres[898]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 13.725412] postgres[898]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 13.726108] postgres[898]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 13.726763] postgres[898]: vm-test-run-plv8> server # [ 13.727599] postgres[898]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 13.728505] postgres[898]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 13.729522] postgres[898]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 13.730141] postgres[898]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 13.730654] postgres[898]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 13.731480] postgres[898]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 13.732143] postgres[898]: vm-test-run-plv8> server # [ 13.732656] postgres[898]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 13.733373] postgres[898]: revoke all on table cron.job from postgres; vm-test-run-plv8> server # [ 13.733921] postgres[898]: grant select on table cron.job to postgres with grant option; vm-test-run-plv8> server # [ 13.734616] postgres[898]: END IF; vm-test-run-plv8> server # [ 13.735306] postgres[898]: END; vm-test-run-plv8> server # [ 13.735849] postgres[898]: $$; vm-test-run-plv8> server # [ 13.740075] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[897]: CREATE FUNCTION vm-test-run-plv8> server # [ 13.741079] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[897]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 13.742116] postgres[898]: ::1 2026-10-07 00:03:11.423 UTC [898] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-plv8> server # [ 13.743568] postgres[898]: ::1 2026-10-07 00:03:11.424 UTC [898] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-plv8> server # [ 13.745253] postgres[898]: ::1 2026-10-07 00:03:11.424 UTC [898] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-plv8> server # [ 13.747675] postgres[898]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-plv8> server # [ 13.748653] postgres[898]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 13.749473] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[897]: ALTER FUNCTION vm-test-run-plv8> server # [ 13.750051] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[897]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 13.750572] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-plv8> server # [ 13.773873] postgres[900]: ::1 2026-10-07 00:03:11.456 UTC [900] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-plv8> server # [ 13.776085] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[899]: ALTER ROLE vm-test-run-plv8> server # [ 13.780069] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-plv8> server # [ 13.803598] postgres[902]: ::1 2026-10-07 00:03:11.486 UTC [902] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-plv8> server # [ 13.805367] postgres[902]: ::1 2026-10-07 00:03:11.488 UTC [902] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-plv8> server # [ 13.807276] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[901]: ALTER FUNCTION vm-test-run-plv8> server # [ 13.808116] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[901]: ALTER FUNCTION vm-test-run-plv8> server # [ 13.809250] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[901]: ALTER FUNCTION vm-test-run-plv8> server # [ 13.809778] postgres[902]: ::1 2026-10-07 00:03:11.488 UTC [902] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-plv8> server # [ 13.812737] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-plv8> server # [ 13.834951] postgres[904]: ::1 2026-10-07 00:03:11.518 UTC [904] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-plv8> server # [ 13.837448] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[903]: GRANT ROLE vm-test-run-plv8> server # [ 13.845309] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-plv8> server # [ 13.948418] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[905]: DO vm-test-run-plv8> server # [ 13.952787] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-plv8> server # [ 13.972979] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[907]: DO vm-test-run-plv8> server # [ 13.974051] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[907]: DO vm-test-run-plv8> server # [ 13.976411] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-plv8> server # [ 13.994721] postgres[910]: ::1 2026-10-07 00:03:11.677 UTC [910] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-plv8> server # [ 13.996986] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[909]: ALTER ROLE vm-test-run-plv8> server # [ 13.998219] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[909]: ALTER ROLE vm-test-run-plv8> server # [ 13.999307] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[909]: ALTER ROLE vm-test-run-plv8> server # [ 14.000334] postgres[910]: ::1 2026-10-07 00:03:11.680 UTC [910] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-plv8> server # [ 14.002961] postgres[910]: ::1 2026-10-07 00:03:11.680 UTC [910] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-plv8> server # [ 14.005620] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-plv8> server # [ 14.023283] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[911]: DO vm-test-run-plv8> server # [ 14.026862] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-plv8> server # [ 14.048781] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[913]: DO vm-test-run-plv8> server # [ 14.053151] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-plv8> server # [ 14.074786] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[915]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.075718] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[915]: DO vm-test-run-plv8> server # [ 14.078395] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-plv8> server # [ 14.096275] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[917]: ALTER FUNCTION vm-test-run-plv8> server # [ 14.097283] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[917]: GRANT vm-test-run-plv8> server # [ 14.100217] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-plv8> server # [ 14.116761] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[919]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 14.118988] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[919]: ALTER FUNCTION vm-test-run-plv8> server # [ 14.119979] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[919]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 14.122497] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 14.138281] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[921]: DO vm-test-run-plv8> server # [ 14.141067] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-plv8> server # [ 14.163969] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[923]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.165130] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[923]: GRANT vm-test-run-plv8> server # [ 14.167650] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-plv8> server # [ 14.186144] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[925]: REVOKE ROLE vm-test-run-plv8> server # [ 14.189162] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[925]: DO vm-test-run-plv8> server # [ 14.190038] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[925]: DO vm-test-run-plv8> server # [ 14.190928] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[925]: REVOKE ROLE vm-test-run-plv8> server # [ 14.191857] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[925]: REVOKE vm-test-run-plv8> server # [ 14.192714] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[925]: DO vm-test-run-plv8> server # [ 14.195223] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 14.211283] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[927]: DO vm-test-run-plv8> server # [ 14.214133] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 14.234103] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[929]: DO vm-test-run-plv8> server # [ 14.236774] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 14.255118] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[931]: DO vm-test-run-plv8> server # [ 14.258104] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-plv8> server # [ 14.276456] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[933]: ALTER ROLE vm-test-run-plv8> server # [ 14.280093] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-plv8> server # [ 14.299388] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[935]: GRANT ROLE vm-test-run-plv8> server # [ 14.301168] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[935]: DO vm-test-run-plv8> server # [ 14.303754] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-plv8> server # [ 14.325780] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[941]: GRANT vm-test-run-plv8> server # [ 14.328084] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-plv8> server # [ 14.345891] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[943]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.347076] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[943]: REVOKE vm-test-run-plv8> server # [ 14.348079] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[943]: REVOKE vm-test-run-plv8> server # [ 14.349033] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[943]: GRANT vm-test-run-plv8> server # [ 14.351695] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-plv8> server # [ 14.370691] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[945]: DO vm-test-run-plv8> server # [ 14.372887] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-plv8> server # [ 14.389050] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[947]: ALTER ROLE vm-test-run-plv8> server # [ 14.391700] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-plv8> server # [ 14.410136] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[949]: DROP EXTENSION vm-test-run-plv8> server # [ 14.414463] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-plv8> server # [ 14.431113] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[951]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.432527] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[951]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 14.433839] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[951]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 14.440975] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-plv8> server # [ 14.464085] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[953]: DO vm-test-run-plv8> server # [ 14.466549] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[953]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.469874] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-plv8> server # [ 14.487349] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[955]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.488862] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[955]: CREATE FUNCTION vm-test-run-plv8> server # [ 14.492144] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Running postgresql schema... vm-test-run-plv8> server # [ 14.511092] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER DATABASE vm-test-run-plv8> server # [ 14.512191] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER DATABASE vm-test-run-plv8> server # [ 14.515111] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER ROLE vm-test-run-plv8> server # [ 14.518925] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER ROLE vm-test-run-plv8> server # [ 14.522030] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER ROLE vm-test-run-plv8> server # [ 14.525761] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER ROLE vm-test-run-plv8> server # [ 14.528835] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER ROLE vm-test-run-plv8> server # [ 14.532739] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER ROLE vm-test-run-plv8> server # [ 14.536590] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER ROLE vm-test-run-plv8> server # [ 14.540398] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER ROLE vm-test-run-plv8> server # [ 14.544241] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER ROLE vm-test-run-plv8> server # [ 14.545497] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[957]: ALTER ROLE vm-test-run-plv8> server # [ 14.548142] k19l9axs9n58r72mv404wmpgczg40xh2-supabase-db-init[806]: Database initialization complete vm-test-run-plv8> server # [ 14.550952] systemd[1]: Finished Supabase Database Initialization. vm-test-run-plv8> server # [ 14.693169] dhcpcd[723]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-plv8> server # [ 14.693808] dhcpcd[723]: eth0: adding route to 10.0.2.0/24 vm-test-run-plv8> server # [ 14.694351] dhcpcd[723]: eth0: adding default route via 10.0.2.2 vm-test-run-plv8> server # [ 14.778649] systemd[1]: Started DHCP Client. vm-test-run-plv8> server # [ 14.779750] systemd[1]: Reached target Multi-User System. vm-test-run-plv8> server # [ 14.780707] systemd[1]: Startup finished in 898ms (kernel) + 3.528s (initrd) + 10.353s (userspace) = 14.780s. vm-test-run-plv8> server: (finished: waiting for unit supabase-db-init.service, in 15.95 seconds) vm-test-run-plv8> subtest: Verify PostgreSQL 15 is our custom build vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT version();" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT version();", in 0.04 seconds) vm-test-run-plv8> server: must succeed: readlink -f $(which postgres) vm-test-run-plv8> server: (finished: must succeed: readlink -f $(which postgres), in 0.03 seconds) vm-test-run-plv8> (finished: subtest: Verify PostgreSQL 15 is our custom build, in 0.06 seconds) vm-test-run-plv8> subtest: Verify ansible config loaded vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW shared_preload_libraries;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW shared_preload_libraries;", in 0.03 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW session_preload_libraries;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW session_preload_libraries;", in 0.04 seconds) vm-test-run-plv8> (finished: subtest: Verify ansible config loaded, in 0.07 seconds) vm-test-run-plv8> subtest: Verify init scripts and migrations ran vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT rolname FROM pg_roles ORDER BY rolname;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT rolname FROM pg_roles ORDER BY rolname;", in 0.03 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT schema_name FROM information_schema.schemata ORDER BY schema_name;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT schema_name FROM information_schema.schemata ORDER BY schema_name;", in 0.03 seconds) vm-test-run-plv8> (finished: subtest: Verify init scripts and migrations ran, in 0.06 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.03 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.63 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.04 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.03 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.54 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.03 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.03 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.53 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.03 seconds) vm-test-run-plv8> (finished: subtest: Check upgrade path with postgresql 15, in 1.90 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.03 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.24 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.03 seconds) vm-test-run-plv8> (finished: subtest: Check the install of the last version of the extension, in 0.30 seconds) vm-test-run-plv8> (finished: run the VM test script, in 18.47 seconds) vm-test-run-plv8> test script finished in 18.51s vm-test-run-plv8> cleanup vm-test-run-plv8> kill QemuMachine (pid 13) vm-test-run-plv8> server # qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/9r02ykx9y35lf4gk6gc30gnag1y8ncp7-python3-3.13.15/bin/python3.13) vm-test-run-plv8> (finished: cleanup, in 0.20 seconds)