these 11 derivations will be built: /nix/store/b09fbs7736p2x0s4zcg13nw1bk03x59i-postgresql-init.drv /nix/store/q7lvqwq8cf3y7qhan8rxr3c519nq1ghh-unit-postgresql.service.drv /nix/store/giynynysvmvqxvyiwy2ssk6smvrhh69d-system-units.drv /nix/store/x6dx8z8vwlhny02plf4bf7hhbxh8cq5d-etc.drv /nix/store/rqid4mrrwrh4pxfvw7q8wqzrq7wx9z8r-activate.drv /nix/store/1nkry5cx8d9p5zpqa727gifdi7wfs7gx-nixos-system-server-test.drv /nix/store/gr6zjc9r6x5qjnnffvmvq15ixdl8ji5x-closure-info.drv /nix/store/ml429p3nlxdwqacvqdbrmw1c6g59s2m2-run-nixos-vm.drv /nix/store/k48qf7s1pv9nv1mj0bjffzw7pf8c704j-nixos-vm.drv /nix/store/xbq7nhvfv9ych2qpv2k9x4zvd2hcq452-nixos-test-driver-plv8.drv /nix/store/cjhi1izzc3my6c65yswbl9ghz45w69ln-vm-test-run-plv8.drv building '/nix/store/b09fbs7736p2x0s4zcg13nw1bk03x59i-postgresql-init.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/b09fbs7736p2x0s4zcg13nw1bk03x59i-postgresql-init.drv' building '/nix/store/xbq7nhvfv9ych2qpv2k9x4zvd2hcq452-nixos-test-driver-plv8.drv' on 'ssh-ng://nixbot-remote-build@62.210.193.142' building '/nix/store/xbq7nhvfv9ych2qpv2k9x4zvd2hcq452-nixos-test-driver-plv8.drv' nixos-test-driver-plv8> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-plv8> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-plv8> Success: no issues found in 1 source file nixos-test-driver-plv8> additionally exposed symbols: nixos-test-driver-plv8> , nixos-test-driver-plv8> , nixos-test-driver-plv8> start_all, test_script, machines, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, Machine, t, debug nixos-test-driver-plv8> Linting test script (enable/disable: config.skipLint) nixos-test-driver-plv8> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint building '/nix/store/cjhi1izzc3my6c65yswbl9ghz45w69ln-vm-test-run-plv8.drv' on 'ssh-ng://nixbot-remote-build@62.210.193.142' building '/nix/store/cjhi1izzc3my6c65yswbl9ghz45w69ln-vm-test-run-plv8.drv' vm-test-run-plv8> Machine state will be reset. To keep it, pass --keep-vm-state vm-test-run-plv8> start all VLans vm-test-run-plv8> start vlan vm-test-run-plv8> running vlan (pid 87245; ctl /nix/var/nix/builds/nix-87236-752123540/vde1.ctl) vm-test-run-plv8> (finished: start all VLans, in 0.01 seconds) vm-test-run-plv8> Test will time out and terminate in 3600 seconds vm-test-run-plv8> run the VM test script vm-test-run-plv8> additionally exposed symbols: vm-test-run-plv8> server, vm-test-run-plv8> vlan1, vm-test-run-plv8> start_all, test_script, machines, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, Machine, t, debug vm-test-run-plv8> start all VMs vm-test-run-plv8> server: starting vm vm-test-run-plv8> mke2fs 1.47.3 (8-Jul-2025) vm-test-run-plv8> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-plv8> server # Formatting '/nix/var/nix/builds/nix-87236-752123540/vm-state-server/tmp.pPRwwNmAzl', fmt=raw size=1073741824 vm-test-run-plv8> server # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-plv8> server # Filesystem UUID: 72b59e35-5567-4e91-a21c-630ee13456aa vm-test-run-plv8> server # Superblock backups stored on blocks: vm-test-run-plv8> server # 32768, 98304, 163840, 229376 vm-test-run-plv8> server # vm-test-run-plv8> server # Allocating group tables: 0/8 done vm-test-run-plv8> server # Writing inode tables: 0/8 done vm-test-run-plv8> server # Creating journal (8192 blocks): done vm-test-run-plv8> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-plv8> server # vm-test-run-plv8> server # Virtualisation disk image created. vm-test-run-plv8> server: QEMU running (pid 87246) vm-test-run-plv8> (finished: start all VMs, in 0.97 seconds) vm-test-run-plv8> server: waiting for unit supabase-db-init.service vm-test-run-plv8> server: waiting for the VM to finish booting vm-test-run-plv8> server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x610f0000] vm-test-run-plv8> server # [ 0.000000] Linux version 6.12.63 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP Thu Dec 18 12:55:23 UTC 2025 vm-test-run-plv8> server # [ 0.000000] KASLR enabled vm-test-run-plv8> server # [ 0.000000] random: crng init done vm-test-run-plv8> server # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-plv8> server # [ 0.000000] efi: UEFI not found. vm-test-run-plv8> server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-plv8> server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f6032c0-0x13f6069ff] vm-test-run-plv8> server # [ 0.000000] Zone ranges: vm-test-run-plv8> server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] vm-test-run-plv8> server # [ 0.000000] DMA32 empty vm-test-run-plv8> server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] Device empty vm-test-run-plv8> server # [ 0.000000] Movable zone start for each node vm-test-run-plv8> server # [ 0.000000] Early memory node ranges vm-test-run-plv8> server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-plv8> server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -1 vm-test-run-plv8> server # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-plv8> server # [ 0.000000] psci: PSCIv1.1 detected in firmware. vm-test-run-plv8> server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-plv8> server # [ 0.000000] psci: Trusted OS migration not required vm-test-run-plv8> server # [ 0.000000] psci: SMC Calling Convention v1.0 vm-test-run-plv8> server # [ 0.000000] percpu: Embedded 88 pages/cpu s180056 r65536 d114856 u360448 vm-test-run-plv8> server # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-plv8> server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm) vm-test-run-plv8> server # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-plv8> server # [ 0.000000] CPU features: detected: Spectre-BHB vm-test-run-plv8> server # [ 0.000000] alternatives: applying boot alternatives vm-test-run-plv8> server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/chbagkpawjqlh05j53a09vh8fy1iy6cb-nixos-system-server-test/init regInfo=/nix/store/1n3blki3fkm915ils6n8xi74ckbw8lld-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-plv8> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/1n3blki3fkm915ils6n8xi74ckbw8lld-closure-info/registration", will be passed to user space. vm-test-run-plv8> server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-plv8> server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-plv8> server # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-plv8> server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 vm-test-run-plv8> server # [ 0.000000] Policy zone: Normal vm-test-run-plv8> server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-plv8> server # [ 0.000000] software IO TLB: area num 2. vm-test-run-plv8> server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) vm-test-run-plv8> server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm-test-run-plv8> server # [ 0.000000] allocated 8388608 bytes of page_ext vm-test-run-plv8> server # [ 0.000000] ftrace: allocating 72257 entries in 283 pages vm-test-run-plv8> server # [ 0.000000] ftrace: allocated 283 pages with 5 groups vm-test-run-plv8> server # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-plv8> server # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-plv8> server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. vm-test-run-plv8> server # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-plv8> server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-plv8> server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm-test-run-plv8> server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-plv8> server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-plv8> server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-plv8> server # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-plv8> server # [ 0.000000] GICv2m: range[mem 0x08020000-0x08020fff], SPI[80:143] vm-test-run-plv8> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-plv8> server # [ 0.000000] arch_timer: cp15 timer(s) running at 24.00MHz (virt). vm-test-run-plv8> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns vm-test-run-plv8> server # [ 0.000000] sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns vm-test-run-plv8> server # [ 0.000186] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-plv8> server # [ 0.000228] Console: colour dummy device 80x25 vm-test-run-plv8> server # [ 0.000230] printk: legacy console [tty0] enabled vm-test-run-plv8> server # [ 0.000277] Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000) vm-test-run-plv8> server # [ 0.000279] pid_max: default: 32768 minimum: 301 vm-test-run-plv8> server # [ 0.000313] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-plv8> server # [ 0.000369] landlock: Up and running. vm-test-run-plv8> server # [ 0.000370] Yama: becoming mindful. vm-test-run-plv8> server # [ 0.000564] LSM support for eBPF active vm-test-run-plv8> server # [ 0.000613] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.000622] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.000942] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-plv8> server # [ 0.001126] rcu: Hierarchical SRCU implementation. vm-test-run-plv8> server # [ 0.001128] rcu: Max phase no-delay instances is 1000. vm-test-run-plv8> server # [ 0.001161] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-plv8> server # [ 0.001465] EFI services will not be available. vm-test-run-plv8> server # [ 0.001491] smp: Bringing up secondary CPUs ... vm-test-run-plv8> server # [ 0.001780] Detected PIPT I-cache on CPU1 vm-test-run-plv8> server # [ 0.001913] CPU1: Booted secondary processor 0x0000000001 [0x610f0000] vm-test-run-plv8> server # [ 0.002063] smp: Brought up 1 node, 2 CPUs vm-test-run-plv8> server # [ 0.002067] SMP: Total of 2 processors activated. vm-test-run-plv8> server # [ 0.002068] CPU: All CPU(s) started at EL1 vm-test-run-plv8> server # [ 0.002071] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-plv8> server # [ 0.002073] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-plv8> server # [ 0.002074] CPU features: detected: Common not Private translations vm-test-run-plv8> server # [ 0.002075] CPU features: detected: CRC32 instructions vm-test-run-plv8> server # [ 0.002075] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-plv8> server # [ 0.002076] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-plv8> server # [ 0.002077] CPU features: detected: Data independent timing control (DIT) vm-test-run-plv8> server # [ 0.002078] CPU features: detected: E0PD vm-test-run-plv8> server # [ 0.002078] CPU features: detected: Enhanced Privileged Access Never vm-test-run-plv8> server # [ 0.002079] CPU features: detected: Fine Grained Traps vm-test-run-plv8> server # [ 0.002080] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-plv8> server # [ 0.002081] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-plv8> server # [ 0.002082] CPU features: detected: LSE atomic instructions vm-test-run-plv8> server # [ 0.002083] CPU features: detected: Privileged Access Never vm-test-run-plv8> server # [ 0.002084] CPU features: detected: RAS Extension Support vm-test-run-plv8> server # [ 0.002085] CPU features: detected: Speculation barrier (SB) vm-test-run-plv8> server # [ 0.002088] CPU features: detected: TLB range maintenance instructions vm-test-run-plv8> server # [ 0.002271] alternatives: applying system-wide alternatives vm-test-run-plv8> server # [ 0.003627] Memory: 3925140K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 221240K reserved, 32768K cma-reserved) vm-test-run-plv8> server # [ 0.004521] devtmpfs: initialized vm-test-run-plv8> server # [ 0.005490] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-plv8> server # [ 0.005518] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.005621] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-plv8> server # [ 0.005623] 0 pages in range for non-PLT usage vm-test-run-plv8> server # [ 0.005624] 509248 pages in range for PLT usage vm-test-run-plv8> server # [ 0.005696] pinctrl core: initialized pinctrl subsystem vm-test-run-plv8> server # [ 0.006106] DMI not present or invalid. vm-test-run-plv8> server # [ 0.007456] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-plv8> server # [ 0.008036] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-plv8> server # [ 0.008187] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-plv8> server # [ 0.008290] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-plv8> server # [ 0.008320] audit: initializing netlink subsys (disabled) vm-test-run-plv8> server # [ 0.008607] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=1 vm-test-run-plv8> server # [ 0.008748] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-plv8> server # [ 0.008749] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-plv8> server # [ 0.008751] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-plv8> server # [ 0.008752] thermal_sys: Registered thermal governor 'user_space' vm-test-run-plv8> server # [ 0.008753] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-plv8> server # [ 0.008889] cpuidle: using governor ladder vm-test-run-plv8> server # [ 0.009035] cpuidle: using governor menu vm-test-run-plv8> server # [ 0.009205] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-plv8> server # [ 0.009308] ASID allocator initialised with 65536 entries vm-test-run-plv8> server # [ 0.009533] Serial: AMBA PL011 UART driver vm-test-run-plv8> server # [ 0.010797] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-plv8> server # [ 0.010841] printk: legacy console [ttyAMA0] enabled vm-test-run-plv8> server # [ 0.051340] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.051548] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-plv8> server # [ 0.051801] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.052011] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-plv8> server # [ 0.052210] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.052415] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-plv8> server # [ 0.052596] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-plv8> server # [ 0.052808] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-plv8> server # [ 0.054580] fbcon: Taking over console vm-test-run-plv8> server # [ 0.055219] ACPI: Interpreter disabled. vm-test-run-plv8> server # [ 0.055689] iommu: Default domain type: Translated vm-test-run-plv8> server # [ 0.055825] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-plv8> server # [ 0.056340] SCSI subsystem initialized vm-test-run-plv8> server # [ 0.056635] usbcore: registered new interface driver usbfs vm-test-run-plv8> server # [ 0.056890] usbcore: registered new interface driver hub vm-test-run-plv8> server # [ 0.057203] usbcore: registered new device driver usb vm-test-run-plv8> server # [ 0.057638] pps_core: LinuxPPS API ver. 1 registered vm-test-run-plv8> server # [ 0.058008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-plv8> server # [ 0.058343] PTP clock support registered vm-test-run-plv8> server # [ 0.058554] EDAC MC: Ver: 3.0.0 vm-test-run-plv8> server # [ 0.058725] scmi_core: SCMI protocol bus registered vm-test-run-plv8> server # [ 0.058974] FPGA manager framework vm-test-run-plv8> server # [ 0.059097] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-plv8> server # [ 0.059407] vgaarb: loaded vm-test-run-plv8> server # [ 0.059893] clocksource: Switched to clocksource arch_sys_counter vm-test-run-plv8> server # [ 0.060626] VFS: Disk quotas dquot_6.6.0 vm-test-run-plv8> server # [ 0.060953] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-plv8> server # [ 0.062098] netfs: FS-Cache loaded vm-test-run-plv8> server # [ 0.062803] pnp: PnP ACPI: disabled vm-test-run-plv8> server # [ 0.071711] NET: Registered PF_INET protocol family vm-test-run-plv8> server # [ 0.072123] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-plv8> server # [ 0.084492] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-plv8> server # [ 0.084946] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.085475] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-plv8> server # [ 0.085990] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-plv8> server # [ 0.086561] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-plv8> server # [ 0.086939] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-plv8> server # [ 0.087162] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.087406] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-plv8> server # [ 0.087649] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-plv8> server # [ 0.087933] NET: Registered PF_XDP protocol family vm-test-run-plv8> server # [ 0.088111] PCI: CLS 0 bytes, default 64 vm-test-run-plv8> server # [ 0.088634] kvm [1]: HYP mode not available vm-test-run-plv8> server # [ 0.088640] Trying to unpack rootfs image as initramfs... vm-test-run-plv8> server # [ 0.102037] Initialise system trusted keyrings vm-test-run-plv8> server # [ 0.102260] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-plv8> server # [ 0.102577] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-plv8> server # [ 0.102761] 9p: Installing v9fs 9p2000 file system support vm-test-run-plv8> server # [ 0.112609] Key type asymmetric registered vm-test-run-plv8> server # [ 0.112850] Asymmetric key parser 'x509' registered vm-test-run-plv8> server # [ 0.113012] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-plv8> server # [ 0.113385] io scheduler mq-deadline registered vm-test-run-plv8> server # [ 0.113506] io scheduler kyber registered vm-test-run-plv8> server # [ 0.115524] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-plv8> server # [ 0.116031] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-plv8> server # [ 0.116305] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-plv8> server # [ 0.116503] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-plv8> server # [ 0.116812] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-plv8> server # [ 0.117177] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-plv8> server # [ 0.117451] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-plv8> server # [ 0.117719] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-plv8> server # [ 0.118123] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-plv8> server # [ 0.118336] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-plv8> server # [ 0.118477] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.118636] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.118811] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.119225] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.119534] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.119925] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.120158] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.120399] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.120638] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.120899] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.121129] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.121281] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.121581] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.121939] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.122250] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.122434] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.122793] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.123311] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.123756] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.124072] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.124490] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.125082] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-plv8> server # [ 0.125491] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.125639] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.125988] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.126307] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.126583] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-plv8> server # [ 0.126739] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.127107] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.127699] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.128328] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.128728] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.129033] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.129351] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-plv8> server # [ 0.129850] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.130278] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.130552] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.131238] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.131622] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.132118] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.132637] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-plv8> server # [ 0.133096] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.133557] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-plv8> server # [ 0.134020] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-plv8> server # [ 0.134306] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.134581] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.134678] Freeing initrd memory: 10684K vm-test-run-plv8> server # [ 0.135156] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-plv8> server # [ 0.135956] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-plv8> server # [ 0.136196] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-plv8> server # [ 0.136479] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-plv8> server # [ 0.137146] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-plv8> server # [ 0.137409] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-plv8> server # [ 0.137735] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.138195] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.138655] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.138951] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.139239] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.139573] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.140193] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.140758] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.141222] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.141656] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.142159] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-plv8> server # [ 0.142596] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-plv8> server # [ 0.142865] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-plv8> server # [ 0.143178] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-plv8> server # [ 0.143590] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-plv8> server # [ 0.144074] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-plv8> server # [ 0.144444] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-plv8> server # [ 0.144857] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-plv8> server # [ 0.145206] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-plv8> server # [ 0.145504] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-plv8> server # [ 0.145798] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-plv8> server # [ 0.146144] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-plv8> server # [ 0.146524] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-plv8> server # [ 0.146753] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-plv8> server # [ 0.146957] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-plv8> server # [ 0.147181] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-plv8> server # [ 0.147382] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-plv8> server # [ 0.147657] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-plv8> server # [ 0.148067] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-plv8> server # [ 0.148402] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-plv8> server # [ 0.148723] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-plv8> server # [ 0.148951] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-plv8> server # [ 0.149294] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-plv8> server # [ 0.149587] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-plv8> server # [ 0.149921] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-plv8> server # [ 0.150216] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.153554] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.154545] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.155567] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.156433] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.157717] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.159100] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.160363] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.161231] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.161981] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-plv8> server # [ 0.163251] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.164421] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-plv8> server # [ 0.166022] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-plv8> server # [ 0.166653] msm_serial: driver initialized vm-test-run-plv8> server # [ 0.166829] SuperH (H)SCI(F) driver initialized vm-test-run-plv8> server # [ 0.166994] STM32 USART driver initialized vm-test-run-plv8> server # [ 0.174645] loop: module loaded vm-test-run-plv8> server # [ 0.174940] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-plv8> server # [ 0.176139] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-plv8> server # [ 0.177344] megasas: 07.727.03.00-rc1 vm-test-run-plv8> server # [ 0.177686] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-plv8> server # [ 0.178766] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 0.179275] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 0.179954] Using buffer write method vm-test-run-plv8> server # [ 0.180091] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-plv8> server # [ 0.181403] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-plv8> server # [ 0.181765] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-plv8> server # [ 0.182563] Using buffer write method vm-test-run-plv8> server # [ 0.182707] Concatenating MTD devices: vm-test-run-plv8> server # [ 0.182838] (0): "0.flash" vm-test-run-plv8> server # [ 0.182942] (1): "0.flash" vm-test-run-plv8> server # [ 0.183029] into device "0.flash" vm-test-run-plv8> server # [ 0.184926] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-plv8> server # [ 0.187460] thunder_xcv, ver 1.0 vm-test-run-plv8> server # [ 0.187745] thunder_bgx, ver 1.0 vm-test-run-plv8> server # [ 0.188154] nicpf, ver 1.0 vm-test-run-plv8> server # [ 0.188661] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-plv8> server # [ 0.189013] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-plv8> server # [ 0.189287] hclge is initializing vm-test-run-plv8> server # [ 0.189485] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 0.189705] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-plv8> server # [ 0.189966] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-plv8> server # [ 0.190219] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-plv8> server # [ 0.190615] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-plv8> server # [ 0.190851] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-plv8> server # [ 0.191095] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-plv8> server # [ 0.191283] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-plv8> server # [ 0.191549] sky2: driver version 1.30 vm-test-run-plv8> server # [ 0.192200] usbcore: registered new interface driver usb-storage vm-test-run-plv8> server # [ 0.192579] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-plv8> server # [ 0.192884] usbcore: registered new interface driver usbserial_generic vm-test-run-plv8> server # [ 0.193020] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-plv8> server # [ 0.193372] usbserial: USB Serial support registered for generic vm-test-run-plv8> server # [ 0.194126] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-plv8> server # [ 0.194989] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-plv8> server # [ 0.195674] rtc-pl031 9010000.pl031: setting system clock to 2026-10-05T10:42:19 UTC (1791196939) vm-test-run-plv8> server # [ 0.196413] i2c_dev: i2c /dev entries driver vm-test-run-plv8> server # [ 0.197394] sdhci: Secure Digital Host Controller Interface driver vm-test-run-plv8> server # [ 0.197649] sdhci: Copyright(c) Pierre Ossman vm-test-run-plv8> server # [ 0.198045] Synopsys Designware Multimedia Card Interface Driver vm-test-run-plv8> server # [ 0.198484] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-plv8> server # [ 0.199090] hid: raw HID events driver (C) Jiri Kosina vm-test-run-plv8> server # [ 0.199465] usbcore: registered new interface driver usbhid vm-test-run-plv8> server # [ 0.199737] usbhid: USB HID core driver vm-test-run-plv8> server # [ 0.200219] armv8-pmu pmu: hw perfevents: failed to probe PMU! vm-test-run-plv8> server # [ 0.202514] drop_monitor: Initializing network drop monitor service vm-test-run-plv8> server # [ 0.203658] NET: Registered PF_INET6 protocol family vm-test-run-plv8> server # [ 0.203994] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-plv8> server # [ 0.204753] hub 1-0:1.0: USB hub found vm-test-run-plv8> server # [ 0.204912] hub 1-0:1.0: 6 ports detected vm-test-run-plv8> server # [ 0.206037] Segment Routing with IPv6 vm-test-run-plv8> server # [ 0.206517] In-situ OAM (IOAM) with IPv6 vm-test-run-plv8> server # [ 0.207120] NET: Registered PF_PACKET protocol family vm-test-run-plv8> server # [ 0.207944] 9pnet: Installing 9P2000 support vm-test-run-plv8> server # [ 0.209087] Key type dns_resolver registered vm-test-run-plv8> server # [ 0.210635] registered taskstats version 1 vm-test-run-plv8> server # [ 0.211145] Loading compiled-in X.509 certificates vm-test-run-plv8> server # [ 0.214037] Demotion targets for Node 0: null vm-test-run-plv8> server # [ 0.215048] Key type .fscrypt registered vm-test-run-plv8> server # [ 0.215435] Key type fscrypt-provisioning registered vm-test-run-plv8> server # [ 0.216484] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-plv8> server # [ 0.220631] clk: Disabling unused clocks vm-test-run-plv8> server # [ 0.221010] PM: genpd: Disabling unused power domains vm-test-run-plv8> server # [ 0.221251] ALSA device list: vm-test-run-plv8> server # [ 0.221475] No soundcards found. vm-test-run-plv8> server # [ 0.222382] Freeing unused kernel memory: 4416K vm-test-run-plv8> server # [ 0.223085] Run /init as init process vm-test-run-plv8> server # [ 0.252346] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-plv8> server # [ 0.260183] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-plv8> server # [ 0.260458] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-plv8> server # [ 0.260459] [drm] features: -context_init vm-test-run-plv8> server # [ 0.261142] [drm] number of scanouts: 1 vm-test-run-plv8> server # [ 0.261283] [drm] number of cap sets: 0 vm-test-run-plv8> server # [ 0.262010] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-plv8> server # [ 0.263995] Console: switching to colour frame buffer device 160x50 vm-test-run-plv8> server # [ 0.267494] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-plv8> server # [ 0.476677] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-plv8> server # [ 0.623734] EXT4-fs (vda): mounted filesystem 72b59e35-5567-4e91-a21c-630ee13456aa r/w with ordered data mode. Quota mode: none. vm-test-run-plv8> server # [ 0.713515] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 vm-test-run-plv8> server # [ 0.828989] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 vm-test-run-plv8> server # [ 0.947981] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-plv8> server # [ 1.033795] EXT4-fs (vda): re-mounted 72b59e35-5567-4e91-a21c-630ee13456aa. vm-test-run-plv8> server # [ 1.037038] booting system configuration /nix/store/chbagkpawjqlh05j53a09vh8fy1iy6cb-nixos-system-server-test vm-test-run-plv8> server # [ 1.122252] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 vm-test-run-plv8> server # [ 1.125449] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 vm-test-run-plv8> server # [ 4.625838] systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN -IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) vm-test-run-plv8> server # [ 4.629269] systemd[1]: Detected virtualization qemu. vm-test-run-plv8> server # [ 4.630136] systemd[1]: Detected architecture arm64. vm-test-run-plv8> server # [ 4.630827] systemd[1]: Detected first boot. vm-test-run-plv8> server # [ 4.638603] systemd[1]: Initializing machine ID from random generator. vm-test-run-plv8> server # [ 4.648038] systemd[1]: Hostname set to . vm-test-run-plv8> server # [ 4.836154] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-plv8> server # [ 5.013821] systemd[1]: Applying preset policy. vm-test-run-plv8> server # [ 6.217976] systemd[1]: Populated /etc with preset unit settings. vm-test-run-plv8> server # [ 7.548705] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-plv8> server # [ 7.668638] systemd[1]: Created slice Slice /system/getty. vm-test-run-plv8> server # [ 7.670394] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-plv8> server # [ 7.674184] systemd[1]: Created slice User and Session Slice. vm-test-run-plv8> server # [ 7.676050] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-plv8> server # [ 7.676632] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-plv8> server # [ 7.677087] systemd[1]: Expecting device /dev/hvc0... vm-test-run-plv8> server # [ 7.678021] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-plv8> server # [ 7.679433] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-plv8> server # [ 7.681076] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-plv8> server # [ 7.683204] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-plv8> server # [ 7.684988] systemd[1]: Reached target Path Units. vm-test-run-plv8> server # [ 7.686197] systemd[1]: Reached target Remote File Systems. vm-test-run-plv8> server # [ 7.686979] systemd[1]: Reached target Slice Units. vm-test-run-plv8> server # [ 7.688182] systemd[1]: Reached target Swaps. vm-test-run-plv8> server # [ 7.707489] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-plv8> server # [ 7.721157] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-plv8> server # [ 7.723226] systemd[1]: Listening on Journal Audit Socket. vm-test-run-plv8> server # [ 7.725039] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-plv8> server # [ 7.725976] systemd[1]: Listening on Journal Sockets. vm-test-run-plv8> server # [ 7.728139] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-plv8> server # [ 7.729090] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 7.730446] systemd[1]: Listening on udev Control Socket. vm-test-run-plv8> server # [ 7.731041] systemd[1]: Listening on udev Kernel Socket. vm-test-run-plv8> server # [ 7.752048] systemd[1]: Mounting Huge Pages File System... vm-test-run-plv8> server # [ 7.761511] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-plv8> server # [ 7.769183] systemd[1]: Mounting Kernel Debug File System... vm-test-run-plv8> server # [ 7.777531] systemd[1]: Mounting Kernel Trace File System... vm-test-run-plv8> server # [ 7.793845] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-plv8> server # [ 7.802598] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-plv8> server # [ 7.804426] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-plv8> server # [ 7.813685] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-plv8> server # [ 7.814652] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-plv8> server # [ 7.816840] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-plv8> server # [ 7.825243] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-plv8> server # [ 7.826538] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-plv8> server # [ 7.829323] systemd[1]: Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). vm-test-run-plv8> server # [ 7.848682] systemd[1]: Starting Journal Service... vm-test-run-plv8> server # [ 7.856753] systemd[1]: Starting Load Kernel Modules... vm-test-run-plv8> server # [ 7.872411] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-plv8> server # [ 7.879664] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-plv8> server # [ 7.881707] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 7.895175] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-plv8> server # [ 7.936081] systemd[1]: Mounted Huge Pages File System. vm-test-run-plv8> server # [ 7.936649] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-plv8> server # [ 7.937085] systemd[1]: Mounted Kernel Debug File System. vm-test-run-plv8> server # [ 7.938341] systemd[1]: Mounted Kernel Trace File System. vm-test-run-plv8> server # [ 7.939110] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-plv8> server # [ 7.956101] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-plv8> server # [ 7.966660] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-plv8> server # [ 8.003306] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-plv8> server # [ 8.004823] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-plv8> server # [ 8.040930] fuse: init (API version 7.41) vm-test-run-plv8> server # [ 8.067789] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-plv8> server # [ 8.068429] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-plv8> server # [ 8.077048] systemd[1]: Mounting FUSE Control File System... vm-test-run-plv8> server # [ 8.112138] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-plv8> server # [ 8.125776] systemd-journald[394]: Collecting audit messages is enabled. vm-test-run-plv8> server # [ 8.160154] systemd[1]: Started Journal Service. vm-test-run-plv8> server # [ 8.137116] systemd-oomd[396]: No swap; memory pressure usage will be degraded vm-test-run-plv8> server # [ 8.137746] systemd-modules-load[395]: Module 'atkbd' is built in vm-test-run-plv8> server # [ 8.139560] systemd-modules-load[395]: Module 'loop' is built in vm-test-run-plv8> server # [ 8.153407] systemd[1]: Mounted FUSE Control File System. vm-test-run-plv8> server # [ 8.156439] systemd[1]: Finished Load Kernel Modules. vm-test-run-plv8> server # [ 8.184268] EXT4-fs (vda): re-mounted 72b59e35-5567-4e91-a21c-630ee13456aa. vm-test-run-plv8> server # [ 8.164854] systemd[1]: Starting Firewall... vm-test-run-plv8> server # [ 8.174704] systemd[1]: Starting Apply Kernel Variables... vm-test-run-plv8> server # [ 8.182253] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-plv8> server # [ 8.186809] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-plv8> server # [ 8.189737] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-plv8> server # [ 8.195363] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-plv8> server # [ 8.195702] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-plv8> server # [ 8.313095] systemd-journald[394]: Received client request to flush runtime journal. vm-test-run-plv8> server # [ 8.306931] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-plv8> server # [ 8.307265] systemd[1]: Reached target First Boot Complete. vm-test-run-plv8> server # [ 8.316839] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-plv8> server # [ 8.349178] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-plv8> server # [ 8.356692] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-plv8> server # [ 8.365333] systemd[1]: Finished Apply Kernel Variables. vm-test-run-plv8> server # [ 8.365842] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-plv8> server # [ 8.590863] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-plv8> server # [ 8.591344] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-plv8> server # [ 8.596867] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-plv8> server # [ 8.799334] systemd-udevd[440]: Using default interface naming scheme 'v258'. vm-test-run-plv8> server # [ 8.916330] systemd[1]: Mounting /run/wrappers... vm-test-run-plv8> server # [ 9.014182] systemd[1]: Mounted /run/wrappers. vm-test-run-plv8> server # [ 9.015281] systemd[1]: Reached target Local File Systems. vm-test-run-plv8> server # [ 9.020425] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-plv8> server # [ 9.025848] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-plv8> server # [ 9.026431] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-plv8> server # [ 9.030716] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-plv8> server # [ 9.037603] systemd[1]: Starting Create System Files and Directories... vm-test-run-plv8> server # [ 9.248845] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-plv8> server # [ 9.269184] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-plv8> server # [ 9.276584] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-plv8> server # [ 9.419563] systemd[1]: Found device /dev/hvc0. vm-test-run-plv8> server # [ 9.428424] systemd[1]: Finished Create System Files and Directories. vm-test-run-plv8> server # [ 9.542865] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-plv8> server # [ 9.634238] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-plv8> server # [ 9.638906] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-plv8> server # [ 9.704631] (udev-worker)[491]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-plv8> server # [ 9.706673] (udev-worker)[491]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 9.714232] (udev-worker)[485]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-plv8> server # [ 9.777564] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-plv8> server # [ 9.895241] mousedev: PS/2 mouse device common for all mice vm-test-run-plv8> server # [ 9.892726] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-plv8> server # [ 9.896745] systemd[1]: Starting Update is Completed... vm-test-run-plv8> server # [ 9.937344] systemd[1]: Found device Virtio network device. vm-test-run-plv8> server # [ 10.011336] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 vm-test-run-plv8> server # [ 10.051160] systemd[1]: Finished Update is Completed. vm-test-run-plv8> server # [ 10.100718] systemd[1]: Starting Virtual Console Setup... vm-test-run-plv8> server # [ 11.234538] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-plv8> server # [ 11.238488] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-plv8> server # [ 12.301914] systemd[1]: Finished Virtual Console Setup. vm-test-run-plv8> server # [ 12.302680] systemd[1]: Reached target System Initialization. vm-test-run-plv8> server # [ 12.302896] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-plv8> server # [ 12.303848] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-plv8> server # [ 12.304237] systemd[1]: Reached target Timer Units. vm-test-run-plv8> server # [ 12.304398] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-plv8> server # [ 12.304603] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-plv8> server # [ 12.304784] systemd[1]: Listening on Hostname Service Socket. vm-test-run-plv8> server # [ 12.304967] systemd[1]: Reached target Socket Units. vm-test-run-plv8> server # [ 12.305755] systemd[1]: Reached target Basic System. vm-test-run-plv8> server # [ 12.316082] systemd[1]: Started backdoor.service. vm-test-run-plv8> server # [ 12.321981] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-plv8> server # [ 12.329240] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 12.337491] systemd[1]: Started Reset console on configuration changes. vm-test-run-plv8> server # [ 12.344938] systemd[1]: Starting resolvconf update... vm-test-run-plv8> server # [ 12.345345] systemd[1]: Finished Firewall. vm-test-run-plv8> server # [ 12.357175] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-plv8> server # [ 12.624080] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-plv8> server # connecting to host... vm-test-run-plv8> server # [ 12.746379] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 12.747016] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 12.747988] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 12.748397] nsncd[654]: Oct 05 10:42:32.067 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 12.760813] systemd[1]: Starting User Login Management... vm-test-run-plv8> server: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-plv8> server: connected to guest root shell vm-test-run-plv8> server: (connecting took 12.94 seconds) vm-test-run-plv8> server: (finished: waiting for the VM to finish booting, in 12.94 seconds) vm-test-run-plv8> server # [ 12.858884] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-plv8> server # [ 12.866264] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-plv8> server # [ 12.868212] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-plv8> server # [ 12.868424] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-plv8> server # [ 12.868982] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 12.879183] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-plv8> server # [ 12.881757] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 12.889972] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-plv8> server # [ 12.906516] dbus-daemon[657]: dbus[657]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-plv8> server # [ 12.992621] systemd-logind[683]: New seat seat0. vm-test-run-plv8> server # [ 13.008719] systemd-logind[683]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-plv8> server # [ 13.010556] systemd-logind[683]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-plv8> server # [ 13.020854] systemd-logind[683]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-plv8> server # [ 13.026831] systemd[1]: Started User Login Management. vm-test-run-plv8> server # [ 13.039759] systemd[1]: Starting linger-users.service... vm-test-run-plv8> server # [ 13.137041] nsncd[720]: Oct 05 10:42:32.464 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-plv8> server # [ 13.205291] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-plv8> server # [ 13.205973] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-plv8> server # [ 13.206915] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-plv8> server # [ 13.209808] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-plv8> server # [ 13.211598] systemd[1]: Finished linger-users.service. vm-test-run-plv8> server # [ 13.236626] systemd[1]: Started D-Bus System Message Bus. vm-test-run-plv8> server # [ 13.287336] systemd[1]: Finished resolvconf update. vm-test-run-plv8> server # [ 13.289241] systemd[1]: Reached target Preparation for Network. vm-test-run-plv8> server # [ 13.296739] systemd[1]: Starting DHCP Client... vm-test-run-plv8> server # [ 13.307497] systemd[1]: Starting Address configuration of eth1... vm-test-run-plv8> server # [ 13.699644] network-addresses-eth1-start[754]: adding address 192.168.1.1/24... done vm-test-run-plv8> server # [ 13.755001] network-addresses-eth1-start[754]: adding address 2001:db8:1::1/64... done vm-test-run-plv8> server # [ 13.801274] dhcpcd[775]: dhcpcd-10.2.4 starting vm-test-run-plv8> server # [ 13.822744] systemd[1]: Finished Address configuration of eth1. vm-test-run-plv8> server # [ 13.830229] systemd[1]: Starting Networking Setup... vm-test-run-plv8> server # [ 13.840584] dhcpcd[787]: dev: loaded udev vm-test-run-plv8> server # [ 13.942979] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-plv8> server # [ 13.943733] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-plv8> server # [ 13.981447] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-plv8> server # [ 14.143344] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-plv8> server # [ 14.237568] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-plv8> server # [ 14.238618] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-plv8> server # [ 14.246388] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-plv8> server # [ 14.248677] cfg80211: failed to load regulatory.db vm-test-run-plv8> server # [ 14.228854] systemd[1]: Finished Networking Setup. vm-test-run-plv8> server # [ 14.229370] systemd[1]: Reached target Network. vm-test-run-plv8> server # [ 14.234345] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-plv8> server # [ 14.240359] systemd[1]: Starting Permit User Sessions... vm-test-run-plv8> server # [ 14.354453] systemd[1]: Finished Permit User Sessions. vm-test-run-plv8> server # [ 14.359431] systemd[1]: Started Getty on tty1. vm-test-run-plv8> server # [ 14.360501] systemd[1]: Reached target Login Prompts. vm-test-run-plv8> server # [ 14.458625] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-plv8> server # [ 14.437490] dhcpcd[787]: eth0: waiting for carrier vm-test-run-plv8> server # [ 14.534457] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[847]: Initializing database at /var/lib/postgresql/data vm-test-run-plv8> server # [ 14.664711] dhcpcd[787]: eth0: carrier acquired vm-test-run-plv8> server # [ 14.746760] dhcpcd[787]: DUID 00:01:00:01:32:56:3b:9a:52:54:00:12:34:56 vm-test-run-plv8> server # [ 14.749919] dhcpcd[787]: eth0: IAID 00:12:34:56 vm-test-run-plv8> server # [ 14.751389] dhcpcd[787]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-plv8> server # [ 15.004115] dhcpcd[787]: eth0: soliciting a DHCP lease vm-test-run-plv8> server # [ 15.017027] dhcpcd[787]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-plv8> server # [ 15.032923] dhcpcd[787]: eth0: probing address 10.0.2.15/24 vm-test-run-plv8> server # [ 15.076916] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: The files belonging to this database system will be owned by user "postgres". vm-test-run-plv8> server # [ 15.078280] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: This user must also own the server process. vm-test-run-plv8> server # [ 15.113025] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-plv8> server # [ 15.114931] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: The default database encoding has accordingly been set to "UTF8". vm-test-run-plv8> server # [ 15.116243] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: The default text search configuration will be set to "english". vm-test-run-plv8> server # [ 15.116719] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: Data page checksums are enabled. vm-test-run-plv8> server # [ 15.117617] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-plv8> server # [ 15.118518] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: creating subdirectories ... ok vm-test-run-plv8> server # [ 15.119129] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: selecting dynamic shared memory implementation ... posix vm-test-run-plv8> server # [ 15.415794] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: selecting default max_connections ... 100 vm-test-run-plv8> server # [ 15.536155] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: selecting default shared_buffers ... 128MB vm-test-run-plv8> server # [ 17.349478] dhcpcd[787]: eth0: soliciting an IPv6 router vm-test-run-plv8> server # [ 17.350998] dhcpcd[787]: eth0: Router Advertisement from fe80::2 vm-test-run-plv8> server # [ 17.352406] dhcpcd[787]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-plv8> server # [ 17.353225] dhcpcd[787]: eth0: adding route to fec0::/64 vm-test-run-plv8> server # [ 17.354246] dhcpcd[787]: eth0: adding default route via fe80::2 vm-test-run-plv8> server # [ 19.383636] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: selecting default time zone ... UTC vm-test-run-plv8> server # [ 19.402304] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: creating configuration files ... ok vm-test-run-plv8> server # [ 19.780243] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: running bootstrap script ... ok vm-test-run-plv8> server # [ 20.664828] dhcpcd[787]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-plv8> server # [ 20.665480] dhcpcd[787]: eth0: adding route to 10.0.2.0/24 vm-test-run-plv8> server # [ 20.666834] dhcpcd[787]: eth0: adding default route via 10.0.2.2 vm-test-run-plv8> server # [ 21.078502] systemd[1]: Started DHCP Client. vm-test-run-plv8> server # [ 21.173907] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: performing post-bootstrap initialization ... ok vm-test-run-plv8> server # [ 21.591364] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: syncing data to disk ... ok vm-test-run-plv8> server # [ 21.591913] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-plv8> server # [ 21.592957] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: 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 # [ 21.596522] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: Success. You can now start the database server using: vm-test-run-plv8> server # [ 21.597014] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[853]: /nix/store/2bhdbvpk81xy3mkfgqrpc719ip588cba-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-plv8> server # [ 22.048325] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[847]: Validating PostgreSQL configuration... vm-test-run-plv8> server # [ 22.187477] 3nvmh6wdhh1295chdzsysz118iqyv80a-postgresql-init[980]: 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 # [ 22.453360] postgres[982]: 2026-10-05 10:42:41.781 UTC [982] LOG: pgaudit extension initialized vm-test-run-plv8> server # [ 22.762378] postgres[982]: 2026-10-05 10:42:42.090 UTC [982] LOG: pgsodium primary server secret key loaded vm-test-run-plv8> server # [ 22.900758] postgres[982]: 2026-10-05 10:42:42.228 UTC [982] LOG: vault primary server secret key loaded vm-test-run-plv8> server # [ 22.916155] postgres[982]: 2026-10-05 10:42:42.244 UTC [982] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-plv8> server # [ 22.919369] postgres[982]: 2026-10-05 10:42:42.247 UTC [982] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-plv8> server # [ 22.919950] postgres[982]: 2026-10-05 10:42:42.247 UTC [982] LOG: listening on IPv6 address "::", port 5432 vm-test-run-plv8> server # [ 22.923126] postgres[982]: 2026-10-05 10:42:42.251 UTC [982] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-plv8> server # [ 22.933393] postgres[987]: 2026-10-05 10:42:42.261 UTC [987] LOG: database system was shut down at 2026-10-05 10:42:40 UTC vm-test-run-plv8> server # [ 22.946868] postgres[982]: 2026-10-05 10:42:42.275 UTC [982] LOG: database system is ready to accept connections vm-test-run-plv8> server # [ 22.951890] postgres[991]: 2026-10-05 10:42:42.277 UTC [991] FATAL: role "postgres" does not exist vm-test-run-plv8> server # [ 22.953953] systemd[1]: Started PostgreSQL Database Server. vm-test-run-plv8> server # [ 22.954718] postgres[982]: 2026-10-05 10:42:42.282 UTC [982] LOG: background worker "pg_net 0.20.4 worker" (PID 991) exited with exit code 1 vm-test-run-plv8> server # [ 22.957057] postgres[992]: 2026-10-05 10:42:42.285 UTC [992] LOG: pg_cron scheduler started vm-test-run-plv8> server # [ 22.957790] postgres[990]: 2026-10-05 10:42:42.285 UTC [990] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-plv8> server # [ 22.959348] systemd[1]: Starting Supabase Database Initialization... vm-test-run-plv8> server # [ 23.096730] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Waiting for PostgreSQL to be ready... vm-test-run-plv8> server # [ 23.230171] postgres[1000]: ::1 2026-10-05 10:42:42.558 UTC [1000] root@root FATAL: role "root" does not exist vm-test-run-plv8> server # [ 23.240405] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: PostgreSQL is ready vm-test-run-plv8> server # [ 23.241142] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Creating postgres role... vm-test-run-plv8> server # [ 23.301086] postgres[1004]: ::1 2026-10-05 10:42:42.628 UTC [1004] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-plv8> server # [ 23.305023] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1003]: CREATE ROLE vm-test-run-plv8> server # [ 23.339725] postgres[1006]: ::1 2026-10-05 10:42:42.667 UTC [1006] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-plv8> server # [ 23.341530] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1005]: ALTER DATABASE vm-test-run-plv8> server # [ 23.349248] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running init-script: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-plv8> server # [ 23.385761] postgres[1008]: ::1 2026-10-05 10:42:42.713 UTC [1008] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-plv8> server # [ 23.386937] postgres[1008]: ::1 2026-10-05 10:42:42.715 UTC [1008] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-plv8> server # [ 23.388558] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: CREATE PUBLICATION vm-test-run-plv8> server # [ 23.389139] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: ALTER ROLE vm-test-run-plv8> server # [ 23.389651] postgres[1008]: ::1 2026-10-05 10:42:42.715 UTC [1008] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-plv8> server # [ 23.390409] postgres[1008]: ::1 2026-10-05 10:42:42.717 UTC [1008] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-plv8> server # [ 23.392282] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: CREATE ROLE vm-test-run-plv8> server # [ 23.392871] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: CREATE ROLE vm-test-run-plv8> server # [ 23.393384] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: GRANT ROLE vm-test-run-plv8> server # [ 23.393717] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: GRANT vm-test-run-plv8> server # [ 23.394456] postgres[1008]: ::1 2026-10-05 10:42:42.718 UTC [1008] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-plv8> server # [ 23.395571] postgres[1008]: ::1 2026-10-05 10:42:42.719 UTC [1008] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-plv8> server # [ 23.396740] postgres[1008]: ::1 2026-10-05 10:42:42.720 UTC [1008] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-plv8> server # [ 23.397653] postgres[1008]: ::1 2026-10-05 10:42:42.721 UTC [1008] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-plv8> server # [ 23.398826] postgres[1008]: ::1 2026-10-05 10:42:42.722 UTC [1008] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-plv8> server # [ 23.400271] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: CREATE ROLE vm-test-run-plv8> server # [ 23.400810] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: GRANT ROLE vm-test-run-plv8> server # [ 23.401250] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: CREATE SCHEMA vm-test-run-plv8> server # [ 23.401930] postgres[1008]: ::1 2026-10-05 10:42:42.723 UTC [1008] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-plv8> server # [ 24.602793] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: CREATE EXTENSION vm-test-run-plv8> server # [ 24.603683] postgres[1008]: ::1 2026-10-05 10:42:43.931 UTC [1008] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-plv8> server # [ 25.049209] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: CREATE EXTENSION vm-test-run-plv8> server # [ 25.049724] postgres[1008]: ::1 2026-10-05 10:42:44.377 UTC [1008] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-plv8> server # [ 25.051484] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: CREATE ROLE vm-test-run-plv8> server # [ 25.052128] postgres[1008]: ::1 2026-10-05 10:42:44.379 UTC [1008] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-plv8> server # [ 25.053436] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: CREATE ROLE vm-test-run-plv8> server # [ 25.053721] postgres[1008]: ::1 2026-10-05 10:42:44.381 UTC [1008] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-plv8> server # [ 25.055221] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: CREATE ROLE vm-test-run-plv8> server # [ 25.056440] postgres[1008]: ::1 2026-10-05 10:42:44.383 UTC [1008] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-plv8> server # [ 25.057610] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: CREATE ROLE vm-test-run-plv8> server # [ 25.058337] postgres[1008]: ::1 2026-10-05 10:42:44.385 UTC [1008] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-plv8> server # [ 25.060747] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: GRANT ROLE vm-test-run-plv8> server # [ 25.061448] postgres[1008]: ::1 2026-10-05 10:42:44.388 UTC [1008] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-plv8> server # [ 25.062478] postgres[1008]: ::1 2026-10-05 10:42:44.390 UTC [1008] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-plv8> server # [ 25.063570] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: GRANT ROLE vm-test-run-plv8> server # [ 25.065603] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: GRANT ROLE vm-test-run-plv8> server # [ 25.066196] postgres[1008]: ::1 2026-10-05 10:42:44.393 UTC [1008] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-plv8> server # [ 25.067572] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: GRANT ROLE vm-test-run-plv8> server # [ 25.068434] postgres[1008]: ::1 2026-10-05 10:42:44.395 UTC [1008] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.069460] postgres[1008]: ::1 2026-10-05 10:42:44.396 UTC [1008] 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 # [ 25.071159] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: GRANT vm-test-run-plv8> server # [ 25.072102] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 25.072702] postgres[1008]: ::1 2026-10-05 10:42:44.399 UTC [1008] 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 # [ 25.075081] postgres[1008]: ::1 2026-10-05 10:42:44.400 UTC [1008] 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 # [ 25.076755] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 25.077028] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 25.077298] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: GRANT vm-test-run-plv8> server # [ 25.077507] postgres[1008]: ::1 2026-10-05 10:42:44.402 UTC [1008] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.078971] postgres[1008]: ::1 2026-10-05 10:42:44.402 UTC [1008] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-plv8> server # [ 25.080072] postgres[1008]: ::1 2026-10-05 10:42:44.406 UTC [1008] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 25.080903] postgres[1008]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.081555] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: ALTER ROLE vm-test-run-plv8> server # [ 25.082242] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 25.082631] postgres[1008]: ::1 2026-10-05 10:42:44.408 UTC [1008] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 25.083873] postgres[1008]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.084236] postgres[1008]: ::1 2026-10-05 10:42:44.410 UTC [1008] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-plv8> server # [ 25.085079] postgres[1008]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.085467] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 25.085717] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 25.086640] postgres[1008]: ::1 2026-10-05 10:42:44.413 UTC [1008] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-plv8> server # [ 25.087994] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: ALTER ROLE vm-test-run-plv8> server # [ 25.088805] postgres[1008]: ::1 2026-10-05 10:42:44.416 UTC [1008] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-plv8> server # [ 25.089979] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1007]: ALTER ROLE vm-test-run-plv8> server # [ 25.102500] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running init-script: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-plv8> server # [ 25.171201] postgres[1016]: ::1 2026-10-05 10:42:44.499 UTC [1016] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 25.172860] postgres[1016]: ::1 2026-10-05 10:42:44.500 UTC [1016] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-plv8> server # [ 25.173246] postgres[1016]: instance_id uuid NULL, vm-test-run-plv8> server # [ 25.173457] postgres[1016]: id uuid NOT NULL UNIQUE, vm-test-run-plv8> server # [ 25.173636] postgres[1016]: aud varchar(255) NULL, vm-test-run-plv8> server # [ 25.174100] postgres[1016]: "role" varchar(255) NULL, vm-test-run-plv8> server # [ 25.175208] postgres[1016]: email varchar(255) NULL UNIQUE, vm-test-run-plv8> server # [ 25.175823] postgres[1016]: encrypted_password varchar(255) NULL, vm-test-run-plv8> server # [ 25.176508] postgres[1016]: confirmed_at timestamptz NULL, vm-test-run-plv8> server # [ 25.176813] postgres[1016]: invited_at timestamptz NULL, vm-test-run-plv8> server # [ 25.177389] postgres[1016]: confirmation_token varchar(255) NULL, vm-test-run-plv8> server # [ 25.178064] postgres[1016]: confirmation_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 25.178862] postgres[1016]: recovery_token varchar(255) NULL, vm-test-run-plv8> server # [ 25.179193] postgres[1016]: recovery_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 25.179531] postgres[1016]: email_change_token varchar(255) NULL, vm-test-run-plv8> server # [ 25.180700] postgres[1016]: email_change varchar(255) NULL, vm-test-run-plv8> server # [ 25.180931] postgres[1016]: email_change_sent_at timestamptz NULL, vm-test-run-plv8> server # [ 25.181513] postgres[1016]: last_sign_in_at timestamptz NULL, vm-test-run-plv8> server # [ 25.183791] postgres[1016]: raw_app_meta_data jsonb NULL, vm-test-run-plv8> server # [ 25.184235] postgres[1016]: raw_user_meta_data jsonb NULL, vm-test-run-plv8> server # [ 25.184641] postgres[1016]: is_super_admin bool NULL, vm-test-run-plv8> server # [ 25.184839] postgres[1016]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 25.185485] postgres[1016]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 25.185828] postgres[1016]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 25.186387] postgres[1016]: ); vm-test-run-plv8> server # [ 25.187317] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE SCHEMA vm-test-run-plv8> server # [ 25.196186] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE TABLE vm-test-run-plv8> server # [ 25.197507] postgres[1016]: ::1 2026-10-05 10:42:44.525 UTC [1016] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-plv8> server # [ 25.204139] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE INDEX vm-test-run-plv8> server # [ 25.204778] postgres[1016]: ::1 2026-10-05 10:42:44.532 UTC [1016] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-plv8> server # [ 25.211301] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE INDEX vm-test-run-plv8> server # [ 25.211903] postgres[1016]: ::1 2026-10-05 10:42:44.539 UTC [1016] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-plv8> server # [ 25.214556] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: COMMENT vm-test-run-plv8> server # [ 25.214841] postgres[1016]: ::1 2026-10-05 10:42:44.542 UTC [1016] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-plv8> server # [ 25.215374] postgres[1016]: instance_id uuid NULL, vm-test-run-plv8> server # [ 25.215796] postgres[1016]: id bigserial NOT NULL, vm-test-run-plv8> server # [ 25.216350] postgres[1016]: "token" varchar(255) NULL, vm-test-run-plv8> server # [ 25.217045] postgres[1016]: user_id varchar(255) NULL, vm-test-run-plv8> server # [ 25.217398] postgres[1016]: revoked bool NULL, vm-test-run-plv8> server # [ 25.217701] postgres[1016]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 25.218389] postgres[1016]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 25.218993] postgres[1016]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 25.219889] postgres[1016]: ); vm-test-run-plv8> server # [ 25.228563] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE TABLE vm-test-run-plv8> server # [ 25.229140] postgres[1016]: ::1 2026-10-05 10:42:44.556 UTC [1016] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-plv8> server # [ 25.236821] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE INDEX vm-test-run-plv8> server # [ 25.237578] postgres[1016]: ::1 2026-10-05 10:42:44.564 UTC [1016] 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 # [ 25.241495] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE INDEX vm-test-run-plv8> server # [ 25.242055] postgres[1016]: ::1 2026-10-05 10:42:44.569 UTC [1016] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-plv8> server # [ 25.246822] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE INDEX vm-test-run-plv8> server # [ 25.247363] postgres[1016]: ::1 2026-10-05 10:42:44.574 UTC [1016] 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 # [ 25.248524] postgres[1016]: ::1 2026-10-05 10:42:44.576 UTC [1016] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-plv8> server # [ 25.249053] postgres[1016]: id uuid NOT NULL, vm-test-run-plv8> server # [ 25.249833] postgres[1016]: uuid uuid NULL, vm-test-run-plv8> server # [ 25.250140] postgres[1016]: raw_base_config text NULL, vm-test-run-plv8> server # [ 25.250868] postgres[1016]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 25.251178] postgres[1016]: updated_at timestamptz NULL, vm-test-run-plv8> server # [ 25.251605] postgres[1016]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 25.252052] postgres[1016]: ); vm-test-run-plv8> server # [ 25.252407] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: COMMENT vm-test-run-plv8> server # [ 25.259563] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE TABLE vm-test-run-plv8> server # [ 25.260140] postgres[1016]: ::1 2026-10-05 10:42:44.587 UTC [1016] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-plv8> server # [ 25.262047] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: COMMENT vm-test-run-plv8> server # [ 25.262339] postgres[1016]: ::1 2026-10-05 10:42:44.590 UTC [1016] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-plv8> server # [ 25.263467] postgres[1016]: instance_id uuid NULL, vm-test-run-plv8> server # [ 25.263719] postgres[1016]: id uuid NOT NULL, vm-test-run-plv8> server # [ 25.263930] postgres[1016]: payload json NULL, vm-test-run-plv8> server # [ 25.265430] postgres[1016]: created_at timestamptz NULL, vm-test-run-plv8> server # [ 25.265857] postgres[1016]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-plv8> server # [ 25.266596] postgres[1016]: ); vm-test-run-plv8> server # [ 25.272921] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE TABLE vm-test-run-plv8> server # [ 25.273360] postgres[1016]: ::1 2026-10-05 10:42:44.601 UTC [1016] 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 # [ 25.278447] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE INDEX vm-test-run-plv8> server # [ 25.278930] postgres[1016]: ::1 2026-10-05 10:42:44.606 UTC [1016] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-plv8> server # [ 25.279984] postgres[1016]: ::1 2026-10-05 10:42:44.608 UTC [1016] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-plv8> server # [ 25.280912] postgres[1016]: "version" varchar(255) NOT NULL, vm-test-run-plv8> server # [ 25.281741] postgres[1016]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-plv8> server # [ 25.282333] postgres[1016]: ); vm-test-run-plv8> server # [ 25.282799] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: COMMENT vm-test-run-plv8> server # [ 25.287255] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE TABLE vm-test-run-plv8> server # [ 25.287915] postgres[1016]: ::1 2026-10-05 10:42:44.615 UTC [1016] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-plv8> server # [ 25.288950] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: COMMENT vm-test-run-plv8> server # [ 25.291976] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: INSERT 0 7 vm-test-run-plv8> server # [ 25.292366] postgres[1016]: ::1 2026-10-05 10:42:44.620 UTC [1016] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-plv8> server # [ 25.293411] postgres[1016]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-plv8> server # [ 25.293893] postgres[1016]: $$ language sql stable; vm-test-run-plv8> server # [ 25.296072] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE FUNCTION vm-test-run-plv8> server # [ 25.296573] postgres[1016]: ::1 2026-10-05 10:42:44.623 UTC [1016] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-plv8> server # [ 25.297189] postgres[1016]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-plv8> server # [ 25.297716] postgres[1016]: $$ language sql stable; vm-test-run-plv8> server # [ 25.300367] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE FUNCTION vm-test-run-plv8> server # [ 25.300828] postgres[1016]: ::1 2026-10-05 10:42:44.628 UTC [1016] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-plv8> server # [ 25.301661] postgres[1016]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-plv8> server # [ 25.302702] postgres[1016]: $$ language sql stable; vm-test-run-plv8> server # [ 25.303053] postgres[1016]: ::1 2026-10-05 10:42:44.630 UTC [1016] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.305016] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE FUNCTION vm-test-run-plv8> server # [ 25.305417] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: GRANT vm-test-run-plv8> server # [ 25.305751] postgres[1016]: ::1 2026-10-05 10:42:44.633 UTC [1016] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 25.307534] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: CREATE ROLE vm-test-run-plv8> server # [ 25.308379] postgres[1016]: ::1 2026-10-05 10:42:44.635 UTC [1016] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 25.310037] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: GRANT vm-test-run-plv8> server # [ 25.310575] postgres[1016]: ::1 2026-10-05 10:42:44.638 UTC [1016] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 25.311901] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: GRANT vm-test-run-plv8> server # [ 25.313160] postgres[1016]: ::1 2026-10-05 10:42:44.640 UTC [1016] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 25.313961] postgres[1016]: ::1 2026-10-05 10:42:44.642 UTC [1016] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-plv8> server # [ 25.314778] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: GRANT vm-test-run-plv8> server # [ 25.316791] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: ALTER ROLE vm-test-run-plv8> server # [ 25.317440] postgres[1016]: ::1 2026-10-05 10:42:44.644 UTC [1016] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 25.319273] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: ALTER TABLE vm-test-run-plv8> server # [ 25.319658] postgres[1016]: ::1 2026-10-05 10:42:44.647 UTC [1016] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 25.321769] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: ALTER TABLE vm-test-run-plv8> server # [ 25.322035] postgres[1016]: ::1 2026-10-05 10:42:44.649 UTC [1016] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 25.323782] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: ALTER TABLE vm-test-run-plv8> server # [ 25.324341] postgres[1016]: ::1 2026-10-05 10:42:44.651 UTC [1016] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 25.326521] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: ALTER TABLE vm-test-run-plv8> server # [ 25.327064] postgres[1016]: ::1 2026-10-05 10:42:44.654 UTC [1016] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 25.328166] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1015]: ALTER TABLE vm-test-run-plv8> server # [ 25.342292] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running init-script: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-plv8> server # [ 25.403648] postgres[1018]: ::1 2026-10-05 10:42:44.731 UTC [1018] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-plv8> server # [ 25.406762] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1017]: CREATE SCHEMA vm-test-run-plv8> server # [ 25.408150] postgres[1018]: ::1 2026-10-05 10:42:44.734 UTC [1018] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 25.409456] postgres[1018]: ::1 2026-10-05 10:42:44.734 UTC [1018] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-plv8> server # [ 25.410486] postgres[1018]: ::1 2026-10-05 10:42:44.736 UTC [1018] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-plv8> server # [ 25.412441] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1017]: CREATE ROLE vm-test-run-plv8> server # [ 25.412944] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1017]: ALTER ROLE vm-test-run-plv8> server # [ 25.413708] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1017]: GRANT vm-test-run-plv8> server # [ 25.415235] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1017]: DO vm-test-run-plv8> server # [ 25.430439] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running init-script: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-plv8> server # [ 25.480852] postgres[1020]: ::1 2026-10-05 10:42:44.808 UTC [1020] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-plv8> server # [ 25.483246] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: ALTER ROLE vm-test-run-plv8> server # [ 25.484964] postgres[1020]: ::1 2026-10-05 10:42:44.811 UTC [1020] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-plv8> server # [ 25.486635] postgres[1020]: ::1 2026-10-05 10:42:44.812 UTC [1020] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-plv8> server # [ 25.488571] postgres[1020]: RETURNS event_trigger vm-test-run-plv8> server # [ 25.489103] postgres[1020]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 25.490370] postgres[1020]: AS $$ vm-test-run-plv8> server # [ 25.491014] postgres[1020]: DECLARE vm-test-run-plv8> server # [ 25.491324] postgres[1020]: schema_is_cron bool; vm-test-run-plv8> server # [ 25.492814] postgres[1020]: BEGIN vm-test-run-plv8> server # [ 25.493280] postgres[1020]: schema_is_cron = ( vm-test-run-plv8> server # [ 25.494006] postgres[1020]: SELECT n.nspname = 'cron' vm-test-run-plv8> server # [ 25.494391] postgres[1020]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 25.495384] postgres[1020]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-plv8> server # [ 25.497158] postgres[1020]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 25.497625] postgres[1020]: ); vm-test-run-plv8> server # [ 25.498210] postgres[1020]: vm-test-run-plv8> server # [ 25.498440] postgres[1020]: IF schema_is_cron vm-test-run-plv8> server # [ 25.498896] postgres[1020]: THEN vm-test-run-plv8> server # [ 25.499155] postgres[1020]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 25.500176] postgres[1020]: vm-test-run-plv8> server # [ 25.501135] postgres[1020]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 25.501953] postgres[1020]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 25.503763] postgres[1020]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 25.505521] postgres[1020]: vm-test-run-plv8> server # [ 25.505746] postgres[1020]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 25.507549] postgres[1020]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 25.510211] postgres[1020]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 25.511628] postgres[1020]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 25.512214] postgres[1020]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 25.513525] postgres[1020]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 25.514459] postgres[1020]: vm-test-run-plv8> server # [ 25.514636] postgres[1020]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 25.515249] postgres[1020]: vm-test-run-plv8> server # [ 25.517520] postgres[1020]: END IF; vm-test-run-plv8> server # [ 25.520657] postgres[1020]: vm-test-run-plv8> server # [ 25.521249] postgres[1020]: END; vm-test-run-plv8> server # [ 25.521905] postgres[1020]: $$; vm-test-run-plv8> server # [ 25.522258] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: ALTER ROLE vm-test-run-plv8> server # [ 25.523654] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: CREATE FUNCTION vm-test-run-plv8> server # [ 25.525752] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 25.526321] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: COMMENT vm-test-run-plv8> server # [ 25.527170] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: CREATE FUNCTION vm-test-run-plv8> server # [ 25.527596] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: COMMENT vm-test-run-plv8> server # [ 25.528057] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: DO vm-test-run-plv8> server # [ 25.528496] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: CREATE ROLE vm-test-run-plv8> server # [ 25.528987] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: GRANT vm-test-run-plv8> server # [ 25.529366] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: GRANT vm-test-run-plv8> server # [ 25.529892] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: GRANT vm-test-run-plv8> server # [ 25.531123] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: GRANT vm-test-run-plv8> server # [ 25.531438] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: GRANT vm-test-run-plv8> server # [ 25.531632] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: GRANT vm-test-run-plv8> server # [ 25.531941] postgres[1020]: ::1 2026-10-05 10:42:44.816 UTC [1020] 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 # [ 25.532973] postgres[1020]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 25.534350] postgres[1020]: ::1 2026-10-05 10:42:44.817 UTC [1020] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-plv8> server # [ 25.535613] postgres[1020]: ::1 2026-10-05 10:42:44.817 UTC [1020] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-plv8> server # [ 25.537407] postgres[1020]: RETURNS event_trigger vm-test-run-plv8> server # [ 25.540380] postgres[1020]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 25.541699] postgres[1020]: AS $$ vm-test-run-plv8> server # [ 25.542242] postgres[1020]: BEGIN vm-test-run-plv8> server # [ 25.543241] postgres[1020]: IF EXISTS ( vm-test-run-plv8> server # [ 25.543476] postgres[1020]: SELECT 1 vm-test-run-plv8> server # [ 25.544603] postgres[1020]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 25.545231] postgres[1020]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 25.545729] postgres[1020]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 25.546328] postgres[1020]: WHERE ext.extname = 'pg_net' vm-test-run-plv8> server # [ 25.546516] postgres[1020]: ) vm-test-run-plv8> server # [ 25.546617] postgres[1020]: THEN vm-test-run-plv8> server # [ 25.547214] postgres[1020]: IF NOT EXISTS ( vm-test-run-plv8> server # [ 25.547365] postgres[1020]: SELECT 1 vm-test-run-plv8> server # [ 25.547493] postgres[1020]: FROM pg_roles vm-test-run-plv8> server # [ 25.547638] postgres[1020]: WHERE rolname = 'supabase_functions_admin' vm-test-run-plv8> server # [ 25.548089] postgres[1020]: ) vm-test-run-plv8> server # [ 25.548564] postgres[1020]: THEN vm-test-run-plv8> server # [ 25.548691] postgres[1020]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-plv8> server # [ 25.549081] postgres[1020]: END IF; vm-test-run-plv8> server # [ 25.549505] postgres[1020]: vm-test-run-plv8> server # [ 25.550112] postgres[1020]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 25.551423] postgres[1020]: vm-test-run-plv8> server # [ 25.551878] postgres[1020]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 25.552876] postgres[1020]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-plv8> server # [ 25.553683] postgres[1020]: vm-test-run-plv8> server # [ 25.553979] postgres[1020]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-plv8> server # [ 25.555061] postgres[1020]: 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 # [ 25.558269] postgres[1020]: vm-test-run-plv8> server # [ 25.559077] postgres[1020]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-plv8> server # [ 25.561803] postgres[1020]: 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 # [ 25.563401] postgres[1020]: vm-test-run-plv8> server # [ 25.563769] postgres[1020]: 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 # [ 25.567010] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: GRANT vm-test-run-plv8> server # [ 25.568698] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: GRANT vm-test-run-plv8> server # [ 25.569128] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: GRANT vm-test-run-plv8> server # [ 25.570447] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1019]: DO vm-test-run-plv8> server # [ 25.571876] postgres[1020]: 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 # [ 25.574824] postgres[1020]: END IF; vm-test-run-plv8> server # [ 25.574963] postgres[1020]: END; vm-test-run-plv8> server # [ 25.575069] postgres[1020]: $$; vm-test-run-plv8> server # [ 25.575170] postgres[1020]: ::1 2026-10-05 10:42:44.822 UTC [1020] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-plv8> server # [ 25.575976] postgres[1020]: ::1 2026-10-05 10:42:44.830 UTC [1020] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-plv8> server # [ 25.577480] postgres[1020]: ::1 2026-10-05 10:42:44.834 UTC [1020] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-plv8> server # [ 25.577983] postgres[1020]: ::1 2026-10-05 10:42:44.836 UTC [1020] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 25.579195] postgres[1020]: ::1 2026-10-05 10:42:44.839 UTC [1020] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 25.579946] postgres[1020]: ::1 2026-10-05 10:42:44.842 UTC [1020] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 25.581706] postgres[1020]: ::1 2026-10-05 10:42:44.846 UTC [1020] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 25.583270] postgres[1020]: ::1 2026-10-05 10:42:44.846 UTC [1020] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 25.584908] postgres[1020]: ::1 2026-10-05 10:42:44.850 UTC [1020] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 25.588368] postgres[1020]: ::1 2026-10-05 10:42:44.851 UTC [1020] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-plv8> server # [ 25.590134] postgres[1020]: ::1 2026-10-05 10:42:44.853 UTC [1020] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-plv8> server # [ 25.592658] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running pgbouncer auth schema... vm-test-run-plv8> server # [ 25.654379] postgres[1022]: ::1 2026-10-05 10:42:44.982 UTC [1022] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-plv8> server # [ 25.663221] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1021]: CREATE ROLE vm-test-run-plv8> server # [ 25.679192] postgres[1022]: ::1 2026-10-05 10:42:45.007 UTC [1022] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-plv8> server # [ 25.697197] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1021]: REVOKE vm-test-run-plv8> server # [ 25.698664] postgres[1022]: ::1 2026-10-05 10:42:45.026 UTC [1022] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-plv8> server # [ 25.745205] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1021]: CREATE SCHEMA vm-test-run-plv8> server # [ 25.746163] postgres[1022]: ::1 2026-10-05 10:42:45.073 UTC [1022] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-plv8> server # [ 25.747774] postgres[1022]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-plv8> server # [ 25.748304] postgres[1022]: $$ vm-test-run-plv8> server # [ 25.748604] postgres[1022]: BEGIN vm-test-run-plv8> server # [ 25.749953] postgres[1022]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-plv8> server # [ 25.751437] postgres[1022]: vm-test-run-plv8> server # [ 25.752178] postgres[1022]: RETURN QUERY vm-test-run-plv8> server # [ 25.752865] postgres[1022]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-plv8> server # [ 25.753504] postgres[1022]: WHERE usename = p_usename; vm-test-run-plv8> server # [ 25.754242] postgres[1022]: END; vm-test-run-plv8> server # [ 25.754746] postgres[1022]: $$ LANGUAGE plpgsql vm-test-run-plv8> server # [ 25.755191] postgres[1022]: SET search_path = '' vm-test-run-plv8> server # [ 25.756348] postgres[1022]: SECURITY DEFINER; vm-test-run-plv8> server # [ 25.757022] postgres[1022]: ::1 2026-10-05 10:42:45.075 UTC [1022] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-plv8> server # [ 25.758493] postgres[1022]: ::1 2026-10-05 10:42:45.078 UTC [1022] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-plv8> server # [ 25.760849] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1021]: CREATE FUNCTION vm-test-run-plv8> server # [ 25.761443] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1021]: REVOKE vm-test-run-plv8> server # [ 25.762263] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1021]: GRANT vm-test-run-plv8> server # [ 25.772096] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running stat extension... vm-test-run-plv8> server # [ 25.822618] postgres[1028]: ::1 2026-10-05 10:42:45.150 UTC [1028] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-plv8> server # [ 25.824204] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1027]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-plv8> server # [ 25.825690] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1027]: CREATE SCHEMA vm-test-run-plv8> server # [ 25.826375] postgres[1028]: ::1 2026-10-05 10:42:45.153 UTC [1028] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-plv8> server # [ 26.363063] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1027]: CREATE EXTENSION vm-test-run-plv8> server # [ 26.379880] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-plv8> server # [ 26.437870] postgres[1030]: ::1 2026-10-05 10:42:45.765 UTC [1030] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-plv8> server # [ 26.440293] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1029]: GRANT vm-test-run-plv8> server # [ 26.440770] postgres[1030]: ::1 2026-10-05 10:42:45.768 UTC [1030] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 26.442101] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1029]: GRANT vm-test-run-plv8> server # [ 26.442867] postgres[1030]: ::1 2026-10-05 10:42:45.770 UTC [1030] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 26.444488] postgres[1030]: ::1 2026-10-05 10:42:45.771 UTC [1030] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 26.445437] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1029]: GRANT vm-test-run-plv8> server # [ 26.446496] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1029]: GRANT vm-test-run-plv8> server # [ 26.446807] postgres[1030]: ::1 2026-10-05 10:42:45.774 UTC [1030] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 26.448781] postgres[1030]: ::1 2026-10-05 10:42:45.776 UTC [1030] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 26.450044] postgres[1030]: ::1 2026-10-05 10:42:45.776 UTC [1030] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 26.451311] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1029]: GRANT vm-test-run-plv8> server # [ 26.451572] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1029]: GRANT vm-test-run-plv8> server # [ 26.451793] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1029]: GRANT vm-test-run-plv8> server # [ 26.452138] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1029]: GRANT vm-test-run-plv8> server # [ 26.452389] postgres[1030]: ::1 2026-10-05 10:42:45.777 UTC [1030] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 26.453301] postgres[1030]: ::1 2026-10-05 10:42:45.779 UTC [1030] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-plv8> server # [ 26.454564] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1029]: GRANT vm-test-run-plv8> server # [ 26.456962] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1029]: DO vm-test-run-plv8> server # [ 26.457339] postgres[1030]: ::1 2026-10-05 10:42:45.785 UTC [1030] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-plv8> server # [ 26.458665] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1029]: ALTER ROLE vm-test-run-plv8> server # [ 26.466311] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-plv8> server # [ 26.521257] postgres[1032]: ::1 2026-10-05 10:42:45.849 UTC [1032] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 26.523051] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: GRANT vm-test-run-plv8> server # [ 26.523655] postgres[1032]: ::1 2026-10-05 10:42:45.851 UTC [1032] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 26.526199] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: GRANT vm-test-run-plv8> server # [ 26.526454] postgres[1032]: ::1 2026-10-05 10:42:45.854 UTC [1032] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-plv8> server # [ 26.528908] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: GRANT vm-test-run-plv8> server # [ 26.529342] postgres[1032]: ::1 2026-10-05 10:42:45.856 UTC [1032] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 26.530464] postgres[1032]: ::1 2026-10-05 10:42:45.858 UTC [1032] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 26.532149] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: ALTER TABLE vm-test-run-plv8> server # [ 26.532932] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: ALTER TABLE vm-test-run-plv8> server # [ 26.533281] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: ALTER TABLE vm-test-run-plv8> server # [ 26.534235] postgres[1032]: ::1 2026-10-05 10:42:45.859 UTC [1032] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 26.535543] postgres[1032]: ::1 2026-10-05 10:42:45.860 UTC [1032] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 26.536713] postgres[1032]: ::1 2026-10-05 10:42:45.861 UTC [1032] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-plv8> server # [ 26.537661] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: ALTER TABLE vm-test-run-plv8> server # [ 26.537895] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: ALTER TABLE vm-test-run-plv8> server # [ 26.538376] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: GRANT vm-test-run-plv8> server # [ 26.538764] postgres[1032]: ::1 2026-10-05 10:42:45.863 UTC [1032] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-plv8> server # [ 26.539964] postgres[1032]: ::1 2026-10-05 10:42:45.865 UTC [1032] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 26.540624] postgres[1032]: ::1 2026-10-05 10:42:45.868 UTC [1032] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 26.541571] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: GRANT vm-test-run-plv8> server # [ 26.543160] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: GRANT vm-test-run-plv8> server # [ 26.543778] postgres[1032]: ::1 2026-10-05 10:42:45.871 UTC [1032] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-plv8> server # [ 26.546128] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: GRANT vm-test-run-plv8> server # [ 26.546418] postgres[1032]: ::1 2026-10-05 10:42:45.874 UTC [1032] 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 # [ 26.549210] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 26.549492] postgres[1032]: ::1 2026-10-05 10:42:45.877 UTC [1032] 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 # [ 26.551386] postgres[1032]: ::1 2026-10-05 10:42:45.878 UTC [1032] 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 # [ 26.553181] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 26.553792] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1031]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 26.563216] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-plv8> server # [ 26.645089] postgres[1034]: ::1 2026-10-05 10:42:45.972 UTC [1034] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-plv8> server # [ 26.649277] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1033]: CREATE SCHEMA vm-test-run-plv8> server # [ 26.671377] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-plv8> server # [ 26.737213] postgres[1036]: ::1 2026-10-05 10:42:46.065 UTC [1036] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-plv8> server # [ 26.739329] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1035]: GRANT vm-test-run-plv8> server # [ 26.739689] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1035]: GRANT vm-test-run-plv8> server # [ 26.739919] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1035]: GRANT vm-test-run-plv8> server # [ 26.740758] postgres[1036]: ::1 2026-10-05 10:42:46.067 UTC [1036] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 26.741960] postgres[1036]: ::1 2026-10-05 10:42:46.067 UTC [1036] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 26.744857] postgres[1036]: ::1 2026-10-05 10:42:46.067 UTC [1036] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-plv8> server # [ 26.746706] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1035]: GRANT vm-test-run-plv8> server # [ 26.761215] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-plv8> server # [ 26.894043] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1037]: DO vm-test-run-plv8> server # [ 26.897192] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1037]: DO vm-test-run-plv8> server # [ 26.899313] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1037]: DO vm-test-run-plv8> server # [ 26.917866] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-plv8> server # [ 26.984375] postgres[1044]: ::1 2026-10-05 10:42:46.312 UTC [1044] 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 # [ 26.986834] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1042]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 26.987822] postgres[1044]: ::1 2026-10-05 10:42:46.315 UTC [1044] 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 # [ 26.990442] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1042]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 27.003856] postgres[1044]: ::1 2026-10-05 10:42:46.319 UTC [1044] 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 # [ 27.044963] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1042]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 27.046038] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-plv8> server # [ 27.059713] postgres[1046]: ::1 2026-10-05 10:42:46.387 UTC [1046] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-plv8> server # [ 27.094274] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1045]: ALTER ROLE vm-test-run-plv8> server # [ 27.095818] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-plv8> server # [ 27.108383] postgres[1048]: ::1 2026-10-05 10:42:46.436 UTC [1048] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 27.110373] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-plv8> server # [ 27.111838] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 27.112667] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-plv8> server # [ 27.114059] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: DROP FUNCTION vm-test-run-plv8> server # [ 27.114518] postgres[1048]: ::1 2026-10-05 10:42:46.437 UTC [1048] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 27.115275] postgres[1048]: ::1 2026-10-05 10:42:46.437 UTC [1048] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 27.116348] postgres[1048]: DECLARE vm-test-run-plv8> server # [ 27.116871] postgres[1048]: cmd record; vm-test-run-plv8> server # [ 27.117167] postgres[1048]: BEGIN vm-test-run-plv8> server # [ 27.117395] postgres[1048]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 27.117987] postgres[1048]: LOOP vm-test-run-plv8> server # [ 27.118311] postgres[1048]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 27.118893] postgres[1048]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 27.119701] postgres[1048]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 27.120813] postgres[1048]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 27.121293] postgres[1048]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 27.121559] postgres[1048]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 27.121967] postgres[1048]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 27.122874] postgres[1048]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 27.123698] postgres[1048]: , 'CREATE TYPE' vm-test-run-plv8> server # [ 27.123913] postgres[1048]: , 'CREATE RULE' vm-test-run-plv8> server # [ 27.124521] postgres[1048]: , 'COMMENT' vm-test-run-plv8> server # [ 27.124862] postgres[1048]: ) vm-test-run-plv8> server # [ 27.125245] postgres[1048]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 27.125915] postgres[1048]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 27.126444] postgres[1048]: THEN vm-test-run-plv8> server # [ 27.127067] postgres[1048]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 27.127806] postgres[1048]: END IF; vm-test-run-plv8> server # [ 27.128458] postgres[1048]: END LOOP; vm-test-run-plv8> server # [ 27.129070] postgres[1048]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 27.129428] postgres[1048]: ::1 2026-10-05 10:42:46.445 UTC [1048] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 27.130324] postgres[1048]: DECLARE vm-test-run-plv8> server # [ 27.130743] postgres[1048]: obj record; vm-test-run-plv8> server # [ 27.130866] postgres[1048]: BEGIN vm-test-run-plv8> server # [ 27.131381] postgres[1048]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 27.132171] postgres[1048]: LOOP vm-test-run-plv8> server # [ 27.132528] postgres[1048]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 27.132777] postgres[1048]: 'schema' vm-test-run-plv8> server # [ 27.133113] postgres[1048]: , 'table' vm-test-run-plv8> server # [ 27.133393] postgres[1048]: , 'foreign table' vm-test-run-plv8> server # [ 27.133838] postgres[1048]: , 'view' vm-test-run-plv8> server # [ 27.134055] postgres[1048]: , 'materialized view' vm-test-run-plv8> server # [ 27.134927] postgres[1048]: , 'function' vm-test-run-plv8> server # [ 27.135080] postgres[1048]: , 'trigger' vm-test-run-plv8> server # [ 27.135605] postgres[1048]: , 'type' vm-test-run-plv8> server # [ 27.135960] postgres[1048]: , 'rule' vm-test-run-plv8> server # [ 27.136242] postgres[1048]: ) vm-test-run-plv8> server # [ 27.136700] postgres[1048]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 27.137341] postgres[1048]: THEN vm-test-run-plv8> server # [ 27.137596] postgres[1048]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 27.138074] postgres[1048]: END IF; vm-test-run-plv8> server # [ 27.138483] postgres[1048]: END LOOP; vm-test-run-plv8> server # [ 27.139016] postgres[1048]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 27.139823] postgres[1048]: ::1 2026-10-05 10:42:46.446 UTC [1048] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 27.140655] postgres[1048]: ::1 2026-10-05 10:42:46.446 UTC [1048] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 27.141282] postgres[1048]: ON ddl_command_end vm-test-run-plv8> server # [ 27.141742] postgres[1048]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 27.142340] postgres[1048]: ::1 2026-10-05 10:42:46.447 UTC [1048] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 27.144089] postgres[1048]: ::1 2026-10-05 10:42:46.448 UTC [1048] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 27.144753] postgres[1048]: ON sql_drop vm-test-run-plv8> server # [ 27.145049] postgres[1048]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 27.145686] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: CREATE FUNCTION vm-test-run-plv8> server # [ 27.146160] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: CREATE FUNCTION vm-test-run-plv8> server # [ 27.147122] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-plv8> server # [ 27.148878] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 27.149400] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 27.149952] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-plv8> server # [ 27.150936] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 27.151744] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1047]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 27.152380] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-plv8> server # [ 27.654062] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1049]: DO vm-test-run-plv8> server # [ 27.659068] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-plv8> server # [ 27.691733] postgres[1053]: ::1 2026-10-05 10:42:47.019 UTC [1053] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-plv8> server # [ 27.697543] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: CREATE SCHEMA vm-test-run-plv8> server # [ 27.698094] postgres[1053]: ::1 2026-10-05 10:42:47.025 UTC [1053] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-plv8> server # [ 27.698858] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-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 # [ 27.703376] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: DROP FUNCTION vm-test-run-plv8> server # [ 27.716294] postgres[1053]: ::1 2026-10-05 10:42:47.029 UTC [1053] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 27.721693] postgres[1053]: "operationName" text default null, vm-test-run-plv8> server # [ 27.722775] postgres[1053]: query text default null, vm-test-run-plv8> server # [ 27.723578] postgres[1053]: variables jsonb default null, vm-test-run-plv8> server # [ 27.728637] postgres[1053]: extensions jsonb default null vm-test-run-plv8> server # [ 27.733579] postgres[1053]: ) vm-test-run-plv8> server # [ 27.733991] postgres[1053]: returns jsonb vm-test-run-plv8> server # [ 27.734705] postgres[1053]: language plpgsql vm-test-run-plv8> server # [ 27.735933] postgres[1053]: as $$ vm-test-run-plv8> server # [ 27.736673] postgres[1053]: DECLARE vm-test-run-plv8> server # [ 27.737060] postgres[1053]: server_version float; vm-test-run-plv8> server # [ 27.737899] postgres[1053]: BEGIN vm-test-run-plv8> server # [ 27.738474] postgres[1053]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 27.740987] postgres[1053]: vm-test-run-plv8> server # [ 27.741490] postgres[1053]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 27.742016] postgres[1053]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 27.742516] postgres[1053]: 'data', null::jsonb, vm-test-run-plv8> server # [ 27.742837] postgres[1053]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 27.743456] postgres[1053]: ); vm-test-run-plv8> server # [ 27.744102] postgres[1053]: ELSE vm-test-run-plv8> server # [ 27.744629] postgres[1053]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 27.745186] postgres[1053]: 'data', null::jsonb, vm-test-run-plv8> server # [ 27.745394] postgres[1053]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 27.746045] postgres[1053]: ); vm-test-run-plv8> server # [ 27.746458] postgres[1053]: END IF; vm-test-run-plv8> server # [ 27.746976] postgres[1053]: END; vm-test-run-plv8> server # [ 27.747326] postgres[1053]: $$; vm-test-run-plv8> server # [ 27.747717] postgres[1053]: ::1 2026-10-05 10:42:47.032 UTC [1053] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 27.748947] postgres[1053]: ::1 2026-10-05 10:42:47.034 UTC [1053] 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 # [ 27.750361] postgres[1053]: ::1 2026-10-05 10:42:47.034 UTC [1053] 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 # [ 27.752245] postgres[1053]: ::1 2026-10-05 10:42:47.035 UTC [1053] 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 # [ 27.753558] postgres[1053]: ::1 2026-10-05 10:42:47.036 UTC [1053] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 27.754544] postgres[1053]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 27.755509] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: CREATE FUNCTION vm-test-run-plv8> server # [ 27.756434] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: GRANT vm-test-run-plv8> server # [ 27.757277] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 27.758059] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 27.759121] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 27.759852] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 27.760577] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 27.761096] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 27.761690] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: CREATE FUNCTION vm-test-run-plv8> server # [ 27.762054] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping vm-test-run-plv8> server # [ 27.764588] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 27.765312] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 27.765916] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: COMMENT vm-test-run-plv8> server # [ 27.766970] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: CREATE FUNCTION vm-test-run-plv8> server # [ 27.767556] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping vm-test-run-plv8> server # [ 27.769534] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 27.770356] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 27.770728] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1052]: COMMENT vm-test-run-plv8> server # [ 27.771544] postgres[1053]: ::1 2026-10-05 10:42:47.038 UTC [1053] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 27.772864] postgres[1053]: on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 27.773461] postgres[1053]: ::1 2026-10-05 10:42:47.038 UTC [1053] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-plv8> server # [ 27.774889] postgres[1053]: on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 27.776218] postgres[1053]: ::1 2026-10-05 10:42:47.041 UTC [1053] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 27.777373] postgres[1053]: RETURNS event_trigger vm-test-run-plv8> server # [ 27.777733] postgres[1053]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 27.777876] postgres[1053]: AS $func$ vm-test-run-plv8> server # [ 27.778284] postgres[1053]: DECLARE vm-test-run-plv8> server # [ 27.778595] postgres[1053]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 27.779400] postgres[1053]: BEGIN vm-test-run-plv8> server # [ 27.779572] postgres[1053]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 27.780271] postgres[1053]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 27.780813] postgres[1053]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 27.781273] postgres[1053]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 27.781711] postgres[1053]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 27.782155] postgres[1053]: ); vm-test-run-plv8> server # [ 27.782468] postgres[1053]: vm-test-run-plv8> server # [ 27.782890] postgres[1053]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 27.783438] postgres[1053]: THEN vm-test-run-plv8> server # [ 27.783731] postgres[1053]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 27.784721] postgres[1053]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 27.785239] postgres[1053]: vm-test-run-plv8> server # [ 27.785341] postgres[1053]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 27.786353] postgres[1053]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 27.787708] postgres[1053]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 27.788865] postgres[1053]: vm-test-run-plv8> server # [ 27.789027] postgres[1053]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 27.789549] postgres[1053]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 27.789944] postgres[1053]: "operationName" text default null, vm-test-run-plv8> server # [ 27.790568] postgres[1053]: query text default null, vm-test-run-plv8> server # [ 27.791524] postgres[1053]: variables jsonb default null, vm-test-run-plv8> server # [ 27.792071] postgres[1053]: extensions jsonb default null vm-test-run-plv8> server # [ 27.793216] postgres[1053]: ) vm-test-run-plv8> server # [ 27.793716] postgres[1053]: returns jsonb vm-test-run-plv8> server # [ 27.794025] postgres[1053]: language sql vm-test-run-plv8> server # [ 27.794545] postgres[1053]: as $$ vm-test-run-plv8> server # [ 27.794963] postgres[1053]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-plv8> server # [ 27.795434] postgres[1053]: $$; vm-test-run-plv8> server # [ 27.795564] postgres[1053]: vm-test-run-plv8> server # [ 27.795685] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-plv8> server # [ 27.797125] postgres[1053]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 27.797704] postgres[1053]: END IF; vm-test-run-plv8> server # [ 27.797909] postgres[1053]: vm-test-run-plv8> server # [ 27.798004] postgres[1053]: END; vm-test-run-plv8> server # [ 27.798336] postgres[1053]: $func$; vm-test-run-plv8> server # [ 27.798443] postgres[1053]: ::1 2026-10-05 10:42:47.042 UTC [1053] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-plv8> server # [ 27.799645] postgres[1053]: ::1 2026-10-05 10:42:47.042 UTC [1053] 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 # [ 27.801412] postgres[1053]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-plv8> server # [ 27.801653] postgres[1053]: ::1 2026-10-05 10:42:47.043 UTC [1053] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-plv8> server # [ 27.802961] postgres[1053]: ::1 2026-10-05 10:42:47.044 UTC [1053] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 27.804337] postgres[1053]: RETURNS event_trigger vm-test-run-plv8> server # [ 27.804936] postgres[1053]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 27.805075] postgres[1053]: AS $func$ vm-test-run-plv8> server # [ 27.805190] postgres[1053]: DECLARE vm-test-run-plv8> server # [ 27.805310] postgres[1053]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 27.805645] postgres[1053]: BEGIN vm-test-run-plv8> server # [ 27.805764] postgres[1053]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 27.806200] postgres[1053]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 27.806978] postgres[1053]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 27.807572] postgres[1053]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 27.808646] postgres[1053]: ); vm-test-run-plv8> server # [ 27.808836] postgres[1053]: vm-test-run-plv8> server # [ 27.808982] postgres[1053]: IF graphql_is_dropped vm-test-run-plv8> server # [ 27.809238] postgres[1053]: THEN vm-test-run-plv8> server # [ 27.809537] postgres[1053]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 27.809996] postgres[1053]: "operationName" text default null, vm-test-run-plv8> server # [ 27.810731] postgres[1053]: query text default null, vm-test-run-plv8> server # [ 27.811091] postgres[1053]: variables jsonb default null, vm-test-run-plv8> server # [ 27.811901] postgres[1053]: extensions jsonb default null vm-test-run-plv8> server # [ 27.812781] postgres[1053]: ) vm-test-run-plv8> server # [ 27.812901] postgres[1053]: returns jsonb vm-test-run-plv8> server # [ 27.813047] postgres[1053]: language plpgsql vm-test-run-plv8> server # [ 27.813718] postgres[1053]: as $$ vm-test-run-plv8> server # [ 27.813993] postgres[1053]: DECLARE vm-test-run-plv8> server # [ 27.814403] postgres[1053]: server_version float; vm-test-run-plv8> server # [ 27.814937] postgres[1053]: BEGIN vm-test-run-plv8> server # [ 27.815293] postgres[1053]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 27.816820] postgres[1053]: vm-test-run-plv8> server # [ 27.816931] postgres[1053]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 27.817356] postgres[1053]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 27.817571] postgres[1053]: 'data', null::jsonb, vm-test-run-plv8> server # [ 27.817780] postgres[1053]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-plv8> server # [ 27.818872] postgres[1053]: ); vm-test-run-plv8> server # [ 27.819274] postgres[1053]: ELSE vm-test-run-plv8> server # [ 27.819857] postgres[1053]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 27.820514] postgres[1053]: 'data', null::jsonb, vm-test-run-plv8> server # [ 27.821214] postgres[1053]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-plv8> server # [ 27.821970] postgres[1053]: ); vm-test-run-plv8> server # [ 27.822219] postgres[1053]: END IF; vm-test-run-plv8> server # [ 27.822373] postgres[1053]: END; vm-test-run-plv8> server # [ 27.822506] postgres[1053]: $$; vm-test-run-plv8> server # [ 27.822623] postgres[1053]: END IF; vm-test-run-plv8> server # [ 27.822934] postgres[1053]: vm-test-run-plv8> server # [ 27.823121] postgres[1053]: END; vm-test-run-plv8> server # [ 27.823476] postgres[1053]: $func$; vm-test-run-plv8> server # [ 27.824247] postgres[1053]: ::1 2026-10-05 10:42:47.045 UTC [1053] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-plv8> server # [ 27.825370] postgres[1053]: ::1 2026-10-05 10:42:47.045 UTC [1053] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-plv8> server # [ 27.826875] postgres[1053]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-plv8> server # [ 27.827863] postgres[1053]: ::1 2026-10-05 10:42:47.046 UTC [1053] 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 # [ 27.834727] postgres[1055]: ::1 2026-10-05 10:42:47.162 UTC [1055] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-plv8> server # [ 27.835674] postgres[1055]: ::1 2026-10-05 10:42:47.162 UTC [1055] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-plv8> server # [ 27.836492] postgres[1055]: ::1 2026-10-05 10:42:47.163 UTC [1055] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 27.837745] postgres[1055]: DECLARE vm-test-run-plv8> server # [ 27.837940] postgres[1055]: cmd record; vm-test-run-plv8> server # [ 27.838131] postgres[1055]: BEGIN vm-test-run-plv8> server # [ 27.838300] postgres[1055]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-plv8> server # [ 27.839492] postgres[1055]: LOOP vm-test-run-plv8> server # [ 27.840171] postgres[1055]: IF cmd.command_tag IN ( vm-test-run-plv8> server # [ 27.840414] postgres[1055]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-plv8> server # [ 27.840680] postgres[1055]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-plv8> server # [ 27.841673] postgres[1055]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-plv8> server # [ 27.842052] postgres[1055]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-plv8> server # [ 27.842461] postgres[1055]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-plv8> server # [ 27.843200] postgres[1055]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-plv8> server # [ 27.844477] postgres[1055]: , 'CREATE TRIGGER' vm-test-run-plv8> server # [ 27.844878] postgres[1055]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-plv8> server # [ 27.845464] postgres[1055]: , 'CREATE RULE' vm-test-run-plv8> server # [ 27.845604] postgres[1055]: , 'COMMENT' vm-test-run-plv8> server # [ 27.845839] postgres[1055]: ) vm-test-run-plv8> server # [ 27.846139] postgres[1055]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-plv8> server # [ 27.847244] postgres[1055]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-plv8> server # [ 27.848394] postgres[1055]: THEN vm-test-run-plv8> server # [ 27.848589] postgres[1055]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 27.848899] postgres[1055]: END IF; vm-test-run-plv8> server # [ 27.849230] postgres[1055]: END LOOP; vm-test-run-plv8> server # [ 27.849488] postgres[1055]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 27.849820] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1054]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-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 # [ 27.851766] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1054]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 27.852332] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1054]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-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 # [ 27.853308] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1054]: DROP FUNCTION vm-test-run-plv8> server # [ 27.853895] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1054]: CREATE FUNCTION vm-test-run-plv8> server # [ 27.854412] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1054]: CREATE FUNCTION vm-test-run-plv8> server # [ 27.856665] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1054]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 27.857658] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1054]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 27.858335] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1054]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 27.859311] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1054]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 27.860248] postgres[1055]: ::1 2026-10-05 10:42:47.168 UTC [1055] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-plv8> server # [ 27.861339] postgres[1055]: DECLARE vm-test-run-plv8> server # [ 27.861600] postgres[1055]: obj record; vm-test-run-plv8> server # [ 27.861931] postgres[1055]: BEGIN vm-test-run-plv8> server # [ 27.862175] postgres[1055]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-plv8> server # [ 27.863251] postgres[1055]: LOOP vm-test-run-plv8> server # [ 27.863708] postgres[1055]: IF obj.object_type IN ( vm-test-run-plv8> server # [ 27.864348] postgres[1055]: 'schema' vm-test-run-plv8> server # [ 27.864778] postgres[1055]: , 'table' vm-test-run-plv8> server # [ 27.865320] postgres[1055]: , 'foreign table' vm-test-run-plv8> server # [ 27.865786] postgres[1055]: , 'view' vm-test-run-plv8> server # [ 27.866251] postgres[1055]: , 'materialized view' vm-test-run-plv8> server # [ 27.866620] postgres[1055]: , 'function' vm-test-run-plv8> server # [ 27.866773] postgres[1055]: , 'trigger' vm-test-run-plv8> server # [ 27.866947] postgres[1055]: , 'type' vm-test-run-plv8> server # [ 27.867104] postgres[1055]: , 'rule' vm-test-run-plv8> server # [ 27.883639] postgres[1055]: ) vm-test-run-plv8> server # [ 27.906294] postgres[1055]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-plv8> server # [ 27.939049] postgres[1055]: THEN vm-test-run-plv8> server # [ 27.939505] postgres[1055]: NOTIFY pgrst, 'reload schema'; vm-test-run-plv8> server # [ 27.940620] postgres[1055]: END IF; vm-test-run-plv8> server # [ 27.941090] postgres[1055]: END LOOP; vm-test-run-plv8> server # [ 27.941400] postgres[1055]: END; $$ LANGUAGE plpgsql; vm-test-run-plv8> server # [ 27.942002] postgres[1055]: ::1 2026-10-05 10:42:47.169 UTC [1055] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-plv8> server # [ 27.943386] postgres[1055]: ::1 2026-10-05 10:42:47.171 UTC [1055] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-plv8> server # [ 27.945119] postgres[1055]: ON ddl_command_end vm-test-run-plv8> server # [ 27.945680] postgres[1055]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-plv8> server # [ 27.946396] postgres[1055]: ::1 2026-10-05 10:42:47.172 UTC [1055] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-plv8> server # [ 27.947784] postgres[1055]: ::1 2026-10-05 10:42:47.174 UTC [1055] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-plv8> server # [ 27.949070] postgres[1055]: ON sql_drop vm-test-run-plv8> server # [ 27.949307] postgres[1055]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-plv8> server # [ 27.952630] postgres[1057]: ::1 2026-10-05 10:42:47.272 UTC [1057] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-plv8> server # [ 27.953555] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-plv8> server # [ 27.954841] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1056]: ALTER ROLE vm-test-run-plv8> server # [ 27.995034] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-plv8> server # [ 28.071686] postgres[1059]: ::1 2026-10-05 10:42:47.399 UTC [1059] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 28.072906] postgres[1059]: returns event_trigger vm-test-run-plv8> server # [ 28.073094] postgres[1059]: language plpgsql vm-test-run-plv8> server # [ 28.073241] postgres[1059]: AS $func$ vm-test-run-plv8> server # [ 28.073379] postgres[1059]: DECLARE vm-test-run-plv8> server # [ 28.073683] postgres[1059]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 28.074025] postgres[1059]: BEGIN vm-test-run-plv8> server # [ 28.074132] postgres[1059]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 28.074767] postgres[1059]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 28.074941] postgres[1059]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 28.075248] postgres[1059]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 28.075963] postgres[1059]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 28.076867] postgres[1059]: ); vm-test-run-plv8> server # [ 28.077073] postgres[1059]: vm-test-run-plv8> server # [ 28.077268] postgres[1059]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 28.077532] postgres[1059]: THEN vm-test-run-plv8> server # [ 28.077760] postgres[1059]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 28.078262] postgres[1059]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 28.080404] postgres[1059]: vm-test-run-plv8> server # [ 28.080524] postgres[1059]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 28.080920] postgres[1059]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 28.081925] postgres[1059]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 28.082973] postgres[1059]: vm-test-run-plv8> server # [ 28.083218] postgres[1059]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 28.084151] postgres[1059]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 28.084515] postgres[1059]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 28.085212] postgres[1059]: "operationName" text default null, vm-test-run-plv8> server # [ 28.085615] postgres[1059]: query text default null, vm-test-run-plv8> server # [ 28.085883] postgres[1059]: variables jsonb default null, vm-test-run-plv8> server # [ 28.086640] postgres[1059]: extensions jsonb default null vm-test-run-plv8> server # [ 28.087076] postgres[1059]: ) vm-test-run-plv8> server # [ 28.087387] postgres[1059]: returns jsonb vm-test-run-plv8> server # [ 28.087784] postgres[1059]: language sql vm-test-run-plv8> server # [ 28.088149] postgres[1059]: as $$ vm-test-run-plv8> server # [ 28.088670] postgres[1059]: -- This changed vm-test-run-plv8> server # [ 28.088925] postgres[1059]: select graphql.resolve( vm-test-run-plv8> server # [ 28.089564] postgres[1059]: query := query, vm-test-run-plv8> server # [ 28.089929] postgres[1059]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 28.090246] postgres[1059]: "operationName" := "operationName", vm-test-run-plv8> server # [ 28.090458] postgres[1059]: extensions := extensions vm-test-run-plv8> server # [ 28.090651] postgres[1059]: ); vm-test-run-plv8> server # [ 28.090778] postgres[1059]: $$; vm-test-run-plv8> server # [ 28.090896] postgres[1059]: vm-test-run-plv8> server # [ 28.090994] postgres[1059]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 28.091349] postgres[1059]: END IF; vm-test-run-plv8> server # [ 28.091477] postgres[1059]: vm-test-run-plv8> server # [ 28.091574] postgres[1059]: END; vm-test-run-plv8> server # [ 28.091675] postgres[1059]: $func$; vm-test-run-plv8> server # [ 28.091805] postgres[1059]: ::1 2026-10-05 10:42:47.405 UTC [1059] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-plv8> server # [ 28.092770] postgres[1059]: RETURNS event_trigger vm-test-run-plv8> server # [ 28.093026] postgres[1059]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 28.093233] postgres[1059]: AS $func$ vm-test-run-plv8> server # [ 28.093409] postgres[1059]: DECLARE vm-test-run-plv8> server # [ 28.093645] postgres[1059]: graphql_is_dropped bool; vm-test-run-plv8> server # [ 28.093835] postgres[1059]: BEGIN vm-test-run-plv8> server # [ 28.093961] postgres[1059]: graphql_is_dropped = ( vm-test-run-plv8> server # [ 28.094125] postgres[1059]: SELECT ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 28.094386] postgres[1059]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-plv8> server # [ 28.095042] postgres[1059]: WHERE ev.schema_name = 'graphql_public' vm-test-run-plv8> server # [ 28.095368] postgres[1059]: ); vm-test-run-plv8> server # [ 28.095533] postgres[1059]: vm-test-run-plv8> server # [ 28.095673] postgres[1059]: IF graphql_is_dropped vm-test-run-plv8> server # [ 28.096213] postgres[1059]: THEN vm-test-run-plv8> server # [ 28.096564] postgres[1059]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 28.096956] postgres[1059]: "operationName" text default null, vm-test-run-plv8> server # [ 28.097304] postgres[1059]: query text default null, vm-test-run-plv8> server # [ 28.097640] postgres[1059]: variables jsonb default null, vm-test-run-plv8> server # [ 28.097834] postgres[1059]: extensions jsonb default null vm-test-run-plv8> server # [ 28.098019] postgres[1059]: ) vm-test-run-plv8> server # [ 28.098131] postgres[1059]: returns jsonb vm-test-run-plv8> server # [ 28.098279] postgres[1059]: language plpgsql vm-test-run-plv8> server # [ 28.098435] postgres[1059]: as $$ vm-test-run-plv8> server # [ 28.098557] postgres[1059]: DECLARE vm-test-run-plv8> server # [ 28.098691] postgres[1059]: server_version float; vm-test-run-plv8> server # [ 28.098868] postgres[1059]: BEGIN vm-test-run-plv8> server # [ 28.098996] postgres[1059]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 28.099293] postgres[1059]: vm-test-run-plv8> server # [ 28.099383] postgres[1059]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 28.099573] postgres[1059]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 28.099765] postgres[1059]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 28.099972] postgres[1059]: jsonb_build_object( vm-test-run-plv8> server # [ 28.100281] postgres[1059]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 28.100556] postgres[1059]: ) vm-test-run-plv8> server # [ 28.100715] postgres[1059]: ) vm-test-run-plv8> server # [ 28.101025] postgres[1059]: ); vm-test-run-plv8> server # [ 28.101177] postgres[1059]: ELSE vm-test-run-plv8> server # [ 28.101325] postgres[1059]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 28.101523] postgres[1059]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 28.101741] postgres[1059]: jsonb_build_object( vm-test-run-plv8> server # [ 28.101979] postgres[1059]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 28.102372] postgres[1059]: ) vm-test-run-plv8> server # [ 28.102543] postgres[1059]: ) vm-test-run-plv8> server # [ 28.102710] postgres[1059]: ); vm-test-run-plv8> server # [ 28.102883] postgres[1059]: END IF; vm-test-run-plv8> server # [ 28.103157] postgres[1059]: END; vm-test-run-plv8> server # [ 28.103303] postgres[1059]: $$; vm-test-run-plv8> server # [ 28.103433] postgres[1059]: END IF; vm-test-run-plv8> server # [ 28.103564] postgres[1059]: vm-test-run-plv8> server # [ 28.103665] postgres[1059]: END; vm-test-run-plv8> server # [ 28.103788] postgres[1059]: $func$; vm-test-run-plv8> server # [ 28.103911] postgres[1059]: ::1 2026-10-05 10:42:47.408 UTC [1059] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 28.104506] postgres[1059]: "operationName" text default null, vm-test-run-plv8> server # [ 28.104702] postgres[1059]: query text default null, vm-test-run-plv8> server # [ 28.104874] postgres[1059]: variables jsonb default null, vm-test-run-plv8> server # [ 28.105222] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1058]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.105472] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1058]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.105952] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1058]: CREATE FUNCTION vm-test-run-plv8> server # [ 28.106444] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1058]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping vm-test-run-plv8> server # [ 28.108148] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1058]: DROP EXTENSION vm-test-run-plv8> server # [ 28.108413] postgres[1059]: extensions jsonb default null vm-test-run-plv8> server # [ 28.108609] postgres[1059]: ) vm-test-run-plv8> server # [ 28.108959] postgres[1059]: returns jsonb vm-test-run-plv8> server # [ 28.109195] postgres[1059]: language plpgsql vm-test-run-plv8> server # [ 28.109414] postgres[1059]: as $$ vm-test-run-plv8> server # [ 28.109587] postgres[1059]: DECLARE vm-test-run-plv8> server # [ 28.109807] postgres[1059]: server_version float; vm-test-run-plv8> server # [ 28.110064] postgres[1059]: BEGIN vm-test-run-plv8> server # [ 28.110269] postgres[1059]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-plv8> server # [ 28.110600] postgres[1059]: vm-test-run-plv8> server # [ 28.110710] postgres[1059]: IF server_version >= 14 THEN vm-test-run-plv8> server # [ 28.110922] postgres[1059]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 28.111127] postgres[1059]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 28.111657] postgres[1059]: jsonb_build_object( vm-test-run-plv8> server # [ 28.111955] postgres[1059]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-plv8> server # [ 28.112553] postgres[1059]: ) vm-test-run-plv8> server # [ 28.112790] postgres[1059]: ) vm-test-run-plv8> server # [ 28.112991] postgres[1059]: ); vm-test-run-plv8> server # [ 28.113341] postgres[1059]: ELSE vm-test-run-plv8> server # [ 28.113479] postgres[1059]: RETURN jsonb_build_object( vm-test-run-plv8> server # [ 28.113733] postgres[1059]: 'errors', jsonb_build_array( vm-test-run-plv8> server # [ 28.114031] postgres[1059]: jsonb_build_object( vm-test-run-plv8> server # [ 28.114233] postgres[1059]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-plv8> server # [ 28.114744] postgres[1059]: ) vm-test-run-plv8> server # [ 28.114900] postgres[1059]: ) vm-test-run-plv8> server # [ 28.115047] postgres[1059]: ); vm-test-run-plv8> server # [ 28.115183] postgres[1059]: END IF; vm-test-run-plv8> server # [ 28.115475] postgres[1059]: END; vm-test-run-plv8> server # [ 28.115680] postgres[1059]: $$; vm-test-run-plv8> server # [ 28.115845] postgres[1059]: ::1 2026-10-05 10:42:47.410 UTC [1059] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 29.040222] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1058]: DO vm-test-run-plv8> server # [ 29.066369] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql vm-test-run-plv8> server # [ 29.127673] postgres[1065]: ::1 2026-10-05 10:42:48.455 UTC [1065] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-plv8> server # [ 29.129579] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1064]: GRANT ROLE vm-test-run-plv8> server # [ 29.137328] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-plv8> server # [ 29.200811] postgres[1067]: ::1 2026-10-05 10:42:48.528 UTC [1067] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 29.201658] postgres[1067]: returns event_trigger vm-test-run-plv8> server # [ 29.201939] postgres[1067]: language plpgsql vm-test-run-plv8> server # [ 29.202200] postgres[1067]: AS $func$ vm-test-run-plv8> server # [ 29.202647] postgres[1067]: DECLARE vm-test-run-plv8> server # [ 29.203214] postgres[1067]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 29.203560] postgres[1067]: BEGIN vm-test-run-plv8> server # [ 29.203772] postgres[1067]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 29.204298] postgres[1067]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 29.204587] postgres[1067]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 29.204951] postgres[1067]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 29.205539] postgres[1067]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 29.205722] postgres[1067]: ); vm-test-run-plv8> server # [ 29.206469] postgres[1067]: vm-test-run-plv8> server # [ 29.206779] postgres[1067]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 29.206969] postgres[1067]: THEN vm-test-run-plv8> server # [ 29.207093] postgres[1067]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 29.207446] postgres[1067]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 29.207688] postgres[1067]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 29.208498] postgres[1067]: "operationName" text default null, vm-test-run-plv8> server # [ 29.209132] postgres[1067]: query text default null, vm-test-run-plv8> server # [ 29.209345] postgres[1067]: variables jsonb default null, vm-test-run-plv8> server # [ 29.209787] postgres[1067]: extensions jsonb default null vm-test-run-plv8> server # [ 29.210120] postgres[1067]: ) vm-test-run-plv8> server # [ 29.210802] postgres[1067]: returns jsonb vm-test-run-plv8> server # [ 29.211429] postgres[1067]: language sql vm-test-run-plv8> server # [ 29.211972] postgres[1067]: as $$ vm-test-run-plv8> server # [ 29.212403] postgres[1067]: select graphql.resolve( vm-test-run-plv8> server # [ 29.212819] postgres[1067]: query := query, vm-test-run-plv8> server # [ 29.213139] postgres[1067]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 29.213534] postgres[1067]: "operationName" := "operationName", vm-test-run-plv8> server # [ 29.214041] postgres[1067]: extensions := extensions vm-test-run-plv8> server # [ 29.214274] postgres[1067]: ); vm-test-run-plv8> server # [ 29.214409] postgres[1067]: $$; vm-test-run-plv8> server # [ 29.214533] postgres[1067]: vm-test-run-plv8> server # [ 29.214631] postgres[1067]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 29.214980] postgres[1067]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 29.215356] postgres[1067]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 29.215700] postgres[1067]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 29.216036] postgres[1067]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 29.216383] postgres[1067]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 29.216734] postgres[1067]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 29.217076] postgres[1067]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 29.217491] postgres[1067]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 29.218315] postgres[1067]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 29.218947] postgres[1067]: END IF; vm-test-run-plv8> server # [ 29.219141] postgres[1067]: vm-test-run-plv8> server # [ 29.219348] postgres[1067]: END; vm-test-run-plv8> server # [ 29.219520] postgres[1067]: $func$; vm-test-run-plv8> server # [ 29.219734] postgres[1067]: ::1 2026-10-05 10:42:48.535 UTC [1067] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 29.220676] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1066]: CREATE FUNCTION vm-test-run-plv8> server # [ 29.221011] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1066]: DROP EXTENSION vm-test-run-plv8> server # [ 30.059476] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1066]: DO vm-test-run-plv8> server # [ 30.069647] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-plv8> server # [ 30.447996] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1072]: DO vm-test-run-plv8> server # [ 30.922254] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1072]: DO vm-test-run-plv8> server # [ 30.932219] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-plv8> server # [ 31.000984] postgres[1080]: ::1 2026-10-05 10:42:50.328 UTC [1080] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-plv8> server # [ 31.002759] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1079]: ALTER ROLE vm-test-run-plv8> server # [ 31.011051] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-plv8> server # [ 31.054605] postgres[1082]: ::1 2026-10-05 10:42:50.382 UTC [1082] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-plv8> server # [ 31.057201] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1081]: REVOKE ROLE vm-test-run-plv8> server # [ 31.065073] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-plv8> server # [ 32.038649] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1083]: DO vm-test-run-plv8> server # [ 32.055984] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-plv8> server # [ 32.194598] postgres[1090]: ::1 2026-10-05 10:42:51.521 UTC [1090] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-plv8> server # [ 32.202208] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1089]: GRANT ROLE vm-test-run-plv8> server # [ 32.249851] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-plv8> server # [ 32.312671] postgres[1092]: ::1 2026-10-05 10:42:51.640 UTC [1092] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 32.314720] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1091]: GRANT vm-test-run-plv8> server # [ 32.315121] postgres[1092]: ::1 2026-10-05 10:42:51.642 UTC [1092] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 32.317146] postgres[1092]: ::1 2026-10-05 10:42:51.645 UTC [1092] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-plv8> server # [ 32.318073] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1091]: GRANT vm-test-run-plv8> server # [ 32.318500] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1091]: GRANT vm-test-run-plv8> server # [ 32.319225] postgres[1092]: ::1 2026-10-05 10:42:51.645 UTC [1092] 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 # [ 32.320609] postgres[1092]: ::1 2026-10-05 10:42:51.646 UTC [1092] 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 # [ 32.322895] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1091]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 32.323160] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1091]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 32.323669] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1091]: ALTER DEFAULT PRIVILEGES vm-test-run-plv8> server # [ 32.324430] postgres[1092]: ::1 2026-10-05 10:42:51.648 UTC [1092] 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 # [ 32.332223] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-plv8> server # [ 32.400726] postgres[1094]: ::1 2026-10-05 10:42:51.728 UTC [1094] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-plv8> server # [ 32.403855] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1093]: GRANT ROLE vm-test-run-plv8> server # [ 32.418349] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 32.477705] postgres[1096]: ::1 2026-10-05 10:42:51.805 UTC [1096] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-plv8> server # [ 32.479218] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1095]: GRANT ROLE vm-test-run-plv8> server # [ 32.492253] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-plv8> server # [ 32.525689] postgres[1098]: ::1 2026-10-05 10:42:51.853 UTC [1098] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-plv8> server # [ 32.526906] postgres[1098]: ::1 2026-10-05 10:42:51.855 UTC [1098] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-plv8> server # [ 32.528531] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1097]: ALTER ROLE vm-test-run-plv8> server # [ 32.528906] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1097]: ALTER ROLE vm-test-run-plv8> server # [ 32.529402] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1097]: ALTER ROLE vm-test-run-plv8> server # [ 32.529860] postgres[1098]: ::1 2026-10-05 10:42:51.855 UTC [1098] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-plv8> server # [ 32.530884] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1097]: DO vm-test-run-plv8> server # [ 32.535328] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-plv8> server # [ 32.572908] postgres[1100]: ::1 2026-10-05 10:42:51.900 UTC [1100] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-plv8> server # [ 32.574335] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1099]: GRANT ROLE vm-test-run-plv8> server # [ 32.575112] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1099]: REVOKE ROLE vm-test-run-plv8> server # [ 32.575809] postgres[1100]: ::1 2026-10-05 10:42:51.902 UTC [1100] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-plv8> server # [ 32.581661] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-plv8> server # [ 32.614884] postgres[1102]: ::1 2026-10-05 10:42:51.942 UTC [1102] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-plv8> server # [ 32.615659] postgres[1102]: returns event_trigger vm-test-run-plv8> server # [ 32.616185] postgres[1102]: language plpgsql vm-test-run-plv8> server # [ 32.616451] postgres[1102]: AS $func$ vm-test-run-plv8> server # [ 32.616645] postgres[1102]: DECLARE vm-test-run-plv8> server # [ 32.616866] postgres[1102]: func_is_graphql_resolve bool; vm-test-run-plv8> server # [ 32.617148] postgres[1102]: BEGIN vm-test-run-plv8> server # [ 32.618292] postgres[1102]: func_is_graphql_resolve = ( vm-test-run-plv8> server # [ 32.623556] postgres[1102]: SELECT n.proname = 'resolve' vm-test-run-plv8> server # [ 32.629319] postgres[1102]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 32.642199] postgres[1102]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-plv8> server # [ 32.642523] postgres[1102]: ON ev.objid = n.oid vm-test-run-plv8> server # [ 32.642759] postgres[1102]: ); vm-test-run-plv8> server # [ 32.642922] postgres[1102]: vm-test-run-plv8> server # [ 32.643059] postgres[1102]: IF func_is_graphql_resolve vm-test-run-plv8> server # [ 32.646062] postgres[1102]: THEN vm-test-run-plv8> server # [ 32.647565] postgres[1102]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-plv8> server # [ 32.648827] postgres[1102]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-plv8> server # [ 32.650095] postgres[1102]: create or replace function graphql_public.graphql( vm-test-run-plv8> server # [ 32.650859] postgres[1102]: "operationName" text default null, vm-test-run-plv8> server # [ 32.651491] postgres[1102]: query text default null, vm-test-run-plv8> server # [ 32.655334] postgres[1102]: variables jsonb default null, vm-test-run-plv8> server # [ 32.655745] postgres[1102]: extensions jsonb default null vm-test-run-plv8> server # [ 32.656822] postgres[1102]: ) vm-test-run-plv8> server # [ 32.658865] postgres[1102]: returns jsonb vm-test-run-plv8> server # [ 32.660941] postgres[1102]: language sql vm-test-run-plv8> server # [ 32.662092] postgres[1102]: as $$ vm-test-run-plv8> server # [ 32.666801] postgres[1102]: select graphql.resolve( vm-test-run-plv8> server # [ 32.667304] postgres[1102]: query := query, vm-test-run-plv8> server # [ 32.668203] postgres[1102]: variables := coalesce(variables, '{}'), vm-test-run-plv8> server # [ 32.668589] postgres[1102]: "operationName" := "operationName", vm-test-run-plv8> server # [ 32.670513] postgres[1102]: extensions := extensions vm-test-run-plv8> server # [ 32.671522] postgres[1102]: ); vm-test-run-plv8> server # [ 32.675324] postgres[1102]: $$; vm-test-run-plv8> server # [ 32.675468] postgres[1102]: vm-test-run-plv8> server # [ 32.675564] postgres[1102]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-plv8> server # [ 32.677732] postgres[1102]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-plv8> server # [ 32.678700] postgres[1102]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-plv8> server # [ 32.680442] postgres[1102]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 32.685351] postgres[1102]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 32.687364] postgres[1102]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 32.692341] postgres[1102]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 32.694228] postgres[1102]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 32.696062] postgres[1102]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 32.697451] postgres[1102]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-plv8> server # [ 32.698089] postgres[1102]: vm-test-run-plv8> server # [ 32.698344] postgres[1102]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-plv8> server # [ 32.700846] postgres[1102]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-plv8> server # [ 32.701917] postgres[1102]: grant usage on schema graphql to postgres with grant option; vm-test-run-plv8> server # [ 32.704457] postgres[1102]: END IF; vm-test-run-plv8> server # [ 32.705582] postgres[1102]: vm-test-run-plv8> server # [ 32.708739] postgres[1102]: END; vm-test-run-plv8> server # [ 32.708969] postgres[1102]: $func$; vm-test-run-plv8> server # [ 32.710382] postgres[1102]: ::1 2026-10-05 10:42:51.950 UTC [1102] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-plv8> server # [ 32.714380] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1101]: CREATE FUNCTION vm-test-run-plv8> server # [ 32.719313] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1101]: DROP EXTENSION vm-test-run-plv8> server # [ 33.448145] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1101]: DO vm-test-run-plv8> server # [ 33.458653] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-plv8> server # [ 33.559690] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1107]: DO vm-test-run-plv8> server # [ 33.560502] postgres[1108]: ::1 2026-10-05 10:42:52.887 UTC [1108] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-plv8> server # [ 33.562451] postgres[1108]: LANGUAGE plpgsql vm-test-run-plv8> server # [ 33.563190] postgres[1108]: AS $$ vm-test-run-plv8> server # [ 33.564182] postgres[1108]: BEGIN vm-test-run-plv8> server # [ 33.564656] postgres[1108]: IF EXISTS ( vm-test-run-plv8> server # [ 33.564994] postgres[1108]: SELECT vm-test-run-plv8> server # [ 33.565385] postgres[1108]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-plv8> server # [ 33.565992] postgres[1108]: JOIN pg_extension AS ext vm-test-run-plv8> server # [ 33.566715] postgres[1108]: ON ev.objid = ext.oid vm-test-run-plv8> server # [ 33.567248] postgres[1108]: WHERE ext.extname = 'pg_cron' vm-test-run-plv8> server # [ 33.568672] postgres[1108]: ) vm-test-run-plv8> server # [ 33.568857] postgres[1108]: THEN vm-test-run-plv8> server # [ 33.569200] postgres[1108]: grant usage on schema cron to postgres with grant option; vm-test-run-plv8> server # [ 33.571033] postgres[1108]: vm-test-run-plv8> server # [ 33.571863] postgres[1108]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-plv8> server # [ 33.572373] postgres[1108]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-plv8> server # [ 33.576155] postgres[1108]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-plv8> server # [ 33.577685] postgres[1108]: vm-test-run-plv8> server # [ 33.578296] postgres[1108]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 33.583767] postgres[1108]: on sequences to postgres with grant option; vm-test-run-plv8> server # [ 33.585392] postgres[1108]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 33.585958] postgres[1108]: on tables to postgres with grant option; vm-test-run-plv8> server # [ 33.586339] postgres[1108]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-plv8> server # [ 33.587479] postgres[1108]: on functions to postgres with grant option; vm-test-run-plv8> server # [ 33.587749] postgres[1108]: vm-test-run-plv8> server # [ 33.587851] postgres[1108]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-plv8> server # [ 33.588563] postgres[1108]: revoke all on table cron.job from postgres; vm-test-run-plv8> server # [ 33.588884] postgres[1108]: grant select on table cron.job to postgres with grant option; vm-test-run-plv8> server # [ 33.589277] postgres[1108]: END IF; vm-test-run-plv8> server # [ 33.589403] postgres[1108]: END; vm-test-run-plv8> server # [ 33.589517] postgres[1108]: $$; vm-test-run-plv8> server # [ 33.589646] postgres[1108]: ::1 2026-10-05 10:42:52.895 UTC [1108] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-plv8> server # [ 33.590726] postgres[1108]: ::1 2026-10-05 10:42:52.915 UTC [1108] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-plv8> server # [ 33.591479] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1107]: CREATE FUNCTION vm-test-run-plv8> server # [ 33.591892] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1107]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 33.593027] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1107]: ALTER FUNCTION vm-test-run-plv8> server # [ 33.594033] postgres[1108]: ::1 2026-10-05 10:42:52.921 UTC [1108] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-plv8> server # [ 33.595540] postgres[1108]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-plv8> server # [ 33.595751] postgres[1108]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-plv8> server # [ 33.597921] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1107]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 33.623379] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-plv8> server # [ 33.718886] postgres[1110]: ::1 2026-10-05 10:42:53.046 UTC [1110] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-plv8> server # [ 33.721671] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1109]: ALTER ROLE vm-test-run-plv8> server # [ 33.744655] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-plv8> server # [ 33.804936] postgres[1112]: ::1 2026-10-05 10:42:53.132 UTC [1112] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-plv8> server # [ 33.809623] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1111]: ALTER FUNCTION vm-test-run-plv8> server # [ 33.810141] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1111]: ALTER FUNCTION vm-test-run-plv8> server # [ 33.811068] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1111]: ALTER FUNCTION vm-test-run-plv8> server # [ 33.813526] postgres[1112]: ::1 2026-10-05 10:42:53.135 UTC [1112] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-plv8> server # [ 33.814777] postgres[1112]: ::1 2026-10-05 10:42:53.136 UTC [1112] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-plv8> server # [ 33.826502] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-plv8> server # [ 33.887883] postgres[1114]: ::1 2026-10-05 10:42:53.214 UTC [1114] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-plv8> server # [ 33.906843] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1113]: GRANT ROLE vm-test-run-plv8> server # [ 33.910273] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-plv8> server # [ 34.325087] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1115]: DO vm-test-run-plv8> server # [ 34.335094] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-plv8> server # [ 34.393756] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1121]: DO vm-test-run-plv8> server # [ 34.394571] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1121]: DO vm-test-run-plv8> server # [ 34.410080] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-plv8> server # [ 34.461405] postgres[1125]: ::1 2026-10-05 10:42:53.789 UTC [1125] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-plv8> server # [ 34.466310] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1124]: ALTER ROLE vm-test-run-plv8> server # [ 34.468361] postgres[1125]: ::1 2026-10-05 10:42:53.795 UTC [1125] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-plv8> server # [ 34.469038] postgres[1125]: ::1 2026-10-05 10:42:53.795 UTC [1125] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-plv8> server # [ 34.472058] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1124]: ALTER ROLE vm-test-run-plv8> server # [ 34.472441] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1124]: ALTER ROLE vm-test-run-plv8> server # [ 34.480982] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-plv8> server # [ 34.638361] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1126]: DO vm-test-run-plv8> server # [ 34.642666] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-plv8> server # [ 34.677173] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1128]: DO vm-test-run-plv8> server # [ 34.681770] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-plv8> server # [ 34.719245] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1130]: CREATE FUNCTION vm-test-run-plv8> server # [ 34.720821] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1130]: DO vm-test-run-plv8> server # [ 34.724723] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-plv8> server # [ 34.764260] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1132]: ALTER FUNCTION vm-test-run-plv8> server # [ 34.765769] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1132]: GRANT vm-test-run-plv8> server # [ 34.774746] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-plv8> server # [ 34.822596] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1134]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 34.826502] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1134]: ALTER FUNCTION vm-test-run-plv8> server # [ 34.829441] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1134]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 34.838616] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 34.984524] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1136]: DO vm-test-run-plv8> server # [ 34.997098] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-plv8> server # [ 35.035633] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1138]: CREATE FUNCTION vm-test-run-plv8> server # [ 35.037096] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1138]: GRANT vm-test-run-plv8> server # [ 35.043941] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-plv8> server # [ 35.076545] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1140]: REVOKE ROLE vm-test-run-plv8> server # [ 35.080142] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1140]: DO vm-test-run-plv8> server # [ 35.081548] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1140]: DO vm-test-run-plv8> server # [ 35.083381] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1140]: REVOKE ROLE vm-test-run-plv8> server # [ 35.084958] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1140]: REVOKE vm-test-run-plv8> server # [ 35.086993] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1140]: DO vm-test-run-plv8> server # [ 35.096891] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-plv8> server # [ 35.177269] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1142]: DO vm-test-run-plv8> server # [ 35.188906] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 35.375292] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1144]: DO vm-test-run-plv8> server # [ 35.379627] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-plv8> server # [ 35.418030] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1146]: DO vm-test-run-plv8> server # [ 35.422027] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-plv8> server # [ 35.455881] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1148]: ALTER ROLE vm-test-run-plv8> server # [ 35.460324] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-plv8> server # [ 35.505978] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1150]: GRANT ROLE vm-test-run-plv8> server # [ 35.513807] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1150]: DO vm-test-run-plv8> server # [ 35.551099] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-plv8> server # [ 35.662530] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1152]: GRANT vm-test-run-plv8> server # [ 35.677564] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-plv8> server # [ 35.754339] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1158]: CREATE FUNCTION vm-test-run-plv8> server # [ 35.755318] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1158]: REVOKE vm-test-run-plv8> server # [ 35.756790] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1158]: REVOKE vm-test-run-plv8> server # [ 35.757922] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1158]: GRANT vm-test-run-plv8> server # [ 35.766240] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-plv8> server # [ 35.820058] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1160]: DO vm-test-run-plv8> server # [ 35.826561] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-plv8> server # [ 35.861589] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1162]: ALTER ROLE vm-test-run-plv8> server # [ 35.867366] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-plv8> server # [ 36.022144] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1164]: DROP EXTENSION vm-test-run-plv8> server # [ 36.032623] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-plv8> server # [ 36.069840] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1166]: CREATE FUNCTION vm-test-run-plv8> server # [ 36.072117] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1166]: DROP EVENT TRIGGER vm-test-run-plv8> server # [ 36.072806] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1166]: CREATE EVENT TRIGGER vm-test-run-plv8> server # [ 36.080433] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-plv8> server # [ 36.117350] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1168]: DO vm-test-run-plv8> server # [ 36.126157] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1168]: CREATE FUNCTION vm-test-run-plv8> server # [ 36.193723] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Running postgresql schema... vm-test-run-plv8> server # [ 36.263698] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER DATABASE vm-test-run-plv8> server # [ 36.264682] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER DATABASE vm-test-run-plv8> server # [ 36.268765] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER ROLE vm-test-run-plv8> server # [ 36.272179] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER ROLE vm-test-run-plv8> server # [ 36.274844] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER ROLE vm-test-run-plv8> server # [ 36.277417] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER ROLE vm-test-run-plv8> server # [ 36.279825] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER ROLE vm-test-run-plv8> server # [ 36.282420] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER ROLE vm-test-run-plv8> server # [ 36.285362] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER ROLE vm-test-run-plv8> server # [ 36.287849] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER ROLE vm-test-run-plv8> server # [ 36.290500] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER ROLE vm-test-run-plv8> server # [ 36.291357] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[1170]: ALTER ROLE vm-test-run-plv8> server # [ 36.295328] 117655b2s7fndch0xgz2kp96h7sq1d6v-supabase-db-init[994]: Database initialization complete vm-test-run-plv8> server # [ 36.297342] systemd[1]: Finished Supabase Database Initialization. vm-test-run-plv8> server # [ 36.297951] systemd[1]: Reached target Multi-User System. vm-test-run-plv8> server # [ 36.298792] systemd[1]: Startup finished in 4.207s (kernel) + 32.090s (userspace) = 36.298s. vm-test-run-plv8> server: (finished: waiting for unit supabase-db-init.service, in 37.22 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.06 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.31 seconds) vm-test-run-plv8> (finished: subtest: Verify PostgreSQL 15 is our custom build, in 0.37 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.08 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.20 seconds) vm-test-run-plv8> (finished: subtest: Verify ansible config loaded, in 0.28 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.14 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.13 seconds) vm-test-run-plv8> (finished: subtest: Verify init scripts and migrations ran, in 0.27 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.22 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 2.42 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.08 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.09 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.5' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.5' CASCADE;" , in 1.78 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.22 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.05 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 1.88 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.10 seconds) vm-test-run-plv8> (finished: subtest: Check upgrade path with postgresql 15, in 6.84 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.11 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.61 seconds) vm-test-run-plv8> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" vm-test-run-plv8> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.11 seconds) vm-test-run-plv8> (finished: subtest: Check the install of the last version of the extension, in 0.82 seconds) vm-test-run-plv8> (finished: run the VM test script, in 46.76 seconds) vm-test-run-plv8> test script finished in 46.93s vm-test-run-plv8> cleanup vm-test-run-plv8> kill machine (pid 87246) vm-test-run-plv8> qemu-system-aarch64: terminating on signal 15 from pid 87244 () vm-test-run-plv8> vde_switch: EOF data port: Interrupted system call vm-test-run-plv8> vde_switch: Reading data: Connection reset by peer vm-test-run-plv8> kill vlan (pid 87245) vm-test-run-plv8> vde_switch: EOF on stdin, cleaning up and exiting vm-test-run-plv8> vde_switch: Caught signal 15, cleaning up and exiting vm-test-run-plv8> (finished: cleanup, in 0.00 seconds)