these 9 derivations will be built: /nix/store/gjgy2nyyfahc3wn7zqnpqvpscpqsrqpr-system-units.drv /nix/store/z6ldfhhd9jg8cr0vl719h0kahnlxz8jr-etc.drv /nix/store/dkk6s57hgadzjx87jgc53hf5m14ij6a9-activate.drv /nix/store/nbs0z6wyfp6bz93c85fkdvyhrsvzk25s-nixos-system-server-test.drv /nix/store/4xnazmzx5cnhlddp2wx01i4qcrybnybg-closure-info.drv /nix/store/dhqa0sq0k77rg049k96wc9x07qn5gzyf-run-nixos-vm.drv /nix/store/lipc521imi5g45053w97k21is0ay8hl7-nixos-vm.drv /nix/store/p4h85mkxz5ilnkn5hv9vbfliw3k1kmj7-nixos-test-driver-timescaledb.drv /nix/store/f3l0mlwa0rnimvfz6fpvfdd6q973czxf-vm-test-run-timescaledb.drv building '/nix/store/p4h85mkxz5ilnkn5hv9vbfliw3k1kmj7-nixos-test-driver-timescaledb.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/p4h85mkxz5ilnkn5hv9vbfliw3k1kmj7-nixos-test-driver-timescaledb.drv' nixos-test-driver-timescaledb> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-timescaledb> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-timescaledb> Success: no issues found in 1 source file nixos-test-driver-timescaledb> additionally exposed symbols: nixos-test-driver-timescaledb> , nixos-test-driver-timescaledb> , nixos-test-driver-timescaledb> 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-timescaledb> Linting test script (enable/disable: config.skipLint) nixos-test-driver-timescaledb> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint building '/nix/store/f3l0mlwa0rnimvfz6fpvfdd6q973czxf-vm-test-run-timescaledb.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/f3l0mlwa0rnimvfz6fpvfdd6q973czxf-vm-test-run-timescaledb.drv' vm-test-run-timescaledb> Machine state will be reset. To keep it, pass --keep-vm-state vm-test-run-timescaledb> start all VLans vm-test-run-timescaledb> start vlan vm-test-run-timescaledb> running vlan (pid 7; ctl /build/vde1.ctl) vm-test-run-timescaledb> (finished: start all VLans, in 0.00 seconds) vm-test-run-timescaledb> Test will time out and terminate in 3600 seconds vm-test-run-timescaledb> run the VM test script vm-test-run-timescaledb> additionally exposed symbols: vm-test-run-timescaledb> server, vm-test-run-timescaledb> vlan1, vm-test-run-timescaledb> 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-timescaledb> start all VMs vm-test-run-timescaledb> server: starting vm vm-test-run-timescaledb> mke2fs 1.47.3 (8-Jul-2025) vm-test-run-timescaledb> qemu-system-aarch64: Could not access KVM kernel module: No such file or directory vm-test-run-timescaledb> qemu-system-aarch64: failed to initialize kvm: No such file or directory vm-test-run-timescaledb> qemu-system-aarch64: falling back to tcg vm-test-run-timescaledb> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-timescaledb> server # Formatting '/build/vm-state-server/tmp.XQJs3wLoSy', fmt=raw size=1073741824 vm-test-run-timescaledb> server # Discarding device blocks: 0/262144 done vm-test-run-timescaledb> server # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-timescaledb> server # Filesystem UUID: c753bb2c-6f3e-48d6-97bb-738712d011ec vm-test-run-timescaledb> server # Superblock backups stored on blocks: vm-test-run-timescaledb> server # 32768, 98304, 163840, 229376 vm-test-run-timescaledb> server # vm-test-run-timescaledb> server # Allocating group tables: 0/8 done vm-test-run-timescaledb> server # Writing inode tables: 0/8 done vm-test-run-timescaledb> server # Creating journal (8192 blocks): done vm-test-run-timescaledb> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-timescaledb> server # vm-test-run-timescaledb> server # Virtualisation disk image created. vm-test-run-timescaledb> server: QEMU running (pid 9) vm-test-run-timescaledb> (finished: start all VMs, in 0.14 seconds) vm-test-run-timescaledb> server: waiting for unit supabase-db-init.service vm-test-run-timescaledb> server: waiting for the VM to finish booting vm-test-run-timescaledb> server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510] vm-test-run-timescaledb> 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-timescaledb> server # [ 0.000000] KASLR enabled vm-test-run-timescaledb> server # [ 0.000000] random: crng init done vm-test-run-timescaledb> server # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-timescaledb> server # [ 0.000000] efi: UEFI not found. vm-test-run-timescaledb> server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-timescaledb> server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f602200-0x13f60593f] vm-test-run-timescaledb> server # [ 0.000000] Zone ranges: vm-test-run-timescaledb> server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] vm-test-run-timescaledb> server # [ 0.000000] DMA32 empty vm-test-run-timescaledb> server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] Device empty vm-test-run-timescaledb> server # [ 0.000000] Movable zone start for each node vm-test-run-timescaledb> server # [ 0.000000] Early memory node ranges vm-test-run-timescaledb> server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -1 vm-test-run-timescaledb> server # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-timescaledb> server # [ 0.000000] psci: PSCIv1.1 detected in firmware. vm-test-run-timescaledb> server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-timescaledb> server # [ 0.000000] psci: Trusted OS migration not required vm-test-run-timescaledb> server # [ 0.000000] psci: SMC Calling Convention v1.0 vm-test-run-timescaledb> server # [ 0.000000] percpu: Embedded 88 pages/cpu s180056 r65536 d114856 u360448 vm-test-run-timescaledb> server # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: GIC system register CPU interface vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: HCRX_EL2 register vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2) vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-timescaledb> server # [ 0.000000] alternatives: applying boot alternatives vm-test-run-timescaledb> 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/vvmmy32pnyf743rwivm8k9bbp085kbxf-nixos-system-server-test/init regInfo=/nix/store/yszjwpyc77nrlx83rzp793lq8h9ny08p-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-timescaledb> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/yszjwpyc77nrlx83rzp793lq8h9ny08p-closure-info/registration", will be passed to user space. vm-test-run-timescaledb> server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-timescaledb> server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-timescaledb> server # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-timescaledb> server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 vm-test-run-timescaledb> server # [ 0.000000] Policy zone: Normal vm-test-run-timescaledb> server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-timescaledb> server # [ 0.000000] software IO TLB: area num 2. vm-test-run-timescaledb> server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) vm-test-run-timescaledb> server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm-test-run-timescaledb> server # [ 0.000000] allocated 8388608 bytes of page_ext vm-test-run-timescaledb> server # [ 0.000000] ftrace: allocating 72257 entries in 283 pages vm-test-run-timescaledb> server # [ 0.000000] ftrace: allocated 283 pages with 5 groups vm-test-run-timescaledb> server # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. vm-test-run-timescaledb> server # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-timescaledb> server # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-timescaledb> server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm-test-run-timescaledb> 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-timescaledb> 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-timescaledb> server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-timescaledb> server # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-timescaledb> server # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-timescaledb> server # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-timescaledb> server # [ 0.000000] GICv3: GICv3 features: 16 PPIs vm-test-run-timescaledb> server # [ 0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 vm-test-run-timescaledb> server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-timescaledb> server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-timescaledb> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100ae0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-timescaledb> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100af0000 (flat, esz 8, psz 64K, shr 1) vm-test-run-timescaledb> server # [ 0.000000] GICv3: using LPI property table @0x0000000100b00000 vm-test-run-timescaledb> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b10000 vm-test-run-timescaledb> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-timescaledb> server # [ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (virt). vm-test-run-timescaledb> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-timescaledb> server # [ 0.000031] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-timescaledb> server # [ 0.002631] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-timescaledb> server # [ 0.009337] Console: colour dummy device 80x25 vm-test-run-timescaledb> server # [ 0.010482] printk: legacy console [tty0] enabled vm-test-run-timescaledb> server # [ 0.016901] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-timescaledb> server # [ 0.017225] pid_max: default: 32768 minimum: 301 vm-test-run-timescaledb> server # [ 0.018799] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-timescaledb> server # [ 0.019755] landlock: Up and running. vm-test-run-timescaledb> server # [ 0.019796] Yama: becoming mindful. vm-test-run-timescaledb> server # [ 0.021991] LSM support for eBPF active vm-test-run-timescaledb> server # [ 0.024490] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.024616] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.048589] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-timescaledb> server # [ 0.057456] rcu: Hierarchical SRCU implementation. vm-test-run-timescaledb> server # [ 0.057537] rcu: Max phase no-delay instances is 1000. vm-test-run-timescaledb> server # [ 0.058605] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-timescaledb> server # [ 0.063814] fsl-mc MSI: its@8080000 domain created vm-test-run-timescaledb> server # [ 0.065878] EFI services will not be available. vm-test-run-timescaledb> server # [ 0.068262] smp: Bringing up secondary CPUs ... vm-test-run-timescaledb> server # [ 0.071574] Detected PIPT I-cache on CPU1 vm-test-run-timescaledb> server # [ 0.072546] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-timescaledb> server # [ 0.073088] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000 vm-test-run-timescaledb> server # [ 0.074368] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-timescaledb> server # [ 0.077338] smp: Brought up 1 node, 2 CPUs vm-test-run-timescaledb> server # [ 0.077439] SMP: Total of 2 processors activated. vm-test-run-timescaledb> server # [ 0.077472] CPU: All CPU(s) started at EL1 vm-test-run-timescaledb> server # [ 0.077606] CPU features: detected: Branch Target Identification vm-test-run-timescaledb> server # [ 0.077647] CPU features: detected: 32-bit EL0 Support vm-test-run-timescaledb> server # [ 0.077671] CPU features: detected: 32-bit EL1 Support vm-test-run-timescaledb> server # [ 0.077690] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-timescaledb> server # [ 0.077715] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-timescaledb> server # [ 0.077746] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-timescaledb> server # [ 0.077800] CPU features: detected: Common not Private translations vm-test-run-timescaledb> server # [ 0.077821] CPU features: detected: CRC32 instructions vm-test-run-timescaledb> server # [ 0.077838] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-timescaledb> server # [ 0.077861] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-timescaledb> server # [ 0.077881] CPU features: detected: Data independent timing control (DIT) vm-test-run-timescaledb> server # [ 0.077901] CPU features: detected: E0PD vm-test-run-timescaledb> server # [ 0.077916] CPU features: detected: Enhanced Counter Virtualization vm-test-run-timescaledb> server # [ 0.077935] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-timescaledb> server # [ 0.077956] CPU features: detected: Enhanced Privileged Access Never vm-test-run-timescaledb> server # [ 0.077975] CPU features: detected: Enhanced Virtualization Traps vm-test-run-timescaledb> server # [ 0.077994] CPU features: detected: Fine Grained Traps vm-test-run-timescaledb> server # [ 0.078049] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.078117] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-timescaledb> server # [ 0.078153] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-timescaledb> server # [ 0.078174] CPU features: detected: LSE atomic instructions vm-test-run-timescaledb> server # [ 0.078192] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-timescaledb> server # [ 0.078213] CPU features: detected: Privileged Access Never vm-test-run-timescaledb> server # [ 0.078236] CPU features: detected: RAS Extension Support vm-test-run-timescaledb> server # [ 0.078254] CPU features: detected: Random Number Generator vm-test-run-timescaledb> server # [ 0.078272] CPU features: detected: Speculation barrier (SB) vm-test-run-timescaledb> server # [ 0.078290] CPU features: detected: Stage-2 Force Write-Back vm-test-run-timescaledb> server # [ 0.078309] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-timescaledb> server # [ 0.078331] CPU features: detected: TLB range maintenance instructions vm-test-run-timescaledb> server # [ 0.078351] CPU features: detected: WFx with timeout vm-test-run-timescaledb> server # [ 0.078385] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-timescaledb> server # [ 0.078405] CPU features: detected: Scalable Vector Extension vm-test-run-timescaledb> server # [ 0.084790] alternatives: applying system-wide alternatives vm-test-run-timescaledb> server # [ 0.097601] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-timescaledb> server # [ 0.098104] SVE: maximum available vector length 256 bytes per vector vm-test-run-timescaledb> server # [ 0.098179] SVE: default vector length 64 bytes per vector vm-test-run-timescaledb> server # [ 0.108496] Memory: 3922804K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-timescaledb> server # [ 0.134948] devtmpfs: initialized vm-test-run-timescaledb> server # [ 0.156882] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-timescaledb> server # [ 0.157364] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.160247] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-timescaledb> server # [ 0.160301] 0 pages in range for non-PLT usage vm-test-run-timescaledb> server # [ 0.160335] 509248 pages in range for PLT usage vm-test-run-timescaledb> server # [ 0.162320] pinctrl core: initialized pinctrl subsystem vm-test-run-timescaledb> server # [ 0.170696] DMI not present or invalid. vm-test-run-timescaledb> server # [ 0.187393] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-timescaledb> server # [ 0.197928] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-timescaledb> server # [ 0.199141] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-timescaledb> server # [ 0.199997] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-timescaledb> server # [ 0.200196] audit: initializing netlink subsys (disabled) vm-test-run-timescaledb> server # [ 0.201931] audit: type=2000 audit(0.096:1): state=initialized audit_enabled=0 res=1 vm-test-run-timescaledb> server # [ 0.207073] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-timescaledb> server # [ 0.207119] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-timescaledb> server # [ 0.207163] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-timescaledb> server # [ 0.207186] thermal_sys: Registered thermal governor 'user_space' vm-test-run-timescaledb> server # [ 0.207207] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-timescaledb> server # [ 0.207887] cpuidle: using governor ladder vm-test-run-timescaledb> server # [ 0.208136] cpuidle: using governor menu vm-test-run-timescaledb> server # [ 0.209652] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-timescaledb> server # [ 0.210211] ASID allocator initialised with 65536 entries vm-test-run-timescaledb> server # [ 0.215554] Serial: AMBA PL011 UART driver vm-test-run-timescaledb> server # [ 0.257548] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-timescaledb> server # [ 0.258494] printk: legacy console [ttyAMA0] enabled vm-test-run-timescaledb> server # [ 0.290587] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.290769] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-timescaledb> server # [ 0.290953] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.291141] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-timescaledb> server # [ 0.291777] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.292094] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-timescaledb> server # [ 0.292270] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.292446] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-timescaledb> server # [ 0.305214] fbcon: Taking over console vm-test-run-timescaledb> server # [ 0.305737] ACPI: Interpreter disabled. vm-test-run-timescaledb> server # [ 0.312259] iommu: Default domain type: Translated vm-test-run-timescaledb> server # [ 0.312710] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-timescaledb> server # [ 0.321208] SCSI subsystem initialized vm-test-run-timescaledb> server # [ 0.323093] usbcore: registered new interface driver usbfs vm-test-run-timescaledb> server # [ 0.323764] usbcore: registered new interface driver hub vm-test-run-timescaledb> server # [ 0.324288] usbcore: registered new device driver usb vm-test-run-timescaledb> server # [ 0.326588] pps_core: LinuxPPS API ver. 1 registered vm-test-run-timescaledb> server # [ 0.326684] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-timescaledb> server # [ 0.326838] PTP clock support registered vm-test-run-timescaledb> server # [ 0.327146] EDAC MC: Ver: 3.0.0 vm-test-run-timescaledb> server # [ 0.328537] scmi_core: SCMI protocol bus registered vm-test-run-timescaledb> server # [ 0.330660] FPGA manager framework vm-test-run-timescaledb> server # [ 0.331674] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-timescaledb> server # [ 0.341030] vgaarb: loaded vm-test-run-timescaledb> server # [ 0.348856] clocksource: Switched to clocksource arch_sys_counter vm-test-run-timescaledb> server # [ 0.354032] VFS: Disk quotas dquot_6.6.0 vm-test-run-timescaledb> server # [ 0.354251] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-timescaledb> server # [ 0.357589] netfs: FS-Cache loaded vm-test-run-timescaledb> server # [ 0.359012] pnp: PnP ACPI: disabled vm-test-run-timescaledb> server # [ 0.383756] NET: Registered PF_INET protocol family vm-test-run-timescaledb> server # [ 0.385580] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-timescaledb> server # [ 0.472134] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.472449] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.472711] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.474506] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-timescaledb> server # [ 0.475121] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-timescaledb> server # [ 0.476540] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-timescaledb> server # [ 0.477133] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.477574] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.480133] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-timescaledb> server # [ 0.481268] NET: Registered PF_XDP protocol family vm-test-run-timescaledb> server # [ 0.481461] PCI: CLS 0 bytes, default 64 vm-test-run-timescaledb> server # [ 0.484251] kvm [1]: HYP mode not available vm-test-run-timescaledb> server # [ 0.485370] Trying to unpack rootfs image as initramfs... vm-test-run-timescaledb> server # [ 0.584432] Initialise system trusted keyrings vm-test-run-timescaledb> server # [ 0.585643] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-timescaledb> server # [ 0.589276] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-timescaledb> server # [ 0.589925] 9p: Installing v9fs 9p2000 file system support vm-test-run-timescaledb> server # [ 0.659061] Key type asymmetric registered vm-test-run-timescaledb> server # [ 0.659261] Asymmetric key parser 'x509' registered vm-test-run-timescaledb> server # [ 0.659710] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-timescaledb> server # [ 0.661398] io scheduler mq-deadline registered vm-test-run-timescaledb> server # [ 0.661753] io scheduler kyber registered vm-test-run-timescaledb> server # [ 0.690003] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-timescaledb> server # [ 0.694825] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-timescaledb> server # [ 0.698659] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-timescaledb> server # [ 0.699207] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-timescaledb> server # [ 0.700014] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-timescaledb> server # [ 0.701114] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-timescaledb> server # [ 0.702104] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-timescaledb> server # [ 0.703161] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-timescaledb> server # [ 0.708909] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-timescaledb> server # [ 0.709490] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-timescaledb> server # [ 0.709856] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.709983] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.710313] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.711569] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.714646] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.714939] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.715533] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.715769] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.716192] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.717307] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.717472] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.717580] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.717693] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.719056] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.719191] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.719277] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.719397] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.719764] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.719887] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.719966] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.720058] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.720403] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.720520] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.720598] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.720690] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.721058] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.721177] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-timescaledb> server # [ 0.721254] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.721346] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.721690] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.721808] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.721888] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.721979] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.722071] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.722413] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.722534] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.722625] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.722959] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.723079] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.723172] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.724610] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.724957] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.726645] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.727098] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.727270] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.727662] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.729038] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.729457] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.729680] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.729902] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.733869] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.734332] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.734734] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.735738] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.736137] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.737608] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.737759] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.738304] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.738604] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.738905] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.739150] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.739536] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.739867] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.740995] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-timescaledb> server # [ 0.741120] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-timescaledb> server # [ 0.741935] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-timescaledb> server # [ 0.742661] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-timescaledb> server # [ 0.743350] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-timescaledb> server # [ 0.743469] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-timescaledb> server # [ 0.743566] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-timescaledb> server # [ 0.745156] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-timescaledb> server # [ 0.745561] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-timescaledb> server # [ 0.745839] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-timescaledb> server # [ 0.746090] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-timescaledb> server # [ 0.746289] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-timescaledb> server # [ 0.746530] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-timescaledb> server # [ 0.746740] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-timescaledb> server # [ 0.746948] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-timescaledb> server # [ 0.747139] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-timescaledb> server # [ 0.747679] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-timescaledb> server # [ 0.747943] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-timescaledb> server # [ 0.748140] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-timescaledb> server # [ 0.749096] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-timescaledb> server # [ 0.749570] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-timescaledb> server # [ 0.749879] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.749985] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.750071] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.750776] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.814781] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.822451] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.826213] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.830918] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.834116] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.838236] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.840533] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.844271] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.846864] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.850436] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.854421] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.881065] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-timescaledb> server # [ 0.888319] msm_serial: driver initialized vm-test-run-timescaledb> server # [ 0.890017] SuperH (H)SCI(F) driver initialized vm-test-run-timescaledb> server # [ 0.891262] STM32 USART driver initialized vm-test-run-timescaledb> server # [ 0.917471] Freeing initrd memory: 10684K vm-test-run-timescaledb> server # [ 0.950182] loop: module loaded vm-test-run-timescaledb> server # [ 0.950803] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-timescaledb> server # [ 0.955078] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-timescaledb> server # [ 0.967156] megasas: 07.727.03.00-rc1 vm-test-run-timescaledb> server # [ 0.971968] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-timescaledb> server # [ 0.974896] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 0.975462] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 0.977031] Using buffer write method vm-test-run-timescaledb> server # [ 0.978055] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-timescaledb> server # [ 0.979697] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 0.979911] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 0.981487] Using buffer write method vm-test-run-timescaledb> server # [ 0.982053] Concatenating MTD devices: vm-test-run-timescaledb> server # [ 0.982136] (0): "0.flash" vm-test-run-timescaledb> server # [ 0.982183] (1): "0.flash" vm-test-run-timescaledb> server # [ 0.982231] into device "0.flash" vm-test-run-timescaledb> server # [ 1.003045] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-timescaledb> server # [ 1.015840] thunder_xcv, ver 1.0 vm-test-run-timescaledb> server # [ 1.016058] thunder_bgx, ver 1.0 vm-test-run-timescaledb> server # [ 1.016513] nicpf, ver 1.0 vm-test-run-timescaledb> server # [ 1.019087] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-timescaledb> server # [ 1.019261] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-timescaledb> server # [ 1.019760] hclge is initializing vm-test-run-timescaledb> server # [ 1.019955] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.020204] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-timescaledb> server # [ 1.021080] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.021409] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-timescaledb> server # [ 1.021643] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-timescaledb> server # [ 1.021725] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-timescaledb> server # [ 1.021901] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-timescaledb> server # [ 1.021998] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-timescaledb> server # [ 1.022607] sky2: driver version 1.30 vm-test-run-timescaledb> server # [ 1.029506] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-timescaledb> server # [ 1.030034] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-timescaledb> server # [ 1.030532] usbcore: registered new interface driver usb-storage vm-test-run-timescaledb> server # [ 1.031013] usbcore: registered new interface driver usbserial_generic vm-test-run-timescaledb> server # [ 1.031242] usbserial: USB Serial support registered for generic vm-test-run-timescaledb> server # [ 1.033758] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-timescaledb> server # [ 1.043799] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-timescaledb> server # [ 1.044719] rtc-pl031 9010000.pl031: setting system clock to 2026-10-08T15:38:46 UTC (1791473926) vm-test-run-timescaledb> server # [ 1.044946] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-timescaledb> server # [ 1.046553] i2c_dev: i2c /dev entries driver vm-test-run-timescaledb> server # [ 1.053549] hub 1-0:1.0: USB hub found vm-test-run-timescaledb> server # [ 1.054688] hub 1-0:1.0: 6 ports detected vm-test-run-timescaledb> server # [ 1.059547] sdhci: Secure Digital Host Controller Interface driver vm-test-run-timescaledb> server # [ 1.059675] sdhci: Copyright(c) Pierre Ossman vm-test-run-timescaledb> server # [ 1.061160] Synopsys Designware Multimedia Card Interface Driver vm-test-run-timescaledb> server # [ 1.062702] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-timescaledb> server # [ 1.068449] hid: raw HID events driver (C) Jiri Kosina vm-test-run-timescaledb> server # [ 1.070386] usbcore: registered new interface driver usbhid vm-test-run-timescaledb> server # [ 1.070594] usbhid: USB HID core driver vm-test-run-timescaledb> server # [ 1.077968] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-timescaledb> server # [ 1.090557] drop_monitor: Initializing network drop monitor service vm-test-run-timescaledb> server # [ 1.092417] NET: Registered PF_INET6 protocol family vm-test-run-timescaledb> server # [ 1.111044] Segment Routing with IPv6 vm-test-run-timescaledb> server # [ 1.111639] In-situ OAM (IOAM) with IPv6 vm-test-run-timescaledb> server # [ 1.112654] NET: Registered PF_PACKET protocol family vm-test-run-timescaledb> server # [ 1.114846] 9pnet: Installing 9P2000 support vm-test-run-timescaledb> server # [ 1.119978] Key type dns_resolver registered vm-test-run-timescaledb> server # [ 1.157892] registered taskstats version 1 vm-test-run-timescaledb> server # [ 1.161133] Loading compiled-in X.509 certificates vm-test-run-timescaledb> server # [ 1.222853] Demotion targets for Node 0: null vm-test-run-timescaledb> server # [ 1.225031] Key type .fscrypt registered vm-test-run-timescaledb> server # [ 1.225149] Key type fscrypt-provisioning registered vm-test-run-timescaledb> server # [ 1.232065] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-timescaledb> server # [ 1.271333] clk: Disabling unused clocks vm-test-run-timescaledb> server # [ 1.271763] PM: genpd: Disabling unused power domains vm-test-run-timescaledb> server # [ 1.273081] ALSA device list: vm-test-run-timescaledb> server # [ 1.273290] No soundcards found. vm-test-run-timescaledb> server # [ 1.347464] Freeing unused kernel memory: 4416K vm-test-run-timescaledb> server # [ 1.348151] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-timescaledb> server # [ 1.351074] Run /init as init process vm-test-run-timescaledb> server # [ 1.569657] 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-timescaledb> server # [ 1.793693] 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-timescaledb> server # [ 1.809446] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-timescaledb> server # [ 1.912809] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-timescaledb> server # [ 1.916607] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-timescaledb> server # [ 1.917658] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-timescaledb> server # [ 1.917680] [drm] features: -context_init vm-test-run-timescaledb> server # [ 1.920076] [drm] number of scanouts: 1 vm-test-run-timescaledb> server # [ 1.920178] [drm] number of cap sets: 0 vm-test-run-timescaledb> server # [ 1.930612] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-timescaledb> server # [ 1.960662] Console: switching to colour frame buffer device 160x50 vm-test-run-timescaledb> server # [ 1.970592] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-timescaledb> server # [ 2.132222] 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-timescaledb> server # [ 2.135230] 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-timescaledb> server # [ 4.685566] EXT4-fs (vda): mounted filesystem c753bb2c-6f3e-48d6-97bb-738712d011ec r/w with ordered data mode. Quota mode: none. vm-test-run-timescaledb> server # [ 6.977765] EXT4-fs (vda): re-mounted c753bb2c-6f3e-48d6-97bb-738712d011ec. vm-test-run-timescaledb> server # [ 6.993539] booting system configuration /nix/store/vvmmy32pnyf743rwivm8k9bbp085kbxf-nixos-system-server-test vm-test-run-timescaledb> server # [ 17.443554] 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-timescaledb> server # [ 17.453175] systemd[1]: Detected virtualization qemu. vm-test-run-timescaledb> server # [ 17.457301] systemd[1]: Detected architecture arm64. vm-test-run-timescaledb> server # [ 17.461564] systemd[1]: Detected first boot. vm-test-run-timescaledb> server # [ 17.486980] systemd[1]: Initializing machine ID from random generator. vm-test-run-timescaledb> server # [ 17.516746] systemd[1]: Hostname set to . vm-test-run-timescaledb> server # [ 18.686551] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-timescaledb> server # [ 20.082566] systemd[1]: Applying preset policy. vm-test-run-timescaledb> server # [ 23.153180] systemd[1]: Populated /etc with preset unit settings. vm-test-run-timescaledb> server # [ 25.976323] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-timescaledb> server # [ 26.169303] systemd[1]: Created slice Slice /system/getty. vm-test-run-timescaledb> server # [ 26.182501] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-timescaledb> server # [ 26.194095] systemd[1]: Created slice User and Session Slice. vm-test-run-timescaledb> server # [ 26.201662] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-timescaledb> server # [ 26.206648] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-timescaledb> server # [ 26.212333] systemd[1]: Expecting device /dev/hvc0... vm-test-run-timescaledb> server # [ 26.218156] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-timescaledb> server # [ 26.223673] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-timescaledb> server # [ 26.228842] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-timescaledb> server # [ 26.233107] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-timescaledb> server # [ 26.237224] systemd[1]: Reached target Path Units. vm-test-run-timescaledb> server # [ 26.242057] systemd[1]: Reached target Remote File Systems. vm-test-run-timescaledb> server # [ 26.246439] systemd[1]: Reached target Slice Units. vm-test-run-timescaledb> server # [ 26.250878] systemd[1]: Reached target Swaps. vm-test-run-timescaledb> server # [ 26.289691] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-timescaledb> server # [ 26.310988] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-timescaledb> server # [ 26.321812] systemd[1]: Listening on Journal Audit Socket. vm-test-run-timescaledb> server # [ 26.327534] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-timescaledb> server # [ 26.333781] systemd[1]: Listening on Journal Sockets. vm-test-run-timescaledb> server # [ 26.341079] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-timescaledb> server # [ 26.345590] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 26.350973] systemd[1]: Listening on udev Control Socket. vm-test-run-timescaledb> server # [ 26.356911] systemd[1]: Listening on udev Kernel Socket. vm-test-run-timescaledb> server # [ 26.402791] systemd[1]: Mounting Huge Pages File System... vm-test-run-timescaledb> server # [ 26.440702] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-timescaledb> server # [ 26.484781] systemd[1]: Mounting Kernel Debug File System... vm-test-run-timescaledb> server # [ 26.591450] systemd[1]: Mounting Kernel Trace File System... vm-test-run-timescaledb> server # [ 26.731404] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-timescaledb> server # [ 26.796625] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-timescaledb> server # [ 26.809805] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-timescaledb> server # [ 26.938393] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-timescaledb> server # [ 26.949290] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-timescaledb> server # [ 26.957890] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-timescaledb> server # [ 27.083891] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-timescaledb> server # [ 27.105068] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-timescaledb> server # [ 27.117770] 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-timescaledb> server # [ 27.255938] systemd[1]: Starting Journal Service... vm-test-run-timescaledb> server # [ 27.358425] systemd[1]: Starting Load Kernel Modules... vm-test-run-timescaledb> server # [ 27.447024] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-timescaledb> server # [ 27.496051] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-timescaledb> server # [ 27.501391] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 27.571379] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-timescaledb> server # [ 27.651271] systemd[1]: Mounted Huge Pages File System. vm-test-run-timescaledb> server # [ 27.663878] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-timescaledb> server # [ 27.677021] systemd[1]: Mounted Kernel Debug File System. vm-test-run-timescaledb> server # [ 27.685594] systemd[1]: Mounted Kernel Trace File System. vm-test-run-timescaledb> server # [ 27.707643] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-timescaledb> server # [ 27.731444] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-timescaledb> server # [ 27.834867] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-timescaledb> server # [ 28.423750] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 28.442871] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-timescaledb> server # [ 28.714409] EXT4-fs (vda): re-mounted c753bb2c-6f3e-48d6-97bb-738712d011ec. vm-test-run-timescaledb> server # [ 28.799803] fuse: init (API version 7.41) vm-test-run-timescaledb> server # [ 28.835779] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-timescaledb> server # [ 28.853502] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-timescaledb> server # [ 28.924224] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-timescaledb> server # [ 28.929251] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 28.947978] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 28.963685] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-timescaledb> server # [ 28.989824] systemd[1]: Finished Load Kernel Modules. vm-test-run-timescaledb> server # [ 29.038648] systemd[1]: Mounting FUSE Control File System... vm-test-run-timescaledb> server # [ 29.104783] systemd[1]: Starting Firewall... vm-test-run-timescaledb> server # [ 29.193892] systemd[1]: Starting Apply Kernel Variables... vm-test-run-timescaledb> server: Guest root shell did not produce any data yet... vm-test-run-timescaledb> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-timescaledb> server # [ 29.355827] systemd-journald[399]: Collecting audit messages is enabled. vm-test-run-timescaledb> server # [ 29.378645] systemd[1]: Mounted FUSE Control File System. vm-test-run-timescaledb> server # [ 30.129899] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-timescaledb> server # [ 30.138482] systemd[1]: Reached target First Boot Complete. vm-test-run-timescaledb> server # [ 30.467857] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-timescaledb> server # [ 30.607660] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-timescaledb> server # [ 30.703091] systemd[1]: Finished Apply Kernel Variables. vm-test-run-timescaledb> server # [ 30.740616] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-timescaledb> server # [ 31.886707] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-timescaledb> server # [ 31.911817] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-timescaledb> server # [ 31.955461] systemd[1]: Mounting /run/wrappers... vm-test-run-timescaledb> server # [ 32.016706] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-timescaledb> server # [ 32.251574] systemd[1]: Started Journal Service. vm-test-run-timescaledb> server # [ 32.110172] systemd-modules-load[400]: Module 'atkbd' is built in vm-test-run-timescaledb> server # [ 32.146240] systemd-modules-load[400]: Module 'loop' is built in vm-test-run-timescaledb> server # [ 32.165293] systemd-oomd[401]: No swap; memory pressure usage will be degraded vm-test-run-timescaledb> server # [ 32.249733] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-timescaledb> server # [ 32.494785] systemd[1]: Mounted /run/wrappers. vm-test-run-timescaledb> server # [ 32.523364] systemd[1]: Reached target Local File Systems. vm-test-run-timescaledb> server # [ 32.556132] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-timescaledb> server # [ 32.602115] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-timescaledb> server # [ 32.611907] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-timescaledb> server # [ 32.646307] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-timescaledb> server # [ 33.470481] systemd-journald[399]: Received client request to flush runtime journal. vm-test-run-timescaledb> server # [ 34.153480] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-timescaledb> server # [ 34.204451] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-timescaledb> server # [ 34.226539] systemd-udevd[428]: Using default interface naming scheme 'v258'. vm-test-run-timescaledb> server # [ 34.246350] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-timescaledb> server # [ 34.305311] systemd[1]: Starting Create System Files and Directories... vm-test-run-timescaledb> server # [ 36.504121] systemd[1]: Finished Create System Files and Directories. vm-test-run-timescaledb> server # [ 36.549520] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-timescaledb> server # [ 36.602148] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-timescaledb> server # [ 36.622839] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-timescaledb> server # [ 37.682757] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-timescaledb> server # [ 38.999717] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-timescaledb> server # [ 39.045950] systemd[1]: Starting Update is Completed... vm-test-run-timescaledb> server # [ 39.706132] systemd[1]: Finished Update is Completed. vm-test-run-timescaledb> server # [ 43.688484] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 43.691794] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-timescaledb> server # [ 43.697636] systemd[1]: suid-sgid-wrappers.service: Consumed 3.102s CPU time, 5.6M memory peak. vm-test-run-timescaledb> server # [ 46.967682] systemd[1]: Finished Firewall. vm-test-run-timescaledb> server # [ 48.212284] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-timescaledb> server # [ 48.233917] systemd[1]: Reached target System Initialization. vm-test-run-timescaledb> server # [ 48.236057] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-timescaledb> server # [ 48.257246] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-timescaledb> server # [ 48.270312] systemd[1]: Reached target Timer Units. vm-test-run-timescaledb> server # [ 48.274776] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-timescaledb> server # [ 48.281814] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-timescaledb> server # [ 48.285543] systemd[1]: Listening on Hostname Service Socket. vm-test-run-timescaledb> server # [ 48.287730] systemd[1]: Reached target Socket Units. vm-test-run-timescaledb> server # [ 48.293096] systemd[1]: Reached target Basic System. vm-test-run-timescaledb> server # [ 48.307429] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-timescaledb> server # [ 48.351311] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 48.411707] systemd[1]: Started Reset console on configuration changes. vm-test-run-timescaledb> server # [ 48.470230] systemd[1]: Starting resolvconf update... vm-test-run-timescaledb> server # [ 48.558338] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-timescaledb> server # [ 49.682408] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-timescaledb> server # [ 50.053353] nsncd[632]: Oct 08 15:39:35.585 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 50.067079] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 50.091772] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 50.107437] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 50.142175] systemd[1]: Starting User Login Management... vm-test-run-timescaledb> server # [ 50.373744] dbus-daemon[635]: dbus[635]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-timescaledb> server # [ 50.830974] systemd[1]: Started D-Bus System Message Bus. vm-test-run-timescaledb> server # [ 51.793559] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 51.796317] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-timescaledb> server # [ 51.809791] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 51.822049] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-timescaledb> server # [ 51.874608] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 51.901809] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 51.919716] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 52.069510] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 52.099837] systemd-logind[653]: New seat seat0. vm-test-run-timescaledb> server # [ 52.121900] systemd[1]: Started User Login Management. vm-test-run-timescaledb> server # [ 52.165255] systemd[1]: Starting linger-users.service... vm-test-run-timescaledb> server # [ 52.889200] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 52.899423] systemd[1]: Finished linger-users.service. vm-test-run-timescaledb> server # [ 53.042374] nsncd[691]: Oct 08 15:39:38.624 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 53.051696] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 53.074749] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 53.090298] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 53.610076] systemd[1]: Finished resolvconf update. vm-test-run-timescaledb> server # [ 53.632587] systemd[1]: Reached target Preparation for Network. vm-test-run-timescaledb> server # [ 53.699581] systemd[1]: Starting DHCP Client... vm-test-run-timescaledb> server # [ 55.508978] dhcpcd[743]: dhcpcd-10.2.4 starting vm-test-run-timescaledb> server # [ 55.632241] dhcpcd[767]: dev: loaded udev vm-test-run-timescaledb> server # [ 56.666029] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-timescaledb> server # [ 56.549374] systemd[1]: Found device /dev/hvc0. vm-test-run-timescaledb> server # [ 57.298314] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-timescaledb> server # [ 57.581326] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-timescaledb> server # [ 57.585977] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-timescaledb> server # [ 57.608943] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-timescaledb> server # [ 57.621293] cfg80211: failed to load regulatory.db vm-test-run-timescaledb> server # [ 58.399616] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-timescaledb> server # [ 58.273874] dhcpcd[767]: eth0: waiting for carrier vm-test-run-timescaledb> server # [ 58.295968] dhcpcd[767]: eth0: carrier acquired vm-test-run-timescaledb> server # [ 58.471447] dhcpcd[767]: DUID 00:01:00:01:32:5a:75:c0:52:54:00:12:34:56 vm-test-run-timescaledb> server # [ 58.473339] dhcpcd[767]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 58.480065] dhcpcd[767]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-timescaledb> server # [ 58.960660] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-timescaledb> server # [ 59.009588] systemd[1]: Started backdoor.service. vm-test-run-timescaledb> server: Guest root shell did not produce any data yet... vm-test-run-timescaledb> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-timescaledb> server # connecting to host... vm-test-run-timescaledb> server: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-timescaledb> server: connected to guest root shell vm-test-run-timescaledb> server: (connecting took 60.71 seconds) vm-test-run-timescaledb> server: (finished: waiting for the VM to finish booting, in 60.71 seconds) vm-test-run-timescaledb> server # [ 59.831955] (udev-worker)[788]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-timescaledb> server # [ 59.841499] dhcpcd[767]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 59.863430] dhcpcd[767]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 59.874371] (udev-worker)[788]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 59.894758] dhcpcd[767]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 60.175060] (udev-worker)[789]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 60.983331] dhcpcd[767]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 60.999164] systemd[1]: Found device Virtio network device. vm-test-run-timescaledb> server # [ 61.018923] dhcpcd[767]: eth0: Router Advertisement from fe80::2 vm-test-run-timescaledb> server # [ 61.023915] systemd[1]: Starting Address configuration of eth1... vm-test-run-timescaledb> server # [ 61.032205] dhcpcd[767]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-timescaledb> server # [ 61.055637] dhcpcd[767]: eth0: adding route to fec0::/64 vm-test-run-timescaledb> server # [ 61.076023] dhcpcd[767]: eth0: adding default route via fe80::2 vm-test-run-timescaledb> server # [ 61.143856] dhcpcd[767]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 61.462350] dhcpcd[767]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 61.474288] dhcpcd[767]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 61.475081] dhcpcd[767]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 61.638322] dhcpcd[767]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 62.122780] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-timescaledb> server # [ 62.161804] network-addresses-eth1-start[818]: adding address 192.168.1.1/24... done vm-test-run-timescaledb> server # [ 62.295444] network-addresses-eth1-start[818]: adding address 2001:db8:1::1/64... done vm-test-run-timescaledb> server # [ 62.498438] systemd[1]: Finished Address configuration of eth1. vm-test-run-timescaledb> server # [ 62.589580] systemd[1]: Starting Networking Setup... vm-test-run-timescaledb> server # [ 67.281682] systemd[1]: Finished Networking Setup. vm-test-run-timescaledb> server # [ 67.301120] systemd[1]: Reached target Network. vm-test-run-timescaledb> server # [ 67.334163] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-timescaledb> server # [ 67.378652] systemd[1]: Starting Permit User Sessions... vm-test-run-timescaledb> server # [ 67.641807] dhcpcd[767]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-timescaledb> server # [ 67.645532] dhcpcd[767]: eth0: adding route to 10.0.2.0/24 vm-test-run-timescaledb> server # [ 67.646925] dhcpcd[767]: eth0: adding default route via 10.0.2.2 vm-test-run-timescaledb> server # [ 67.947399] systemd[1]: Finished Permit User Sessions. vm-test-run-timescaledb> server # [ 68.027019] systemd[1]: Started Getty on tty1. vm-test-run-timescaledb> server # [ 68.039585] systemd[1]: Reached target Login Prompts. vm-test-run-timescaledb> server # [ 68.870736] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[949]: Initializing database at /var/lib/postgresql/data vm-test-run-timescaledb> server # [ 71.314751] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: The files belonging to this database system will be owned by user "postgres". vm-test-run-timescaledb> server # [ 71.336024] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: This user must also own the server process. vm-test-run-timescaledb> server # [ 71.425075] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-timescaledb> server # [ 71.426951] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: The default database encoding has accordingly been set to "UTF8". vm-test-run-timescaledb> server # [ 71.434517] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: The default text search configuration will be set to "english". vm-test-run-timescaledb> server # [ 71.435990] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: Data page checksums are enabled. vm-test-run-timescaledb> server # [ 71.442271] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-timescaledb> server # [ 71.451417] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: creating subdirectories ... ok vm-test-run-timescaledb> server # [ 71.468183] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: selecting dynamic shared memory implementation ... posix vm-test-run-timescaledb> server # [ 71.616813] systemd-logind[653]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-timescaledb> server # [ 71.765594] systemd[1]: Started DHCP Client. vm-test-run-timescaledb> server # [ 72.694688] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: selecting default max_connections ... 100 vm-test-run-timescaledb> server # [ 73.802707] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: selecting default shared_buffers ... 128MB vm-test-run-timescaledb> server # [ 82.408805] mousedev: PS/2 mouse device common for all mice vm-test-run-timescaledb> server # [ 85.295136] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: selecting default time zone ... UTC vm-test-run-timescaledb> server # [ 85.334900] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: creating configuration files ... ok vm-test-run-timescaledb> server # [ 86.533639] systemd-logind[653]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-timescaledb> server # [ 90.152349] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: running bootstrap script ... ok vm-test-run-timescaledb> server # [ 104.317991] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: performing post-bootstrap initialization ... ok vm-test-run-timescaledb> server # [ 107.533673] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: syncing data to disk ... ok vm-test-run-timescaledb> server # [ 107.565830] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-timescaledb> server # [ 107.584154] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: 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-timescaledb> server # [ 107.592320] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: Success. You can now start the database server using: vm-test-run-timescaledb> server # [ 107.603134] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[963]: /nix/store/2jmk0ipjl6m8ckpzhqyax62hqwcvkfyh-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-timescaledb> server # [ 109.299711] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[949]: Validating PostgreSQL configuration... vm-test-run-timescaledb> server # [ 109.910978] 6vbg85406f6rdg1jfmcr4fy57251g3mf-postgresql-init[1388]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault vm-test-run-timescaledb> server # [ 111.235779] postgres[1401]: 2026-10-08 15:40:36.820 UTC [1401] LOG: pgaudit extension initialized vm-test-run-timescaledb> server # [ 112.167810] postgres[1401]: 2026-10-08 15:40:37.770 UTC [1401] LOG: pgsodium primary server secret key loaded vm-test-run-timescaledb> server # [ 112.621242] postgres[1401]: 2026-10-08 15:40:38.212 UTC [1401] LOG: vault primary server secret key loaded vm-test-run-timescaledb> server # [ 113.335431] postgres[1401]: 2026-10-08 15:40:38.938 UTC [1401] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-timescaledb> server # [ 113.361707] postgres[1401]: 2026-10-08 15:40:38.961 UTC [1401] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-timescaledb> server # [ 113.365296] postgres[1401]: 2026-10-08 15:40:38.963 UTC [1401] LOG: listening on IPv6 address "::", port 5432 vm-test-run-timescaledb> server # [ 113.391859] postgres[1401]: 2026-10-08 15:40:38.991 UTC [1401] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-timescaledb> server # [ 113.654280] postgres[1443]: 2026-10-08 15:40:39.241 UTC [1443] LOG: database system was shut down at 2026-10-08 15:40:29 UTC vm-test-run-timescaledb> server # [ 114.259962] postgres[1401]: 2026-10-08 15:40:39.815 UTC [1401] LOG: database system is ready to accept connections vm-test-run-timescaledb> server # [ 114.287877] systemd[1]: Started PostgreSQL Database Server. vm-test-run-timescaledb> server # [ 114.307188] postgres[1453]: 2026-10-08 15:40:39.901 UTC [1453] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-timescaledb> server # [ 114.331151] postgres[1454]: 2026-10-08 15:40:39.925 UTC [1454] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 114.350283] systemd[1]: Starting Supabase Database Initialization... vm-test-run-timescaledb> server # [ 114.583424] postgres[1401]: 2026-10-08 15:40:40.185 UTC [1401] LOG: background worker "pg_net 0.20.4 worker" (PID 1454) exited with exit code 1 vm-test-run-timescaledb> server # [ 114.806451] postgres[1456]: 2026-10-08 15:40:40.389 UTC [1456] LOG: pg_cron scheduler started vm-test-run-timescaledb> server # [ 114.890181] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Waiting for PostgreSQL to be ready... vm-test-run-timescaledb> server # [ 115.367682] postgres[1464]: ::1 2026-10-08 15:40:40.961 UTC [1464] root@root FATAL: role "root" does not exist vm-test-run-timescaledb> server # [ 115.400783] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: PostgreSQL is ready vm-test-run-timescaledb> server # [ 115.405292] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Creating postgres role... vm-test-run-timescaledb> server # [ 115.647290] postgres[1466]: 2026-10-08 15:40:41.220 UTC [1466] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 115.674292] postgres[1401]: 2026-10-08 15:40:41.264 UTC [1401] LOG: background worker "pg_net 0.20.4 worker" (PID 1466) exited with exit code 1 vm-test-run-timescaledb> server # [ 115.838200] postgres[1467]: ::1 2026-10-08 15:40:41.430 UTC [1467] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-timescaledb> server # [ 115.859083] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1465]: CREATE ROLE vm-test-run-timescaledb> server # [ 116.338566] postgres[1477]: ::1 2026-10-08 15:40:41.929 UTC [1477] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-timescaledb> server # [ 116.383810] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1468]: ALTER DATABASE vm-test-run-timescaledb> server # [ 116.456345] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-timescaledb> server # [ 116.957350] postgres[1485]: ::1 2026-10-08 15:40:42.541 UTC [1485] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-timescaledb> server # [ 117.013164] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: CREATE PUBLICATION vm-test-run-timescaledb> server # [ 117.014335] postgres[1485]: ::1 2026-10-08 15:40:42.597 UTC [1485] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-timescaledb> server # [ 117.018077] postgres[1485]: ::1 2026-10-08 15:40:42.610 UTC [1485] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-timescaledb> server # [ 117.021728] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: ALTER ROLE vm-test-run-timescaledb> server # [ 117.028947] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: CREATE ROLE vm-test-run-timescaledb> server # [ 117.044756] postgres[1485]: ::1 2026-10-08 15:40:42.645 UTC [1485] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-timescaledb> server # [ 117.069093] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: CREATE ROLE vm-test-run-timescaledb> server # [ 117.076293] postgres[1485]: ::1 2026-10-08 15:40:42.678 UTC [1485] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-timescaledb> server # [ 117.100784] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: GRANT ROLE vm-test-run-timescaledb> server # [ 117.101666] postgres[1485]: ::1 2026-10-08 15:40:42.702 UTC [1485] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-timescaledb> server # [ 117.118441] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 117.131627] postgres[1485]: ::1 2026-10-08 15:40:42.718 UTC [1485] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-timescaledb> server # [ 117.141904] postgres[1485]: ::1 2026-10-08 15:40:42.740 UTC [1485] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-timescaledb> server # [ 117.151447] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: CREATE ROLE vm-test-run-timescaledb> server # [ 117.163237] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: GRANT ROLE vm-test-run-timescaledb> server # [ 117.173561] postgres[1485]: ::1 2026-10-08 15:40:42.759 UTC [1485] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-timescaledb> server # [ 117.190804] postgres[1485]: ::1 2026-10-08 15:40:42.790 UTC [1485] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-timescaledb> server # [ 117.197552] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 120.082511] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 120.094279] postgres[1485]: ::1 2026-10-08 15:40:45.678 UTC [1485] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-timescaledb> server # [ 121.147148] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 121.153913] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: CREATE ROLE vm-test-run-timescaledb> server # [ 121.158876] postgres[1485]: ::1 2026-10-08 15:40:46.742 UTC [1485] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-timescaledb> server # [ 121.165133] postgres[1485]: ::1 2026-10-08 15:40:46.757 UTC [1485] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-timescaledb> server # [ 121.167018] postgres[1485]: ::1 2026-10-08 15:40:46.767 UTC [1485] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-timescaledb> server # [ 121.173491] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: CREATE ROLE vm-test-run-timescaledb> server # [ 121.174014] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: CREATE ROLE vm-test-run-timescaledb> server # [ 121.174643] postgres[1485]: ::1 2026-10-08 15:40:46.777 UTC [1485] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-timescaledb> server # [ 121.180507] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: CREATE ROLE vm-test-run-timescaledb> server # [ 121.181645] postgres[1485]: ::1 2026-10-08 15:40:46.784 UTC [1485] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-timescaledb> server # [ 121.196619] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: GRANT ROLE vm-test-run-timescaledb> server # [ 121.210567] postgres[1485]: ::1 2026-10-08 15:40:46.804 UTC [1485] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-timescaledb> server # [ 121.225474] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: GRANT ROLE vm-test-run-timescaledb> server # [ 121.238168] postgres[1485]: ::1 2026-10-08 15:40:46.833 UTC [1485] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-timescaledb> server # [ 121.251602] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: GRANT ROLE vm-test-run-timescaledb> server # [ 121.257707] postgres[1485]: ::1 2026-10-08 15:40:46.856 UTC [1485] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-timescaledb> server # [ 121.276934] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: GRANT ROLE vm-test-run-timescaledb> server # [ 121.286984] postgres[1485]: ::1 2026-10-08 15:40:46.882 UTC [1485] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.289374] postgres[1485]: ::1 2026-10-08 15:40:46.892 UTC [1485] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.291796] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 121.307929] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.310724] postgres[1485]: ::1 2026-10-08 15:40:46.913 UTC [1485] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.321690] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.322716] postgres[1485]: ::1 2026-10-08 15:40:46.922 UTC [1485] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.328130] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.329747] postgres[1485]: ::1 2026-10-08 15:40:46.932 UTC [1485] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.337031] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 121.338850] postgres[1485]: ::1 2026-10-08 15:40:46.942 UTC [1485] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-timescaledb> server # [ 121.348659] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: ALTER ROLE vm-test-run-timescaledb> server # [ 121.350083] postgres[1485]: ::1 2026-10-08 15:40:46.952 UTC [1485] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 121.350605] postgres[1485]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.361058] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.364493] postgres[1485]: ::1 2026-10-08 15:40:46.961 UTC [1485] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 121.366941] postgres[1485]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.368831] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.372526] postgres[1485]: ::1 2026-10-08 15:40:46.973 UTC [1485] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 121.376295] postgres[1485]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.379542] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.382952] postgres[1485]: ::1 2026-10-08 15:40:46.985 UTC [1485] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-timescaledb> server # [ 121.390473] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: ALTER ROLE vm-test-run-timescaledb> server # [ 121.393096] postgres[1485]: ::1 2026-10-08 15:40:46.995 UTC [1485] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 121.402750] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1481]: ALTER ROLE vm-test-run-timescaledb> server # [ 121.454169] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-timescaledb> server # [ 121.729731] postgres[1526]: ::1 2026-10-08 15:40:47.327 UTC [1526] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 121.750534] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 121.751429] postgres[1526]: ::1 2026-10-08 15:40:47.349 UTC [1526] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-timescaledb> server # [ 121.755444] postgres[1526]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 121.756348] postgres[1526]: id uuid NOT NULL UNIQUE, vm-test-run-timescaledb> server # [ 121.758363] postgres[1526]: aud varchar(255) NULL, vm-test-run-timescaledb> server # [ 121.759215] postgres[1526]: "role" varchar(255) NULL, vm-test-run-timescaledb> server # [ 121.760000] postgres[1526]: email varchar(255) NULL UNIQUE, vm-test-run-timescaledb> server # [ 121.761159] postgres[1526]: encrypted_password varchar(255) NULL, vm-test-run-timescaledb> server # [ 121.761801] postgres[1526]: confirmed_at timestamptz NULL, vm-test-run-timescaledb> server # [ 121.765741] postgres[1526]: invited_at timestamptz NULL, vm-test-run-timescaledb> server # [ 121.766733] postgres[1526]: confirmation_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 121.767651] postgres[1526]: confirmation_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 121.768850] postgres[1526]: recovery_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 121.769726] postgres[1526]: recovery_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 121.770925] postgres[1526]: email_change_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 121.771436] postgres[1526]: email_change varchar(255) NULL, vm-test-run-timescaledb> server # [ 121.774119] postgres[1526]: email_change_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 121.775042] postgres[1526]: last_sign_in_at timestamptz NULL, vm-test-run-timescaledb> server # [ 121.776006] postgres[1526]: raw_app_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 121.778508] postgres[1526]: raw_user_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 121.778868] postgres[1526]: is_super_admin bool NULL, vm-test-run-timescaledb> server # [ 121.780947] postgres[1526]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 121.783693] postgres[1526]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 121.785485] postgres[1526]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 121.786720] postgres[1526]: ); vm-test-run-timescaledb> server # [ 121.918184] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE TABLE vm-test-run-timescaledb> server # [ 121.925573] postgres[1526]: ::1 2026-10-08 15:40:47.527 UTC [1526] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-timescaledb> server # [ 121.982785] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE INDEX vm-test-run-timescaledb> server # [ 121.990955] postgres[1526]: ::1 2026-10-08 15:40:47.587 UTC [1526] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-timescaledb> server # [ 122.035527] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE INDEX vm-test-run-timescaledb> server # [ 122.039215] postgres[1526]: ::1 2026-10-08 15:40:47.637 UTC [1526] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-timescaledb> server # [ 122.061063] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: COMMENT vm-test-run-timescaledb> server # [ 122.066142] postgres[1526]: ::1 2026-10-08 15:40:47.667 UTC [1526] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-timescaledb> server # [ 122.067023] postgres[1526]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 122.067373] postgres[1526]: id bigserial NOT NULL, vm-test-run-timescaledb> server # [ 122.068092] postgres[1526]: "token" varchar(255) NULL, vm-test-run-timescaledb> server # [ 122.077186] postgres[1526]: user_id varchar(255) NULL, vm-test-run-timescaledb> server # [ 122.082433] postgres[1526]: revoked bool NULL, vm-test-run-timescaledb> server # [ 122.083117] postgres[1526]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 122.083773] postgres[1526]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 122.084064] postgres[1526]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 122.085696] postgres[1526]: ); vm-test-run-timescaledb> server # [ 122.173452] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE TABLE vm-test-run-timescaledb> server # [ 122.174529] postgres[1526]: ::1 2026-10-08 15:40:47.776 UTC [1526] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-timescaledb> server # [ 122.205406] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE INDEX vm-test-run-timescaledb> server # [ 122.206715] postgres[1526]: ::1 2026-10-08 15:40:47.806 UTC [1526] 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-timescaledb> server # [ 122.257768] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE INDEX vm-test-run-timescaledb> server # [ 122.264912] postgres[1526]: ::1 2026-10-08 15:40:47.864 UTC [1526] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-timescaledb> server # [ 122.297226] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE INDEX vm-test-run-timescaledb> server # [ 122.301359] postgres[1526]: ::1 2026-10-08 15:40:47.903 UTC [1526] 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-timescaledb> server # [ 122.322037] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: COMMENT vm-test-run-timescaledb> server # [ 122.322900] postgres[1526]: ::1 2026-10-08 15:40:47.921 UTC [1526] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-timescaledb> server # [ 122.323910] postgres[1526]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 122.334033] postgres[1526]: uuid uuid NULL, vm-test-run-timescaledb> server # [ 122.334653] postgres[1526]: raw_base_config text NULL, vm-test-run-timescaledb> server # [ 122.341453] postgres[1526]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 122.350418] postgres[1526]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 122.355607] postgres[1526]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 122.361560] postgres[1526]: ); vm-test-run-timescaledb> server # [ 122.418158] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE TABLE vm-test-run-timescaledb> server # [ 122.421018] postgres[1526]: ::1 2026-10-08 15:40:48.022 UTC [1526] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-timescaledb> server # [ 122.436636] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: COMMENT vm-test-run-timescaledb> server # [ 122.441451] postgres[1526]: ::1 2026-10-08 15:40:48.035 UTC [1526] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-timescaledb> server # [ 122.442667] postgres[1526]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 122.443211] postgres[1526]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 122.444012] postgres[1526]: payload json NULL, vm-test-run-timescaledb> server # [ 122.445415] postgres[1526]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 122.446005] postgres[1526]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 122.447100] postgres[1526]: ); vm-test-run-timescaledb> server # [ 122.492593] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE TABLE vm-test-run-timescaledb> server # [ 122.493597] postgres[1526]: ::1 2026-10-08 15:40:48.094 UTC [1526] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id); vm-test-run-timescaledb> server # [ 122.547292] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE INDEX vm-test-run-timescaledb> server # [ 122.555705] postgres[1526]: ::1 2026-10-08 15:40:48.155 UTC [1526] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-timescaledb> server # [ 122.564608] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: COMMENT vm-test-run-timescaledb> server # [ 122.569833] postgres[1526]: ::1 2026-10-08 15:40:48.169 UTC [1526] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-timescaledb> server # [ 122.571865] postgres[1526]: "version" varchar(255) NOT NULL, vm-test-run-timescaledb> server # [ 122.572994] postgres[1526]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-timescaledb> server # [ 122.573764] postgres[1526]: ); vm-test-run-timescaledb> server # [ 122.618569] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE TABLE vm-test-run-timescaledb> server # [ 122.622392] postgres[1526]: ::1 2026-10-08 15:40:48.225 UTC [1526] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-timescaledb> server # [ 122.633864] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: COMMENT vm-test-run-timescaledb> server # [ 122.651357] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: INSERT 0 7 vm-test-run-timescaledb> server # [ 122.657326] postgres[1526]: ::1 2026-10-08 15:40:48.257 UTC [1526] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-timescaledb> server # [ 122.658216] postgres[1526]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-timescaledb> server # [ 122.660305] postgres[1526]: $$ language sql stable; vm-test-run-timescaledb> server # [ 122.667252] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 122.674063] postgres[1526]: ::1 2026-10-08 15:40:48.273 UTC [1526] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-timescaledb> server # [ 122.675590] postgres[1526]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-timescaledb> server # [ 122.678122] postgres[1526]: $$ language sql stable; vm-test-run-timescaledb> server # [ 122.682163] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 122.683215] postgres[1526]: ::1 2026-10-08 15:40:48.285 UTC [1526] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-timescaledb> server # [ 122.683869] postgres[1526]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-timescaledb> server # [ 122.689077] postgres[1526]: $$ language sql stable; vm-test-run-timescaledb> server # [ 122.693492] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 122.694307] postgres[1526]: ::1 2026-10-08 15:40:48.297 UTC [1526] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 122.717810] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: GRANT vm-test-run-timescaledb> server # [ 122.720170] postgres[1526]: ::1 2026-10-08 15:40:48.320 UTC [1526] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 122.727315] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: CREATE ROLE vm-test-run-timescaledb> server # [ 122.733430] postgres[1526]: ::1 2026-10-08 15:40:48.331 UTC [1526] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 122.739118] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: GRANT vm-test-run-timescaledb> server # [ 122.742503] postgres[1526]: ::1 2026-10-08 15:40:48.345 UTC [1526] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 122.761529] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: GRANT vm-test-run-timescaledb> server # [ 122.762594] postgres[1526]: ::1 2026-10-08 15:40:48.359 UTC [1526] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 122.770683] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: GRANT vm-test-run-timescaledb> server # [ 122.775600] postgres[1526]: ::1 2026-10-08 15:40:48.376 UTC [1526] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-timescaledb> server # [ 122.790487] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: ALTER ROLE vm-test-run-timescaledb> server # [ 122.793751] postgres[1526]: ::1 2026-10-08 15:40:48.390 UTC [1526] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 122.804985] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: ALTER TABLE vm-test-run-timescaledb> server # [ 122.809283] postgres[1526]: ::1 2026-10-08 15:40:48.406 UTC [1526] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 122.821090] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: ALTER TABLE vm-test-run-timescaledb> server # [ 122.822025] postgres[1526]: ::1 2026-10-08 15:40:48.423 UTC [1526] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 122.831313] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: ALTER TABLE vm-test-run-timescaledb> server # [ 122.837644] postgres[1526]: ::1 2026-10-08 15:40:48.436 UTC [1526] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 122.853791] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: ALTER TABLE vm-test-run-timescaledb> server # [ 122.859809] postgres[1526]: ::1 2026-10-08 15:40:48.459 UTC [1526] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 122.873035] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1525]: ALTER TABLE vm-test-run-timescaledb> server # [ 122.936791] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-timescaledb> server # [ 123.360397] postgres[1538]: ::1 2026-10-08 15:40:48.953 UTC [1538] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 123.389463] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1531]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 123.396914] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1531]: CREATE ROLE vm-test-run-timescaledb> server # [ 123.397769] postgres[1538]: ::1 2026-10-08 15:40:48.985 UTC [1538] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 123.398888] postgres[1538]: ::1 2026-10-08 15:40:49.000 UTC [1538] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-timescaledb> server # [ 123.412501] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1531]: ALTER ROLE vm-test-run-timescaledb> server # [ 123.423629] postgres[1538]: ::1 2026-10-08 15:40:49.021 UTC [1538] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-timescaledb> server # [ 123.453501] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1531]: GRANT vm-test-run-timescaledb> server # [ 123.524983] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1531]: DO vm-test-run-timescaledb> server # [ 123.602300] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-timescaledb> server # [ 124.198789] postgres[1555]: ::1 2026-10-08 15:40:49.779 UTC [1555] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-timescaledb> server # [ 124.253813] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: ALTER ROLE vm-test-run-timescaledb> server # [ 124.255334] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: ALTER ROLE vm-test-run-timescaledb> server # [ 124.267381] postgres[1555]: ::1 2026-10-08 15:40:49.828 UTC [1555] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-timescaledb> server # [ 124.277880] postgres[1555]: ::1 2026-10-08 15:40:49.850 UTC [1555] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-timescaledb> server # [ 124.282035] postgres[1555]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 124.282766] postgres[1555]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 124.283660] postgres[1555]: AS $$ vm-test-run-timescaledb> server # [ 124.284195] postgres[1555]: DECLARE vm-test-run-timescaledb> server # [ 124.289292] postgres[1555]: schema_is_cron bool; vm-test-run-timescaledb> server # [ 124.291509] postgres[1555]: BEGIN vm-test-run-timescaledb> server # [ 124.292365] postgres[1555]: schema_is_cron = ( vm-test-run-timescaledb> server # [ 124.299799] postgres[1555]: SELECT n.nspname = 'cron' vm-test-run-timescaledb> server # [ 124.300626] postgres[1555]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 124.301157] postgres[1555]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-timescaledb> server # [ 124.308846] postgres[1555]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 124.310487] postgres[1555]: ); vm-test-run-timescaledb> server # [ 124.311393] postgres[1555]: vm-test-run-timescaledb> server # [ 124.316963] postgres[1555]: IF schema_is_cron vm-test-run-timescaledb> server # [ 124.318489] postgres[1555]: THEN vm-test-run-timescaledb> server # [ 124.319653] postgres[1555]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 124.326415] postgres[1555]: vm-test-run-timescaledb> server # [ 124.329403] postgres[1555]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 124.331190] postgres[1555]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 124.332067] postgres[1555]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 124.338000] postgres[1555]: vm-test-run-timescaledb> server # [ 124.338648] postgres[1555]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 124.338946] postgres[1555]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 124.339196] postgres[1555]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 124.339440] postgres[1555]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 124.340098] postgres[1555]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 124.354209] postgres[1555]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 124.359785] postgres[1555]: vm-test-run-timescaledb> server # [ 124.364136] postgres[1555]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 124.373619] postgres[1555]: vm-test-run-timescaledb> server # [ 124.374296] postgres[1555]: END IF; vm-test-run-timescaledb> server # [ 124.375404] postgres[1555]: vm-test-run-timescaledb> server # [ 124.381559] postgres[1555]: END; vm-test-run-timescaledb> server # [ 124.385153] postgres[1555]: $$; vm-test-run-timescaledb> server # [ 124.385847] postgres[1555]: ::1 2026-10-08 15:40:49.938 UTC [1555] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA') vm-test-run-timescaledb> server # [ 124.387261] postgres[1555]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 124.388074] postgres[1555]: ::1 2026-10-08 15:40:49.953 UTC [1555] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-timescaledb> server # [ 124.398404] postgres[1555]: ::1 2026-10-08 15:40:49.972 UTC [1555] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-timescaledb> server # [ 124.409144] postgres[1555]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 124.410620] postgres[1555]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 124.411407] postgres[1555]: AS $$ vm-test-run-timescaledb> server # [ 124.416708] postgres[1555]: BEGIN vm-test-run-timescaledb> server # [ 124.417803] postgres[1555]: IF EXISTS ( vm-test-run-timescaledb> server # [ 124.418848] postgres[1555]: SELECT 1 vm-test-run-timescaledb> server # [ 124.419755] postgres[1555]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 124.420103] postgres[1555]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 124.421833] postgres[1555]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 124.422614] postgres[1555]: WHERE ext.extname = 'pg_net' vm-test-run-timescaledb> server # [ 124.423757] postgres[1555]: ) vm-test-run-timescaledb> server # [ 124.425411] postgres[1555]: THEN vm-test-run-timescaledb> server # [ 124.426558] postgres[1555]: IF NOT EXISTS ( vm-test-run-timescaledb> server # [ 124.427963] postgres[1555]: SELECT 1 vm-test-run-timescaledb> server # [ 124.430396] postgres[1555]: FROM pg_roles vm-test-run-timescaledb> server # [ 124.431288] postgres[1555]: WHERE rolname = 'supabase_functions_admin' vm-test-run-timescaledb> server # [ 124.432064] postgres[1555]: ) vm-test-run-timescaledb> server # [ 124.437786] postgres[1555]: THEN vm-test-run-timescaledb> server # [ 124.439313] postgres[1555]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 124.440270] postgres[1555]: END IF; vm-test-run-timescaledb> server # [ 124.441210] postgres[1555]: vm-test-run-timescaledb> server # [ 124.441723] postgres[1555]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.442078] postgres[1555]: vm-test-run-timescaledb> server # [ 124.442306] postgres[1555]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 124.442853] postgres[1555]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 124.443643] postgres[1555]: vm-test-run-timescaledb> server # [ 124.443877] postgres[1555]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-timescaledb> server # [ 124.446091] postgres[1555]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-timescaledb> server # [ 124.447662] postgres[1555]: vm-test-run-timescaledb> server # [ 124.447969] postgres[1555]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-timescaledb> server # [ 124.453680] postgres[1555]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-timescaledb> server # [ 124.455359] postgres[1555]: vm-test-run-timescaledb> server # [ 124.456707] postgres[1555]: 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-timescaledb> server # [ 124.458046] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 124.458986] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 124.459327] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: COMMENT vm-test-run-timescaledb> server # [ 124.460046] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 124.463934] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: COMMENT vm-test-run-timescaledb> server # [ 124.464543] postgres[1555]: 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-timescaledb> server # [ 124.469681] postgres[1555]: END IF; vm-test-run-timescaledb> server # [ 124.470066] postgres[1555]: END; vm-test-run-timescaledb> server # [ 124.470305] postgres[1555]: $$; vm-test-run-timescaledb> server # [ 124.470565] postgres[1555]: ::1 2026-10-08 15:40:49.997 UTC [1555] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-timescaledb> server # [ 124.500607] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: DO vm-test-run-timescaledb> server # [ 124.501779] postgres[1555]: ::1 2026-10-08 15:40:50.104 UTC [1555] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-timescaledb> server # [ 124.516743] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: CREATE ROLE vm-test-run-timescaledb> server # [ 124.517977] postgres[1555]: ::1 2026-10-08 15:40:50.118 UTC [1555] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-timescaledb> server # [ 124.543369] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: GRANT vm-test-run-timescaledb> server # [ 124.550295] postgres[1555]: ::1 2026-10-08 15:40:50.138 UTC [1555] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 124.551110] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: GRANT vm-test-run-timescaledb> server # [ 124.559826] postgres[1555]: ::1 2026-10-08 15:40:50.162 UTC [1555] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 124.575443] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: GRANT vm-test-run-timescaledb> server # [ 124.583348] postgres[1555]: ::1 2026-10-08 15:40:50.184 UTC [1555] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 124.605138] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: GRANT vm-test-run-timescaledb> server # [ 124.606396] postgres[1555]: ::1 2026-10-08 15:40:50.205 UTC [1555] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 124.612737] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: GRANT vm-test-run-timescaledb> server # [ 124.617835] postgres[1555]: ::1 2026-10-08 15:40:50.218 UTC [1555] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 124.625025] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: GRANT vm-test-run-timescaledb> server # [ 124.627975] postgres[1555]: ::1 2026-10-08 15:40:50.230 UTC [1555] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 124.637339] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: GRANT vm-test-run-timescaledb> server # [ 124.639751] postgres[1555]: ::1 2026-10-08 15:40:50.238 UTC [1555] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 124.657441] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: GRANT vm-test-run-timescaledb> server # [ 124.658756] postgres[1555]: ::1 2026-10-08 15:40:50.259 UTC [1555] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 124.714409] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: GRANT vm-test-run-timescaledb> server # [ 124.752997] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1548]: DO vm-test-run-timescaledb> server # [ 124.814165] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running pgbouncer auth schema... vm-test-run-timescaledb> server # [ 125.102212] postgres[1560]: ::1 2026-10-08 15:40:50.698 UTC [1560] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-timescaledb> server # [ 125.126114] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1559]: CREATE ROLE vm-test-run-timescaledb> server # [ 125.131161] postgres[1560]: ::1 2026-10-08 15:40:50.719 UTC [1560] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-timescaledb> server # [ 125.136920] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1559]: REVOKE vm-test-run-timescaledb> server # [ 125.143167] postgres[1560]: ::1 2026-10-08 15:40:50.737 UTC [1560] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-timescaledb> server # [ 125.171354] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1559]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 125.177169] postgres[1560]: ::1 2026-10-08 15:40:50.779 UTC [1560] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-timescaledb> server # [ 125.178817] postgres[1560]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-timescaledb> server # [ 125.180319] postgres[1560]: $$ vm-test-run-timescaledb> server # [ 125.183326] postgres[1560]: BEGIN vm-test-run-timescaledb> server # [ 125.184066] postgres[1560]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-timescaledb> server # [ 125.193009] postgres[1560]: vm-test-run-timescaledb> server # [ 125.194637] postgres[1560]: RETURN QUERY vm-test-run-timescaledb> server # [ 125.196874] postgres[1560]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-timescaledb> server # [ 125.198107] postgres[1560]: WHERE usename = p_usename; vm-test-run-timescaledb> server # [ 125.199580] postgres[1560]: END; vm-test-run-timescaledb> server # [ 125.200119] postgres[1560]: $$ LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 125.200517] postgres[1560]: SET search_path = '' vm-test-run-timescaledb> server # [ 125.202738] postgres[1560]: SECURITY DEFINER; vm-test-run-timescaledb> server # [ 125.204539] postgres[1560]: ::1 2026-10-08 15:40:50.807 UTC [1560] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-timescaledb> server # [ 125.205760] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1559]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 125.214069] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1559]: REVOKE vm-test-run-timescaledb> server # [ 125.216759] postgres[1560]: ::1 2026-10-08 15:40:50.819 UTC [1560] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-timescaledb> server # [ 125.227914] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1559]: GRANT vm-test-run-timescaledb> server # [ 125.266295] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running stat extension... vm-test-run-timescaledb> server # [ 125.523993] postgres[1562]: ::1 2026-10-08 15:40:51.113 UTC [1562] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-timescaledb> server # [ 125.558188] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1561]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-timescaledb> server # [ 125.559253] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1561]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 125.559942] postgres[1562]: ::1 2026-10-08 15:40:51.151 UTC [1562] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-timescaledb> server # [ 127.127422] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1561]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 127.200550] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-timescaledb> server # [ 127.582232] postgres[1588]: ::1 2026-10-08 15:40:53.156 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-timescaledb> server # [ 127.584048] postgres[1588]: ::1 2026-10-08 15:40:53.174 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 127.594795] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1586]: GRANT vm-test-run-timescaledb> server # [ 127.629847] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1586]: GRANT vm-test-run-timescaledb> server # [ 127.641102] postgres[1588]: ::1 2026-10-08 15:40:53.238 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 127.654195] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1586]: GRANT vm-test-run-timescaledb> server # [ 127.661687] postgres[1588]: ::1 2026-10-08 15:40:53.253 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 127.681201] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1586]: GRANT vm-test-run-timescaledb> server # [ 127.682357] postgres[1588]: ::1 2026-10-08 15:40:53.280 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 127.693922] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1586]: GRANT vm-test-run-timescaledb> server # [ 127.702098] postgres[1588]: ::1 2026-10-08 15:40:53.302 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 127.715341] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1586]: GRANT vm-test-run-timescaledb> server # [ 127.721926] postgres[1588]: ::1 2026-10-08 15:40:53.320 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 127.729353] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1586]: GRANT vm-test-run-timescaledb> server # [ 127.734136] postgres[1588]: ::1 2026-10-08 15:40:53.337 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 127.770974] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1586]: GRANT vm-test-run-timescaledb> server # [ 127.775199] postgres[1588]: ::1 2026-10-08 15:40:53.374 UTC [1588] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 127.861771] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1586]: GRANT vm-test-run-timescaledb> server # [ 127.898414] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1586]: DO vm-test-run-timescaledb> server # [ 127.899833] postgres[1588]: ::1 2026-10-08 15:40:53.502 UTC [1588] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-timescaledb> server # [ 127.917586] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1586]: ALTER ROLE vm-test-run-timescaledb> server # [ 127.961843] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-timescaledb> server # [ 128.316313] postgres[1594]: ::1 2026-10-08 15:40:53.906 UTC [1594] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.334650] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: GRANT vm-test-run-timescaledb> server # [ 128.339376] postgres[1594]: ::1 2026-10-08 15:40:53.933 UTC [1594] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.347146] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: GRANT vm-test-run-timescaledb> server # [ 128.351278] postgres[1594]: ::1 2026-10-08 15:40:53.954 UTC [1594] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.365492] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: GRANT vm-test-run-timescaledb> server # [ 128.369919] postgres[1594]: ::1 2026-10-08 15:40:53.971 UTC [1594] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.378801] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: ALTER TABLE vm-test-run-timescaledb> server # [ 128.384943] postgres[1594]: ::1 2026-10-08 15:40:53.986 UTC [1594] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.392049] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: ALTER TABLE vm-test-run-timescaledb> server # [ 128.397966] postgres[1594]: ::1 2026-10-08 15:40:53.997 UTC [1594] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.403213] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: ALTER TABLE vm-test-run-timescaledb> server # [ 128.409880] postgres[1594]: ::1 2026-10-08 15:40:54.008 UTC [1594] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.416911] postgres[1594]: ::1 2026-10-08 15:40:54.018 UTC [1594] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.418987] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: ALTER TABLE vm-test-run-timescaledb> server # [ 128.437139] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: ALTER TABLE vm-test-run-timescaledb> server # [ 128.441883] postgres[1594]: ::1 2026-10-08 15:40:54.042 UTC [1594] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 128.459688] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: GRANT vm-test-run-timescaledb> server # [ 128.462715] postgres[1594]: ::1 2026-10-08 15:40:54.066 UTC [1594] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 128.477344] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: GRANT vm-test-run-timescaledb> server # [ 128.485423] postgres[1594]: ::1 2026-10-08 15:40:54.083 UTC [1594] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 128.493671] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: GRANT vm-test-run-timescaledb> server # [ 128.501159] postgres[1594]: ::1 2026-10-08 15:40:54.098 UTC [1594] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 128.521945] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: GRANT vm-test-run-timescaledb> server # [ 128.523583] postgres[1594]: ::1 2026-10-08 15:40:54.126 UTC [1594] 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-timescaledb> server # [ 128.541667] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 128.545344] postgres[1594]: ::1 2026-10-08 15:40:54.146 UTC [1594] 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-timescaledb> server # [ 128.557748] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 128.559055] postgres[1594]: ::1 2026-10-08 15:40:54.157 UTC [1594] 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-timescaledb> server # [ 128.569147] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1593]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 128.618579] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-timescaledb> server # [ 128.847670] postgres[1596]: ::1 2026-10-08 15:40:54.446 UTC [1596] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-timescaledb> server # [ 128.870057] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1595]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 128.912374] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 129.202216] postgres[1598]: ::1 2026-10-08 15:40:54.793 UTC [1598] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-timescaledb> server # [ 129.219828] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1597]: GRANT vm-test-run-timescaledb> server # [ 129.229221] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1597]: GRANT vm-test-run-timescaledb> server # [ 129.230012] postgres[1598]: ::1 2026-10-08 15:40:54.821 UTC [1598] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 129.232165] postgres[1598]: ::1 2026-10-08 15:40:54.824 UTC [1598] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 129.242797] postgres[1598]: ::1 2026-10-08 15:40:54.837 UTC [1598] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 129.249417] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1597]: GRANT vm-test-run-timescaledb> server # [ 129.249999] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1597]: GRANT vm-test-run-timescaledb> server # [ 129.309325] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-timescaledb> server # [ 129.957223] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1602]: DO vm-test-run-timescaledb> server # [ 129.960210] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1602]: DO vm-test-run-timescaledb> server # [ 129.976890] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1602]: DO vm-test-run-timescaledb> server # [ 130.038722] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 130.422540] postgres[1621]: ::1 2026-10-08 15:40:56.014 UTC [1621] 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-timescaledb> server # [ 130.463135] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1618]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 130.490889] postgres[1621]: ::1 2026-10-08 15:40:56.052 UTC [1621] 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-timescaledb> server # [ 130.494694] postgres[1621]: ::1 2026-10-08 15:40:56.079 UTC [1621] 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-timescaledb> server # [ 130.502555] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1618]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 130.509459] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1618]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 130.568934] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-timescaledb> server # [ 131.006211] postgres[1628]: ::1 2026-10-08 15:40:56.603 UTC [1628] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-timescaledb> server # [ 131.041402] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1623]: ALTER ROLE vm-test-run-timescaledb> server # [ 131.091365] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-timescaledb> server # [ 131.371575] postgres[1630]: ::1 2026-10-08 15:40:56.971 UTC [1630] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 131.380878] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-timescaledb> server # [ 131.385987] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.386937] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-timescaledb> server # [ 131.387943] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: DROP FUNCTION vm-test-run-timescaledb> server # [ 131.389853] postgres[1630]: ::1 2026-10-08 15:40:56.982 UTC [1630] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 131.394342] postgres[1630]: ::1 2026-10-08 15:40:56.988 UTC [1630] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 131.395298] postgres[1630]: DECLARE vm-test-run-timescaledb> server # [ 131.395908] postgres[1630]: cmd record; vm-test-run-timescaledb> server # [ 131.403759] postgres[1630]: BEGIN vm-test-run-timescaledb> server # [ 131.405172] postgres[1630]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 131.405611] postgres[1630]: LOOP vm-test-run-timescaledb> server # [ 131.406331] postgres[1630]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 131.407865] postgres[1630]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 131.411767] postgres[1630]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 131.415265] postgres[1630]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 131.415858] postgres[1630]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 131.417112] postgres[1630]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 131.417697] postgres[1630]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 131.418388] postgres[1630]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 131.420195] postgres[1630]: , 'CREATE TYPE' vm-test-run-timescaledb> server # [ 131.420983] postgres[1630]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 131.421306] postgres[1630]: , 'COMMENT' vm-test-run-timescaledb> server # [ 131.422156] postgres[1630]: ) vm-test-run-timescaledb> server # [ 131.422635] postgres[1630]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 131.424093] postgres[1630]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 131.425412] postgres[1630]: THEN vm-test-run-timescaledb> server # [ 131.427204] postgres[1630]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 131.429159] postgres[1630]: END IF; vm-test-run-timescaledb> server # [ 131.430708] postgres[1630]: END LOOP; vm-test-run-timescaledb> server # [ 131.431352] postgres[1630]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 131.434027] postgres[1630]: ::1 2026-10-08 15:40:57.024 UTC [1630] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 131.435149] postgres[1630]: DECLARE vm-test-run-timescaledb> server # [ 131.437348] postgres[1630]: obj record; vm-test-run-timescaledb> server # [ 131.437833] postgres[1630]: BEGIN vm-test-run-timescaledb> server # [ 131.438855] postgres[1630]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 131.440285] postgres[1630]: LOOP vm-test-run-timescaledb> server # [ 131.442108] postgres[1630]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 131.445617] postgres[1630]: 'schema' vm-test-run-timescaledb> server # [ 131.446106] postgres[1630]: , 'table' vm-test-run-timescaledb> server # [ 131.446493] postgres[1630]: , 'foreign table' vm-test-run-timescaledb> server # [ 131.447525] postgres[1630]: , 'view' vm-test-run-timescaledb> server # [ 131.448015] postgres[1630]: , 'materialized view' vm-test-run-timescaledb> server # [ 131.450227] postgres[1630]: , 'function' vm-test-run-timescaledb> server # [ 131.450652] postgres[1630]: , 'trigger' vm-test-run-timescaledb> server # [ 131.450928] postgres[1630]: , 'type' vm-test-run-timescaledb> server # [ 131.455095] postgres[1630]: , 'rule' vm-test-run-timescaledb> server # [ 131.457263] postgres[1630]: ) vm-test-run-timescaledb> server # [ 131.457611] postgres[1630]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 131.459186] postgres[1630]: THEN vm-test-run-timescaledb> server # [ 131.460795] postgres[1630]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 131.461464] postgres[1630]: END IF; vm-test-run-timescaledb> server # [ 131.462077] postgres[1630]: END LOOP; vm-test-run-timescaledb> server # [ 131.463583] postgres[1630]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 131.464473] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 131.471423] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 131.473837] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 131.475810] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.477721] postgres[1630]: ::1 2026-10-08 15:40:57.040 UTC [1630] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 131.479271] postgres[1630]: ::1 2026-10-08 15:40:57.050 UTC [1630] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 131.481384] postgres[1630]: ON ddl_command_end vm-test-run-timescaledb> server # [ 131.483780] postgres[1630]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 131.485282] postgres[1630]: ::1 2026-10-08 15:40:57.070 UTC [1630] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 131.485912] postgres[1630]: ::1 2026-10-08 15:40:57.075 UTC [1630] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 131.486966] postgres[1630]: ON sql_drop vm-test-run-timescaledb> server # [ 131.489442] postgres[1630]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 131.491072] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.492706] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 131.494240] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.495216] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1629]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.531259] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-timescaledb> server # [ 132.721646] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1631]: DO vm-test-run-timescaledb> server # [ 132.759776] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-timescaledb> server # [ 133.211963] postgres[1647]: ::1 2026-10-08 15:40:58.802 UTC [1647] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-timescaledb> server # [ 133.295623] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 133.299853] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping vm-test-run-timescaledb> server # [ 133.305967] postgres[1647]: ::1 2026-10-08 15:40:58.895 UTC [1647] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-timescaledb> server # [ 133.306724] postgres[1647]: ::1 2026-10-08 15:40:58.907 UTC [1647] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 133.307171] postgres[1647]: "operationName" text default null, vm-test-run-timescaledb> server # [ 133.307943] postgres[1647]: query text default null, vm-test-run-timescaledb> server # [ 133.312699] postgres[1647]: variables jsonb default null, vm-test-run-timescaledb> server # [ 133.313683] postgres[1647]: extensions jsonb default null vm-test-run-timescaledb> server # [ 133.315002] postgres[1647]: ) vm-test-run-timescaledb> server # [ 133.315334] postgres[1647]: returns jsonb vm-test-run-timescaledb> server # [ 133.316319] postgres[1647]: language plpgsql vm-test-run-timescaledb> server # [ 133.321411] postgres[1647]: as $$ vm-test-run-timescaledb> server # [ 133.322376] postgres[1647]: DECLARE vm-test-run-timescaledb> server # [ 133.322840] postgres[1647]: server_version float; vm-test-run-timescaledb> server # [ 133.323334] postgres[1647]: BEGIN vm-test-run-timescaledb> server # [ 133.328861] postgres[1647]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 133.329676] postgres[1647]: vm-test-run-timescaledb> server # [ 133.330130] postgres[1647]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 133.330413] postgres[1647]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 133.331831] postgres[1647]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 133.337098] postgres[1647]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 133.338498] postgres[1647]: ); vm-test-run-timescaledb> server # [ 133.339176] postgres[1647]: ELSE vm-test-run-timescaledb> server # [ 133.346924] postgres[1647]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 133.347979] postgres[1647]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 133.348887] postgres[1647]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 133.350273] postgres[1647]: ); vm-test-run-timescaledb> server # [ 133.350891] postgres[1647]: END IF; vm-test-run-timescaledb> server # [ 133.351200] postgres[1647]: END; vm-test-run-timescaledb> server # [ 133.351725] postgres[1647]: $$; vm-test-run-timescaledb> server # [ 133.352211] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: DROP FUNCTION vm-test-run-timescaledb> server # [ 133.358151] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 133.359905] postgres[1647]: ::1 2026-10-08 15:40:58.950 UTC [1647] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.368760] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: GRANT vm-test-run-timescaledb> server # [ 133.375791] postgres[1647]: ::1 2026-10-08 15:40:58.972 UTC [1647] 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-timescaledb> server # [ 133.398847] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.410591] postgres[1647]: ::1 2026-10-08 15:40:59.008 UTC [1647] 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-timescaledb> server # [ 133.435306] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.444095] postgres[1647]: ::1 2026-10-08 15:40:59.041 UTC [1647] 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-timescaledb> server # [ 133.477462] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.479660] postgres[1647]: ::1 2026-10-08 15:40:59.073 UTC [1647] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 133.485612] postgres[1647]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.503714] postgres[1647]: ::1 2026-10-08 15:40:59.096 UTC [1647] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 133.509339] postgres[1647]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.510060] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.510569] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.510965] postgres[1647]: ::1 2026-10-08 15:40:59.112 UTC [1647] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 133.511406] postgres[1647]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.519016] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.528816] postgres[1647]: ::1 2026-10-08 15:40:59.130 UTC [1647] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 133.529679] postgres[1647]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 133.530430] postgres[1647]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 133.531384] postgres[1647]: AS $func$ vm-test-run-timescaledb> server # [ 133.532302] postgres[1647]: DECLARE vm-test-run-timescaledb> server # [ 133.545700] postgres[1647]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 133.546776] postgres[1647]: BEGIN vm-test-run-timescaledb> server # [ 133.547210] postgres[1647]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 133.547824] postgres[1647]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 133.548727] postgres[1647]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 133.558759] postgres[1647]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 133.559370] postgres[1647]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 133.559778] postgres[1647]: ); vm-test-run-timescaledb> server # [ 133.573271] postgres[1647]: vm-test-run-timescaledb> server # [ 133.574309] postgres[1647]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 133.574687] postgres[1647]: THEN vm-test-run-timescaledb> server # [ 133.574945] postgres[1647]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.575217] postgres[1647]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.575620] postgres[1647]: vm-test-run-timescaledb> server # [ 133.576069] postgres[1647]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.586842] postgres[1647]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.594986] postgres[1647]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.602963] postgres[1647]: vm-test-run-timescaledb> server # [ 133.604011] postgres[1647]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 133.611328] postgres[1647]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 133.617435] postgres[1647]: "operationName" text default null, vm-test-run-timescaledb> server # [ 133.617988] postgres[1647]: query text default null, vm-test-run-timescaledb> server # [ 133.618469] postgres[1647]: variables jsonb default null, vm-test-run-timescaledb> server # [ 133.619406] postgres[1647]: extensions jsonb default null vm-test-run-timescaledb> server # [ 133.629798] postgres[1647]: ) vm-test-run-timescaledb> server # [ 133.639008] postgres[1647]: returns jsonb vm-test-run-timescaledb> server # [ 133.640463] postgres[1647]: language sql vm-test-run-timescaledb> server # [ 133.652144] postgres[1647]: as $$ vm-test-run-timescaledb> server # [ 133.653581] postgres[1647]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-timescaledb> server # [ 133.654443] postgres[1647]: $$; vm-test-run-timescaledb> server # [ 133.656170] postgres[1647]: vm-test-run-timescaledb> server # [ 133.662649] postgres[1647]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.663934] postgres[1647]: END IF; vm-test-run-timescaledb> server # [ 133.692385] postgres[1647]: vm-test-run-timescaledb> server # [ 133.693349] postgres[1647]: END; vm-test-run-timescaledb> server # [ 133.709628] postgres[1647]: $func$; vm-test-run-timescaledb> server # [ 133.711952] postgres[1647]: ::1 2026-10-08 15:40:59.149 UTC [1647] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-timescaledb> server # [ 133.729497] postgres[1647]: ::1 2026-10-08 15:40:59.155 UTC [1647] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION') vm-test-run-timescaledb> server # [ 133.730593] postgres[1647]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-timescaledb> server # [ 133.730963] postgres[1647]: ::1 2026-10-08 15:40:59.164 UTC [1647] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-timescaledb> server # [ 133.731385] postgres[1647]: ::1 2026-10-08 15:40:59.178 UTC [1647] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 133.731831] postgres[1647]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 133.732066] postgres[1647]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 133.745246] postgres[1647]: AS $func$ vm-test-run-timescaledb> server # [ 133.748083] postgres[1647]: DECLARE vm-test-run-timescaledb> server # [ 133.753948] postgres[1647]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 133.755274] postgres[1647]: BEGIN vm-test-run-timescaledb> server # [ 133.761317] postgres[1647]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 133.773009] postgres[1647]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 133.774007] postgres[1647]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 133.781804] postgres[1647]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 133.783706] postgres[1647]: ); vm-test-run-timescaledb> server # [ 133.784454] postgres[1647]: vm-test-run-timescaledb> server # [ 133.796115] postgres[1647]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 133.797747] postgres[1647]: THEN vm-test-run-timescaledb> server # [ 133.804586] postgres[1647]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 133.812926] postgres[1647]: "operationName" text default null, vm-test-run-timescaledb> server # [ 133.813760] postgres[1647]: query text default null, vm-test-run-timescaledb> server # [ 133.816861] postgres[1647]: variables jsonb default null, vm-test-run-timescaledb> server # [ 133.818206] postgres[1647]: extensions jsonb default null vm-test-run-timescaledb> server # [ 133.819709] postgres[1647]: ) vm-test-run-timescaledb> server # [ 133.824549] postgres[1647]: returns jsonb vm-test-run-timescaledb> server # [ 133.833526] postgres[1647]: language plpgsql vm-test-run-timescaledb> server # [ 133.834393] postgres[1647]: as $$ vm-test-run-timescaledb> server # [ 133.835228] postgres[1647]: DECLARE vm-test-run-timescaledb> server # [ 133.841169] postgres[1647]: server_version float; vm-test-run-timescaledb> server # [ 133.845466] postgres[1647]: BEGIN vm-test-run-timescaledb> server # [ 133.846013] postgres[1647]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 133.847440] postgres[1647]: vm-test-run-timescaledb> server # [ 133.848132] postgres[1647]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 133.848555] postgres[1647]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 133.854381] postgres[1647]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 133.855297] postgres[1647]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 133.857169] postgres[1647]: ); vm-test-run-timescaledb> server # [ 133.857852] postgres[1647]: ELSE vm-test-run-timescaledb> server # [ 133.860180] postgres[1647]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 133.865821] postgres[1647]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 133.867178] postgres[1647]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 133.869648] postgres[1647]: ); vm-test-run-timescaledb> server # [ 133.875379] postgres[1647]: END IF; vm-test-run-timescaledb> server # [ 133.876226] postgres[1647]: END; vm-test-run-timescaledb> server # [ 133.886856] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 133.888051] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping vm-test-run-timescaledb> server # [ 133.893915] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 133.894693] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 133.895900] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: COMMENT vm-test-run-timescaledb> server # [ 133.896952] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 133.898824] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping vm-test-run-timescaledb> server # [ 133.909242] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 133.913131] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 133.914222] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1644]: COMMENT vm-test-run-timescaledb> server # [ 133.915731] postgres[1647]: $$; vm-test-run-timescaledb> server # [ 133.917681] postgres[1647]: END IF; vm-test-run-timescaledb> server # [ 133.925686] postgres[1647]: vm-test-run-timescaledb> server # [ 133.928039] postgres[1647]: END; vm-test-run-timescaledb> server # [ 133.930667] postgres[1647]: $func$; vm-test-run-timescaledb> server # [ 133.931133] postgres[1647]: ::1 2026-10-08 15:40:59.231 UTC [1647] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-timescaledb> server # [ 133.932257] postgres[1647]: ::1 2026-10-08 15:40:59.240 UTC [1647] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-timescaledb> server # [ 133.933529] postgres[1647]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-timescaledb> server # [ 133.933940] postgres[1647]: ::1 2026-10-08 15:40:59.248 UTC [1647] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql'; vm-test-run-timescaledb> server # [ 133.948227] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-timescaledb> server # [ 134.215542] postgres[1664]: ::1 2026-10-08 15:40:59.809 UTC [1664] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 134.226175] postgres[1664]: ::1 2026-10-08 15:40:59.821 UTC [1664] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 134.242406] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1661]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-timescaledb> server # [ 134.251990] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1661]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.263251] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1661]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-timescaledb> server # [ 134.267931] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1661]: DROP FUNCTION vm-test-run-timescaledb> server # [ 134.273987] postgres[1664]: ::1 2026-10-08 15:40:59.846 UTC [1664] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 134.274662] postgres[1664]: DECLARE vm-test-run-timescaledb> server # [ 134.274933] postgres[1664]: cmd record; vm-test-run-timescaledb> server # [ 134.275165] postgres[1664]: BEGIN vm-test-run-timescaledb> server # [ 134.275631] postgres[1664]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 134.284307] postgres[1664]: LOOP vm-test-run-timescaledb> server # [ 134.291308] postgres[1664]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 134.294121] postgres[1664]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 134.302697] postgres[1664]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 134.303778] postgres[1664]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 134.305336] postgres[1664]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 134.306257] postgres[1664]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 134.307111] postgres[1664]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 134.307782] postgres[1664]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 134.308106] postgres[1664]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-timescaledb> server # [ 134.308372] postgres[1664]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 134.320917] postgres[1664]: , 'COMMENT' vm-test-run-timescaledb> server # [ 134.321719] postgres[1664]: ) vm-test-run-timescaledb> server # [ 134.325233] postgres[1664]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 134.326326] postgres[1664]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 134.327309] postgres[1664]: THEN vm-test-run-timescaledb> server # [ 134.333162] postgres[1664]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 134.334339] postgres[1664]: END IF; vm-test-run-timescaledb> server # [ 134.335100] postgres[1664]: END LOOP; vm-test-run-timescaledb> server # [ 134.335834] postgres[1664]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 134.369644] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1661]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 134.375259] postgres[1664]: ::1 2026-10-08 15:40:59.978 UTC [1664] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 134.386038] postgres[1664]: DECLARE vm-test-run-timescaledb> server # [ 134.386911] postgres[1664]: obj record; vm-test-run-timescaledb> server # [ 134.387226] postgres[1664]: BEGIN vm-test-run-timescaledb> server # [ 134.387771] postgres[1664]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 134.393248] postgres[1664]: LOOP vm-test-run-timescaledb> server # [ 134.393939] postgres[1664]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 134.394666] postgres[1664]: 'schema' vm-test-run-timescaledb> server # [ 134.395042] postgres[1664]: , 'table' vm-test-run-timescaledb> server # [ 134.395285] postgres[1664]: , 'foreign table' vm-test-run-timescaledb> server # [ 134.395807] postgres[1664]: , 'view' vm-test-run-timescaledb> server # [ 134.405236] postgres[1664]: , 'materialized view' vm-test-run-timescaledb> server # [ 134.405800] postgres[1664]: , 'function' vm-test-run-timescaledb> server # [ 134.406102] postgres[1664]: , 'trigger' vm-test-run-timescaledb> server # [ 134.407699] postgres[1664]: , 'type' vm-test-run-timescaledb> server # [ 134.412950] postgres[1664]: , 'rule' vm-test-run-timescaledb> server # [ 134.414259] postgres[1664]: ) vm-test-run-timescaledb> server # [ 134.414932] postgres[1664]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 134.415441] postgres[1664]: THEN vm-test-run-timescaledb> server # [ 134.415923] postgres[1664]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 134.424877] postgres[1664]: END IF; vm-test-run-timescaledb> server # [ 134.425568] postgres[1664]: END LOOP; vm-test-run-timescaledb> server # [ 134.425853] postgres[1664]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 134.426280] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1661]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 134.429097] postgres[1664]: ::1 2026-10-08 15:41:00.030 UTC [1664] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 134.448838] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1661]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.449996] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1661]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.451037] postgres[1664]: ::1 2026-10-08 15:41:00.042 UTC [1664] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 134.451821] postgres[1664]: ON ddl_command_end vm-test-run-timescaledb> server # [ 134.452135] postgres[1664]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 134.467154] postgres[1664]: ::1 2026-10-08 15:41:00.050 UTC [1664] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 134.497985] postgres[1664]: ::1 2026-10-08 15:41:00.063 UTC [1664] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 134.518472] postgres[1664]: ON sql_drop vm-test-run-timescaledb> server # [ 134.531929] postgres[1664]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 134.546591] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1661]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.547374] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1661]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.566207] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-timescaledb> server # [ 134.798017] postgres[1666]: ::1 2026-10-08 15:41:00.392 UTC [1666] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-timescaledb> server # [ 134.824814] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1665]: ALTER ROLE vm-test-run-timescaledb> server # [ 134.833921] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-timescaledb> server # [ 135.102920] postgres[1668]: ::1 2026-10-08 15:41:00.696 UTC [1668] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 135.103718] postgres[1668]: returns event_trigger vm-test-run-timescaledb> server # [ 135.105805] postgres[1668]: language plpgsql vm-test-run-timescaledb> server # [ 135.106775] postgres[1668]: AS $func$ vm-test-run-timescaledb> server # [ 135.107182] postgres[1668]: DECLARE vm-test-run-timescaledb> server # [ 135.108052] postgres[1668]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 135.108963] postgres[1668]: BEGIN vm-test-run-timescaledb> server # [ 135.109288] postgres[1668]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 135.109550] postgres[1668]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 135.110132] postgres[1668]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 135.110546] postgres[1668]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 135.110795] postgres[1668]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 135.111383] postgres[1668]: ); vm-test-run-timescaledb> server # [ 135.111725] postgres[1668]: vm-test-run-timescaledb> server # [ 135.112239] postgres[1668]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 135.114884] postgres[1668]: THEN vm-test-run-timescaledb> server # [ 135.115281] postgres[1668]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.115819] postgres[1668]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.116148] postgres[1668]: vm-test-run-timescaledb> server # [ 135.117231] postgres[1668]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.117857] postgres[1668]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.118259] postgres[1668]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.121258] postgres[1668]: vm-test-run-timescaledb> server # [ 135.122412] postgres[1668]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 135.123674] postgres[1668]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 135.126339] postgres[1668]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 135.126982] postgres[1668]: "operationName" text default null, vm-test-run-timescaledb> server # [ 135.128287] postgres[1668]: query text default null, vm-test-run-timescaledb> server # [ 135.129361] postgres[1668]: variables jsonb default null, vm-test-run-timescaledb> server # [ 135.129913] postgres[1668]: extensions jsonb default null vm-test-run-timescaledb> server # [ 135.130990] postgres[1668]: ) vm-test-run-timescaledb> server # [ 135.131264] postgres[1668]: returns jsonb vm-test-run-timescaledb> server # [ 135.131948] postgres[1668]: language sql vm-test-run-timescaledb> server # [ 135.132592] postgres[1668]: as $$ vm-test-run-timescaledb> server # [ 135.133341] postgres[1668]: -- This changed vm-test-run-timescaledb> server # [ 135.133774] postgres[1668]: select graphql.resolve( vm-test-run-timescaledb> server # [ 135.134364] postgres[1668]: query := query, vm-test-run-timescaledb> server # [ 135.134650] postgres[1668]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 135.135087] postgres[1668]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 135.135405] postgres[1668]: extensions := extensions vm-test-run-timescaledb> server # [ 135.137609] postgres[1668]: ); vm-test-run-timescaledb> server # [ 135.138635] postgres[1668]: $$; vm-test-run-timescaledb> server # [ 135.138925] postgres[1668]: vm-test-run-timescaledb> server # [ 135.139153] postgres[1668]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.139452] postgres[1668]: END IF; vm-test-run-timescaledb> server # [ 135.141529] postgres[1668]: vm-test-run-timescaledb> server # [ 135.142781] postgres[1668]: END; vm-test-run-timescaledb> server # [ 135.143265] postgres[1668]: $func$; vm-test-run-timescaledb> server # [ 135.179326] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1667]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 135.189278] postgres[1668]: ::1 2026-10-08 15:41:00.778 UTC [1668] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 135.190117] postgres[1668]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 135.190476] postgres[1668]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 135.191261] postgres[1668]: AS $func$ vm-test-run-timescaledb> server # [ 135.195120] postgres[1668]: DECLARE vm-test-run-timescaledb> server # [ 135.196010] postgres[1668]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 135.196294] postgres[1668]: BEGIN vm-test-run-timescaledb> server # [ 135.199989] postgres[1668]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 135.200586] postgres[1668]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 135.201540] postgres[1668]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 135.201814] postgres[1668]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 135.202083] postgres[1668]: ); vm-test-run-timescaledb> server # [ 135.202487] postgres[1668]: vm-test-run-timescaledb> server # [ 135.203239] postgres[1668]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 135.204363] postgres[1668]: THEN vm-test-run-timescaledb> server # [ 135.204634] postgres[1668]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 135.213246] postgres[1668]: "operationName" text default null, vm-test-run-timescaledb> server # [ 135.213930] postgres[1668]: query text default null, vm-test-run-timescaledb> server # [ 135.214528] postgres[1668]: variables jsonb default null, vm-test-run-timescaledb> server # [ 135.214849] postgres[1668]: extensions jsonb default null vm-test-run-timescaledb> server # [ 135.215830] postgres[1668]: ) vm-test-run-timescaledb> server # [ 135.221896] postgres[1668]: returns jsonb vm-test-run-timescaledb> server # [ 135.222370] postgres[1668]: language plpgsql vm-test-run-timescaledb> server # [ 135.222991] postgres[1668]: as $$ vm-test-run-timescaledb> server # [ 135.224132] postgres[1668]: DECLARE vm-test-run-timescaledb> server # [ 135.231754] postgres[1668]: server_version float; vm-test-run-timescaledb> server # [ 135.234902] postgres[1668]: BEGIN vm-test-run-timescaledb> server # [ 135.235661] postgres[1668]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 135.236286] postgres[1668]: vm-test-run-timescaledb> server # [ 135.240293] postgres[1668]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 135.242694] postgres[1668]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.243627] postgres[1668]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 135.248440] postgres[1668]: jsonb_build_object( vm-test-run-timescaledb> server # [ 135.250080] postgres[1668]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 135.250471] postgres[1668]: ) vm-test-run-timescaledb> server # [ 135.252572] postgres[1668]: ) vm-test-run-timescaledb> server # [ 135.253152] postgres[1668]: ); vm-test-run-timescaledb> server # [ 135.257370] postgres[1668]: ELSE vm-test-run-timescaledb> server # [ 135.258628] postgres[1668]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.259345] postgres[1668]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 135.259933] postgres[1668]: jsonb_build_object( vm-test-run-timescaledb> server # [ 135.264853] postgres[1668]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 135.266092] postgres[1668]: ) vm-test-run-timescaledb> server # [ 135.266443] postgres[1668]: ) vm-test-run-timescaledb> server # [ 135.266714] postgres[1668]: ); vm-test-run-timescaledb> server # [ 135.267099] postgres[1668]: END IF; vm-test-run-timescaledb> server # [ 135.268032] postgres[1668]: END; vm-test-run-timescaledb> server # [ 135.268300] postgres[1668]: $$; vm-test-run-timescaledb> server # [ 135.275880] postgres[1668]: END IF; vm-test-run-timescaledb> server # [ 135.277273] postgres[1668]: vm-test-run-timescaledb> server # [ 135.277568] postgres[1668]: END; vm-test-run-timescaledb> server # [ 135.278494] postgres[1668]: $func$; vm-test-run-timescaledb> server # [ 135.279683] postgres[1668]: ::1 2026-10-08 15:41:00.809 UTC [1668] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 135.283096] postgres[1668]: "operationName" text default null, vm-test-run-timescaledb> server # [ 135.285147] postgres[1668]: query text default null, vm-test-run-timescaledb> server # [ 135.287444] postgres[1668]: variables jsonb default null, vm-test-run-timescaledb> server # [ 135.289417] postgres[1668]: extensions jsonb default null vm-test-run-timescaledb> server # [ 135.290905] postgres[1668]: ) vm-test-run-timescaledb> server # [ 135.294006] postgres[1668]: returns jsonb vm-test-run-timescaledb> server # [ 135.295847] postgres[1668]: language plpgsql vm-test-run-timescaledb> server # [ 135.301254] postgres[1668]: as $$ vm-test-run-timescaledb> server # [ 135.304694] postgres[1668]: DECLARE vm-test-run-timescaledb> server # [ 135.307920] postgres[1668]: server_version float; vm-test-run-timescaledb> server # [ 135.314016] postgres[1668]: BEGIN vm-test-run-timescaledb> server # [ 135.318140] postgres[1668]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 135.322325] postgres[1668]: vm-test-run-timescaledb> server # [ 135.325581] postgres[1668]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 135.326354] postgres[1668]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.327733] postgres[1668]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 135.329768] postgres[1668]: jsonb_build_object( vm-test-run-timescaledb> server # [ 135.331291] postgres[1668]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 135.332959] postgres[1668]: ) vm-test-run-timescaledb> server # [ 135.333632] postgres[1668]: ) vm-test-run-timescaledb> server # [ 135.334715] postgres[1668]: ); vm-test-run-timescaledb> server # [ 135.336426] postgres[1668]: ELSE vm-test-run-timescaledb> server # [ 135.337615] postgres[1668]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.338628] postgres[1668]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 135.339038] postgres[1668]: jsonb_build_object( vm-test-run-timescaledb> server # [ 135.339330] postgres[1668]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 135.341128] postgres[1668]: ) vm-test-run-timescaledb> server # [ 135.341977] postgres[1668]: ) vm-test-run-timescaledb> server # [ 135.342295] postgres[1668]: ); vm-test-run-timescaledb> server # [ 135.342940] postgres[1668]: END IF; vm-test-run-timescaledb> server # [ 135.343277] postgres[1668]: END; vm-test-run-timescaledb> server # [ 135.344151] postgres[1668]: $$; vm-test-run-timescaledb> server # [ 135.345502] postgres[1668]: ::1 2026-10-08 15:41:00.849 UTC [1668] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 135.347228] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1667]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 135.349512] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1667]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 135.350439] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1667]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping vm-test-run-timescaledb> server # [ 135.351719] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1667]: DROP EXTENSION vm-test-run-timescaledb> server # [ 137.410608] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1667]: DO vm-test-run-timescaledb> server # [ 137.447347] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql vm-test-run-timescaledb> server # [ 137.758832] postgres[1694]: ::1 2026-10-08 15:41:03.343 UTC [1694] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-timescaledb> server # [ 137.783734] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1693]: GRANT ROLE vm-test-run-timescaledb> server # [ 137.820920] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-timescaledb> server # [ 138.169988] postgres[1700]: ::1 2026-10-08 15:41:03.769 UTC [1700] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 138.174325] postgres[1700]: returns event_trigger vm-test-run-timescaledb> server # [ 138.177219] postgres[1700]: language plpgsql vm-test-run-timescaledb> server # [ 138.178587] postgres[1700]: AS $func$ vm-test-run-timescaledb> server # [ 138.180472] postgres[1700]: DECLARE vm-test-run-timescaledb> server # [ 138.182334] postgres[1700]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 138.183743] postgres[1700]: BEGIN vm-test-run-timescaledb> server # [ 138.185483] postgres[1700]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 138.186059] postgres[1700]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 138.190677] postgres[1700]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 138.192048] postgres[1700]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 138.193637] postgres[1700]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 138.194597] postgres[1700]: ); vm-test-run-timescaledb> server # [ 138.194885] postgres[1700]: vm-test-run-timescaledb> server # [ 138.195109] postgres[1700]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 138.195349] postgres[1700]: THEN vm-test-run-timescaledb> server # [ 138.196110] postgres[1700]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 138.198869] postgres[1700]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 138.200100] postgres[1700]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 138.201518] postgres[1700]: "operationName" text default null, vm-test-run-timescaledb> server # [ 138.201939] postgres[1700]: query text default null, vm-test-run-timescaledb> server # [ 138.202213] postgres[1700]: variables jsonb default null, vm-test-run-timescaledb> server # [ 138.202462] postgres[1700]: extensions jsonb default null vm-test-run-timescaledb> server # [ 138.202677] postgres[1700]: ) vm-test-run-timescaledb> server # [ 138.203316] postgres[1700]: returns jsonb vm-test-run-timescaledb> server # [ 138.203752] postgres[1700]: language sql vm-test-run-timescaledb> server # [ 138.204010] postgres[1700]: as $$ vm-test-run-timescaledb> server # [ 138.205583] postgres[1700]: select graphql.resolve( vm-test-run-timescaledb> server # [ 138.206408] postgres[1700]: query := query, vm-test-run-timescaledb> server # [ 138.208585] postgres[1700]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 138.209158] postgres[1700]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 138.209538] postgres[1700]: extensions := extensions vm-test-run-timescaledb> server # [ 138.209781] postgres[1700]: ); vm-test-run-timescaledb> server # [ 138.209994] postgres[1700]: $$; vm-test-run-timescaledb> server # [ 138.210195] postgres[1700]: vm-test-run-timescaledb> server # [ 138.210392] postgres[1700]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 138.212038] postgres[1700]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 138.217298] postgres[1700]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 138.217828] postgres[1700]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.225774] postgres[1700]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.226513] postgres[1700]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.234608] postgres[1700]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.239049] postgres[1700]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.250050] postgres[1700]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.250777] postgres[1700]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.264825] postgres[1700]: END IF; vm-test-run-timescaledb> server # [ 138.266280] postgres[1700]: vm-test-run-timescaledb> server # [ 138.271749] postgres[1700]: END; vm-test-run-timescaledb> server # [ 138.275388] postgres[1700]: $func$; vm-test-run-timescaledb> server # [ 138.306708] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1697]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 138.307758] postgres[1700]: ::1 2026-10-08 15:41:03.903 UTC [1700] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 138.367888] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1697]: DROP EXTENSION vm-test-run-timescaledb> server # [ 140.312038] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1697]: DO vm-test-run-timescaledb> server # [ 140.369391] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-timescaledb> server # [ 141.438807] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1724]: DO vm-test-run-timescaledb> server # [ 142.162289] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1724]: DO vm-test-run-timescaledb> server # [ 142.234662] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-timescaledb> server # [ 142.620133] postgres[1736]: ::1 2026-10-08 15:41:08.207 UTC [1736] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 142.685982] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1732]: ALTER ROLE vm-test-run-timescaledb> server # [ 142.741364] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-timescaledb> server # [ 143.218074] postgres[1746]: ::1 2026-10-08 15:41:08.797 UTC [1746] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-timescaledb> server # [ 143.268763] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1740]: REVOKE ROLE vm-test-run-timescaledb> server # [ 143.326688] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-timescaledb> server # [ 145.484759] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1752]: DO vm-test-run-timescaledb> server # [ 145.537966] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 145.982743] postgres[1770]: ::1 2026-10-08 15:41:11.555 UTC [1770] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-timescaledb> server # [ 146.015782] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1761]: GRANT ROLE vm-test-run-timescaledb> server # [ 146.053615] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-timescaledb> server # [ 146.633311] postgres[1780]: ::1 2026-10-08 15:41:12.230 UTC [1780] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 146.755898] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1774]: GRANT vm-test-run-timescaledb> server # [ 146.770197] postgres[1780]: ::1 2026-10-08 15:41:12.341 UTC [1780] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 146.793706] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1774]: GRANT vm-test-run-timescaledb> server # [ 146.795108] postgres[1780]: ::1 2026-10-08 15:41:12.394 UTC [1780] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 146.803168] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1774]: GRANT vm-test-run-timescaledb> server # [ 146.804282] postgres[1780]: ::1 2026-10-08 15:41:12.406 UTC [1780] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 146.818955] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1774]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 146.819924] postgres[1780]: ::1 2026-10-08 15:41:12.422 UTC [1780] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option; vm-test-run-timescaledb> server # [ 146.833796] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1774]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 146.848458] postgres[1780]: ::1 2026-10-08 15:41:12.447 UTC [1780] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 146.869848] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1774]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 146.951559] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-timescaledb> server # [ 147.343072] postgres[1790]: ::1 2026-10-08 15:41:12.933 UTC [1790] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-timescaledb> server # [ 147.354077] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1785]: GRANT ROLE vm-test-run-timescaledb> server # [ 147.383309] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 147.652792] postgres[1792]: ::1 2026-10-08 15:41:13.249 UTC [1792] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-timescaledb> server # [ 147.670485] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1791]: GRANT ROLE vm-test-run-timescaledb> server # [ 147.709910] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-timescaledb> server # [ 148.058642] postgres[1797]: ::1 2026-10-08 15:41:13.652 UTC [1797] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-timescaledb> server # [ 148.070162] postgres[1797]: ::1 2026-10-08 15:41:13.666 UTC [1797] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-timescaledb> server # [ 148.077728] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1793]: ALTER ROLE vm-test-run-timescaledb> server # [ 148.078759] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1793]: ALTER ROLE vm-test-run-timescaledb> server # [ 148.079872] postgres[1797]: ::1 2026-10-08 15:41:13.680 UTC [1797] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-timescaledb> server # [ 148.089084] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1793]: ALTER ROLE vm-test-run-timescaledb> server # [ 148.139118] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1793]: DO vm-test-run-timescaledb> server # [ 148.202493] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 148.491818] postgres[1800]: ::1 2026-10-08 15:41:14.083 UTC [1800] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-timescaledb> server # [ 148.519731] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1799]: GRANT ROLE vm-test-run-timescaledb> server # [ 148.521991] postgres[1800]: ::1 2026-10-08 15:41:14.110 UTC [1800] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-timescaledb> server # [ 148.525226] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1799]: REVOKE ROLE vm-test-run-timescaledb> server # [ 148.564664] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-timescaledb> server # [ 148.897089] postgres[1802]: ::1 2026-10-08 15:41:14.487 UTC [1802] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 148.903617] postgres[1802]: returns event_trigger vm-test-run-timescaledb> server # [ 148.906036] postgres[1802]: language plpgsql vm-test-run-timescaledb> server # [ 148.911822] postgres[1802]: AS $func$ vm-test-run-timescaledb> server # [ 148.916161] postgres[1802]: DECLARE vm-test-run-timescaledb> server # [ 148.925038] postgres[1802]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 148.925587] postgres[1802]: BEGIN vm-test-run-timescaledb> server # [ 148.925894] postgres[1802]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 148.926136] postgres[1802]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 148.926795] postgres[1802]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 148.927229] postgres[1802]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 148.927661] postgres[1802]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 148.928002] postgres[1802]: ); vm-test-run-timescaledb> server # [ 148.928251] postgres[1802]: vm-test-run-timescaledb> server # [ 148.945193] postgres[1802]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 148.946052] postgres[1802]: THEN vm-test-run-timescaledb> server # [ 148.947028] postgres[1802]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 148.949932] postgres[1802]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 148.950727] postgres[1802]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 148.951681] postgres[1802]: "operationName" text default null, vm-test-run-timescaledb> server # [ 148.952009] postgres[1802]: query text default null, vm-test-run-timescaledb> server # [ 148.952259] postgres[1802]: variables jsonb default null, vm-test-run-timescaledb> server # [ 148.954325] postgres[1802]: extensions jsonb default null vm-test-run-timescaledb> server # [ 148.956843] postgres[1802]: ) vm-test-run-timescaledb> server # [ 148.957325] postgres[1802]: returns jsonb vm-test-run-timescaledb> server # [ 148.958547] postgres[1802]: language sql vm-test-run-timescaledb> server # [ 148.959024] postgres[1802]: as $$ vm-test-run-timescaledb> server # [ 148.960241] postgres[1802]: select graphql.resolve( vm-test-run-timescaledb> server # [ 148.962084] postgres[1802]: query := query, vm-test-run-timescaledb> server # [ 148.962493] postgres[1802]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 148.962910] postgres[1802]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 148.965859] postgres[1802]: extensions := extensions vm-test-run-timescaledb> server # [ 148.967088] postgres[1802]: ); vm-test-run-timescaledb> server # [ 148.973395] postgres[1802]: $$; vm-test-run-timescaledb> server # [ 148.974195] postgres[1802]: vm-test-run-timescaledb> server # [ 148.974463] postgres[1802]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 148.975771] postgres[1802]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 148.976124] postgres[1802]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 148.982779] postgres[1802]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 148.990433] postgres[1802]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 148.998455] postgres[1802]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.001025] postgres[1802]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.002828] postgres[1802]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.012926] postgres[1802]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.022460] postgres[1802]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.024010] postgres[1802]: vm-test-run-timescaledb> server # [ 149.030773] postgres[1802]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-timescaledb> server # [ 149.042779] postgres[1802]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-timescaledb> server # [ 149.051216] postgres[1802]: grant usage on schema graphql to postgres with grant option; vm-test-run-timescaledb> server # [ 149.058038] postgres[1802]: END IF; vm-test-run-timescaledb> server # [ 149.058424] postgres[1802]: vm-test-run-timescaledb> server # [ 149.059979] postgres[1802]: END; vm-test-run-timescaledb> server # [ 149.068615] postgres[1802]: $func$; vm-test-run-timescaledb> server # [ 149.069293] postgres[1802]: ::1 2026-10-08 15:41:14.573 UTC [1802] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 149.097987] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1801]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 149.154424] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1801]: DROP EXTENSION vm-test-run-timescaledb> server # [ 151.040633] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1801]: DO vm-test-run-timescaledb> server # [ 151.077777] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-timescaledb> server # [ 151.306259] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1827]: DO vm-test-run-timescaledb> server # [ 151.315191] postgres[1828]: ::1 2026-10-08 15:41:16.913 UTC [1828] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-timescaledb> server # [ 151.316200] postgres[1828]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 151.322714] postgres[1828]: AS $$ vm-test-run-timescaledb> server # [ 151.323341] postgres[1828]: BEGIN vm-test-run-timescaledb> server # [ 151.323765] postgres[1828]: IF EXISTS ( vm-test-run-timescaledb> server # [ 151.330320] postgres[1828]: SELECT vm-test-run-timescaledb> server # [ 151.331136] postgres[1828]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 151.331521] postgres[1828]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 151.332273] postgres[1828]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 151.340836] postgres[1828]: WHERE ext.extname = 'pg_cron' vm-test-run-timescaledb> server # [ 151.341850] postgres[1828]: ) vm-test-run-timescaledb> server # [ 151.342376] postgres[1828]: THEN vm-test-run-timescaledb> server # [ 151.342745] postgres[1828]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 151.344334] postgres[1828]: vm-test-run-timescaledb> server # [ 151.346208] postgres[1828]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 151.346757] postgres[1828]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 151.347440] postgres[1828]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 151.348688] postgres[1828]: vm-test-run-timescaledb> server # [ 151.349029] postgres[1828]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 151.349719] postgres[1828]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 151.350521] postgres[1828]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 151.351244] postgres[1828]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 151.351584] postgres[1828]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 151.352012] postgres[1828]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 151.354174] postgres[1828]: vm-test-run-timescaledb> server # [ 151.354617] postgres[1828]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 151.355157] postgres[1828]: revoke all on table cron.job from postgres; vm-test-run-timescaledb> server # [ 151.355598] postgres[1828]: grant select on table cron.job to postgres with grant option; vm-test-run-timescaledb> server # [ 151.356666] postgres[1828]: END IF; vm-test-run-timescaledb> server # [ 151.357152] postgres[1828]: END; vm-test-run-timescaledb> server # [ 151.358142] postgres[1828]: $$; vm-test-run-timescaledb> server # [ 151.381373] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1827]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 151.387778] postgres[1828]: ::1 2026-10-08 15:41:16.986 UTC [1828] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-timescaledb> server # [ 151.394566] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1827]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 151.401243] postgres[1828]: ::1 2026-10-08 15:41:17.000 UTC [1828] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-timescaledb> server # [ 151.409309] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1827]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 151.411148] postgres[1828]: ::1 2026-10-08 15:41:17.014 UTC [1828] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-timescaledb> server # [ 151.415982] postgres[1828]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-timescaledb> server # [ 151.417581] postgres[1828]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 151.427808] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1827]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 151.456336] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-timescaledb> server # [ 151.710460] postgres[1830]: ::1 2026-10-08 15:41:17.306 UTC [1830] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-timescaledb> server # [ 151.727591] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1829]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.769630] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-timescaledb> server # [ 152.201764] postgres[1835]: ::1 2026-10-08 15:41:17.781 UTC [1835] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-timescaledb> server # [ 152.266569] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1831]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 152.267410] postgres[1835]: ::1 2026-10-08 15:41:17.844 UTC [1835] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-timescaledb> server # [ 152.290800] postgres[1835]: ::1 2026-10-08 15:41:17.853 UTC [1835] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-timescaledb> server # [ 152.296087] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1831]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 152.307319] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1831]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 152.343999] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 152.822334] postgres[1845]: ::1 2026-10-08 15:41:18.406 UTC [1845] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-timescaledb> server # [ 152.850209] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1842]: GRANT ROLE vm-test-run-timescaledb> server # [ 152.893159] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-timescaledb> server # [ 154.242846] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1850]: DO vm-test-run-timescaledb> server # [ 154.290111] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-timescaledb> server # [ 154.665217] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1865]: DO vm-test-run-timescaledb> server # [ 154.671074] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1865]: DO vm-test-run-timescaledb> server # [ 154.705463] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-timescaledb> server # [ 154.951927] postgres[1868]: ::1 2026-10-08 15:41:20.547 UTC [1868] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-timescaledb> server # [ 154.956447] postgres[1868]: ::1 2026-10-08 15:41:20.558 UTC [1868] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-timescaledb> server # [ 154.963080] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1867]: ALTER ROLE vm-test-run-timescaledb> server # [ 154.965130] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1867]: ALTER ROLE vm-test-run-timescaledb> server # [ 154.966037] postgres[1868]: ::1 2026-10-08 15:41:20.567 UTC [1868] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-timescaledb> server # [ 154.980498] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1867]: ALTER ROLE vm-test-run-timescaledb> server # [ 155.018126] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-timescaledb> server # [ 155.314497] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1869]: DO vm-test-run-timescaledb> server # [ 155.367888] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-timescaledb> server # [ 155.865274] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1871]: DO vm-test-run-timescaledb> server # [ 155.944169] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-timescaledb> server # [ 156.644114] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1886]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 156.677981] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1886]: DO vm-test-run-timescaledb> server # [ 156.764139] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-timescaledb> server # [ 157.132232] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1897]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 157.155047] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1897]: GRANT vm-test-run-timescaledb> server # [ 157.194547] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-timescaledb> server # [ 157.470159] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1901]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 157.494803] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1901]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 157.506995] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1901]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 157.555208] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 157.839789] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1903]: DO vm-test-run-timescaledb> server # [ 157.906123] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-timescaledb> server # [ 158.314576] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1908]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 158.323599] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1908]: GRANT vm-test-run-timescaledb> server # [ 158.390746] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-timescaledb> server # [ 158.850121] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1911]: REVOKE ROLE vm-test-run-timescaledb> server # [ 158.915444] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1911]: DO vm-test-run-timescaledb> server # [ 158.943380] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1911]: DO vm-test-run-timescaledb> server # [ 158.953271] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1911]: REVOKE ROLE vm-test-run-timescaledb> server # [ 158.977846] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1911]: REVOKE vm-test-run-timescaledb> server # [ 159.039240] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1911]: DO vm-test-run-timescaledb> server # [ 159.087743] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 159.618123] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1924]: DO vm-test-run-timescaledb> server # [ 159.653234] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 160.154154] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1935]: DO vm-test-run-timescaledb> server # [ 160.217402] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 160.615238] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1941]: DO vm-test-run-timescaledb> server # [ 160.642810] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-timescaledb> server # [ 160.903158] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1943]: ALTER ROLE vm-test-run-timescaledb> server # [ 160.942428] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-timescaledb> server # [ 161.206826] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1945]: GRANT ROLE vm-test-run-timescaledb> server # [ 161.218340] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1945]: DO vm-test-run-timescaledb> server # [ 161.268731] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-timescaledb> server # [ 161.635636] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1947]: GRANT vm-test-run-timescaledb> server # [ 161.659650] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-timescaledb> server # [ 162.298439] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1952]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 162.305836] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1952]: REVOKE vm-test-run-timescaledb> server # [ 162.333610] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1952]: REVOKE vm-test-run-timescaledb> server # [ 162.345080] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1952]: GRANT vm-test-run-timescaledb> server # [ 162.413480] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-timescaledb> server # [ 162.948304] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1963]: DO vm-test-run-timescaledb> server # [ 162.982990] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-timescaledb> server # [ 163.405789] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1974]: ALTER ROLE vm-test-run-timescaledb> server # [ 163.432670] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-timescaledb> server # [ 163.918728] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1979]: DROP EXTENSION vm-test-run-timescaledb> server # [ 163.949306] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-timescaledb> server # [ 164.335490] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1985]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 164.359887] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1985]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 164.371651] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1985]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 164.417409] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-timescaledb> server # [ 164.680727] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1987]: DO vm-test-run-timescaledb> server # [ 164.714698] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1987]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 164.770801] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-timescaledb> server # [ 165.242239] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1989]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 165.252894] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1989]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 165.307641] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Running postgresql schema... vm-test-run-timescaledb> server # [ 165.841542] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER DATABASE vm-test-run-timescaledb> server # [ 165.875319] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER DATABASE vm-test-run-timescaledb> server # [ 166.158756] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.260713] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.410319] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.504128] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.555452] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.632447] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.691850] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.752635] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.806383] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.815155] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[2000]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.882697] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1459]: Database initialization complete vm-test-run-timescaledb> server # [ 166.899318] systemd[1]: Finished Supabase Database Initialization. vm-test-run-timescaledb> server # [ 166.919334] systemd[1]: Reached target Multi-User System. vm-test-run-timescaledb> server # [ 166.925385] systemd[1]: Startup finished in 16.733s (kernel) + 2min 30.186s (userspace) = 2min 46.919s. vm-test-run-timescaledb> server: (finished: waiting for unit supabase-db-init.service, in 169.41 seconds) vm-test-run-timescaledb> subtest: Verify PostgreSQL 15 is our custom build vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT version();" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT version();", in 0.56 seconds) vm-test-run-timescaledb> server: must succeed: readlink -f $(which postgres) vm-test-run-timescaledb> server: (finished: must succeed: readlink -f $(which postgres), in 0.48 seconds) vm-test-run-timescaledb> (finished: subtest: Verify PostgreSQL 15 is our custom build, in 1.04 seconds) vm-test-run-timescaledb> subtest: Verify ansible config loaded vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW shared_preload_libraries;" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW shared_preload_libraries;", in 0.54 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW session_preload_libraries;" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW session_preload_libraries;", in 0.53 seconds) vm-test-run-timescaledb> (finished: subtest: Verify ansible config loaded, in 1.06 seconds) vm-test-run-timescaledb> subtest: Verify init scripts and migrations ran vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT rolname FROM pg_roles ORDER BY rolname;" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT rolname FROM pg_roles ORDER BY rolname;", in 0.75 seconds) vm-test-run-timescaledb> 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-timescaledb> 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.88 seconds) vm-test-run-timescaledb> (finished: subtest: Verify init scripts and migrations ran, in 1.63 seconds) vm-test-run-timescaledb> subtest: Check upgrade path with postgresql 15 vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" vm-test-run-timescaledb> server # NOTICE: extension "timescaledb" does not exist, skipping vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" , in 0.58 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.9.1' CASCADE;" vm-test-run-timescaledb> server # WARNING: vm-test-run-timescaledb> server # WELCOME TO vm-test-run-timescaledb> server # _____ _ _ ____________ vm-test-run-timescaledb> server # |_ _(_) | | | _ \ ___ \ vm-test-run-timescaledb> server # | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ / vm-test-run-timescaledb> server # | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \ vm-test-run-timescaledb> server # | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ / vm-test-run-timescaledb> server # |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/ vm-test-run-timescaledb> server # Running version 2.9.1 vm-test-run-timescaledb> server # For more information on TimescaleDB, please visit the following links: vm-test-run-timescaledb> server # vm-test-run-timescaledb> server # 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started vm-test-run-timescaledb> server # 2. API reference documentation: https://docs.timescale.com/api/latest vm-test-run-timescaledb> server # 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts vm-test-run-timescaledb> server # vm-test-run-timescaledb> server # Note: Please enable telemetry to help us improve our product by running: ALTER DATABASE "postgres" SET timescaledb.telemetry_level = 'basic'; vm-test-run-timescaledb> server # vm-test-run-timescaledb> server # [ 179.011777] postgres[2093]: [local] 2026-10-08 15:41:44.605 UTC [2093] supabase_admin@postgres WARNING: vm-test-run-timescaledb> server # [ 179.022546] postgres[2093]: WELCOME TO vm-test-run-timescaledb> server # [ 179.025400] postgres[2093]: _____ _ _ ____________ vm-test-run-timescaledb> server # [ 179.027075] postgres[2093]: |_ _(_) | | | _ \ ___ \ vm-test-run-timescaledb> server # [ 179.037799] postgres[2093]: | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ / vm-test-run-timescaledb> server # [ 179.039393] postgres[2093]: | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \ vm-test-run-timescaledb> server # [ 179.045751] postgres[2093]: | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ / vm-test-run-timescaledb> server # [ 179.047671] postgres[2093]: |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/ vm-test-run-timescaledb> server # [ 179.050144] postgres[2093]: Running version 2.9.1 vm-test-run-timescaledb> server # [ 179.051278] postgres[2093]: For more information on TimescaleDB, please visit the following links: vm-test-run-timescaledb> server # [ 179.057468] postgres[2093]: vm-test-run-timescaledb> server # [ 179.059437] postgres[2093]: 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started vm-test-run-timescaledb> server # [ 179.061250] postgres[2093]: 2. API reference documentation: https://docs.timescale.com/api/latest vm-test-run-timescaledb> server # [ 179.062807] postgres[2093]: 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts vm-test-run-timescaledb> server # [ 179.063703] postgres[2093]: vm-test-run-timescaledb> server # [ 179.065876] postgres[2093]: Note: Please enable telemetry to help us improve our product by running: ALTER DATABASE "postgres" SET timescaledb.telemetry_level = 'basic'; vm-test-run-timescaledb> server # [ 179.068148] postgres[2093]: vm-test-run-timescaledb> server # [ 179.068534] postgres[2093]: [local] 2026-10-08 15:41:44.605 UTC [2093] supabase_admin@postgres CONTEXT: PL/pgSQL function inline_code_block line 16 at RAISE vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.9.1' CASCADE;" , in 6.32 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" vm-test-run-timescaledb> server # [ 179.517194] postgres[2139]: 2026-10-08 15:41:45.107 UTC [2139] LOG: job 2 threw an error vm-test-run-timescaledb> server # [ 179.528088] postgres[2139]: 2026-10-08 15:41:45.126 UTC [2139] ERROR: functionality not supported under the current "apache" license vm-test-run-timescaledb> server # [ 179.541282] postgres[2139]: 2026-10-08 15:41:45.126 UTC [2139] HINT: Upgrade your license to 'timescale' to use this free community feature. vm-test-run-timescaledb> server # [ 179.589399] postgres[1401]: 2026-10-08 15:41:45.176 UTC [1401] LOG: background worker "Error Log Retention Policy [2]" (PID 2139) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.81 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "ALTER EXTENSION timescaledb UPDATE TO '2.16.1';" vm-test-run-timescaledb> server # [ 181.063580] postgres[2135]: 2026-10-08 15:41:46.653 UTC [2135] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 181.104957] postgres[1401]: 2026-10-08 15:41:46.695 UTC [1401] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2135) exited with exit code 1 vm-test-run-timescaledb> server # [ 183.257229] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 vm-test-run-timescaledb> server # [ 187.899075] postgres[2165]: 2026-10-08 15:41:53.473 UTC [2165] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 187.927130] postgres[1401]: 2026-10-08 15:41:53.512 UTC [1401] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2165) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "ALTER EXTENSION timescaledb UPDATE TO '2.16.1';" , in 8.39 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" vm-test-run-timescaledb> server # [ 188.562705] postgres[2209]: 2026-10-08 15:41:54.144 UTC [2209] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 188.570485] postgres[2209]: 2026-10-08 15:41:54.154 UTC [2209] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 188.572166] postgres[2209]: 2026-10-08 15:41:54.154 UTC [2209] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 188.609255] postgres[1401]: 2026-10-08 15:41:54.207 UTC [1401] LOG: background worker "Job History Log Retention Policy [3]" (PID 2209) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.87 seconds) vm-test-run-timescaledb> (finished: subtest: Check upgrade path with postgresql 15, in 16.98 seconds) vm-test-run-timescaledb> subtest: Check the install of the last version of the extension vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" vm-test-run-timescaledb> server # [ 189.792071] postgres[2208]: 2026-10-08 15:41:55.386 UTC [2208] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 189.865048] postgres[1401]: 2026-10-08 15:41:55.457 UTC [1401] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2208) exited with exit code 1 vm-test-run-timescaledb> server # [ 190.603560] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-timescaledb> server # [ 190.837595] systemd[1]: Starting Virtual Console Setup... vm-test-run-timescaledb> server # [ 191.080840] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 191.100614] systemd[1]: Stopped Virtual Console Setup. vm-test-run-timescaledb> server # [ 191.132274] systemd[1]: Starting Virtual Console Setup... vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" , in 1.99 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" vm-test-run-timescaledb> server # [ 196.487981] systemd[1]: Finished Virtual Console Setup. vm-test-run-timescaledb> server # [ 197.186402] systemd-logind[653]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" , in 6.60 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" vm-test-run-timescaledb> server # [ 197.967438] postgres[2280]: 2026-10-08 15:42:03.557 UTC [2280] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 197.977721] postgres[2280]: 2026-10-08 15:42:03.562 UTC [2280] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 197.978820] postgres[2280]: 2026-10-08 15:42:03.562 UTC [2280] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 197.987496] postgres[1401]: 2026-10-08 15:42:03.586 UTC [1401] LOG: background worker "Job History Log Retention Policy [3]" (PID 2280) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.30 seconds) vm-test-run-timescaledb> (finished: subtest: Check the install of the last version of the extension, in 8.89 seconds) vm-test-run-timescaledb> (finished: run the VM test script, in 199.15 seconds) vm-test-run-timescaledb> test script finished in 199.35s vm-test-run-timescaledb> cleanup vm-test-run-timescaledb> kill machine (pid 9) vm-test-run-timescaledb> qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13) vm-test-run-timescaledb> vde_switch: EOF data port: Interrupted system call vm-test-run-timescaledb> kill vlan (pid 7) vm-test-run-timescaledb> (finished: cleanup, in 0.00 seconds) vm-test-run-timescaledb> vde_switch: Caught signal 15, cleaning up and exiting