these 2 derivations will be built: /nix/store/yg5zd0sqkp7k43i01j997p657jxjb0c3-nixos-test-driver-timescaledb.drv /nix/store/add431jm976wkg99q2306jn79p4drnxg-vm-test-run-timescaledb.drv building '/nix/store/yg5zd0sqkp7k43i01j997p657jxjb0c3-nixos-test-driver-timescaledb.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/add431jm976wkg99q2306jn79p4drnxg-vm-test-run-timescaledb.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/add431jm976wkg99q2306jn79p4drnxg-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.aWjOOTNtv0', 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: 9b2fe437-dcf5-4130-93d3-cf4dd0d1b229 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/28zxnlhnmf0az0j1p73f6y41srrawafj-nixos-system-server-test/init regInfo=/nix/store/mwli842c2z7srsnj5aikb6rj1rndswdj-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-timescaledb> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/mwli842c2z7srsnj5aikb6rj1rndswdj-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.000040] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-timescaledb> server # [ 0.004084] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-timescaledb> server # [ 0.014607] Console: colour dummy device 80x25 vm-test-run-timescaledb> server # [ 0.016025] printk: legacy console [tty0] enabled vm-test-run-timescaledb> server # [ 0.022176] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-timescaledb> server # [ 0.022582] pid_max: default: 32768 minimum: 301 vm-test-run-timescaledb> server # [ 0.024704] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-timescaledb> server # [ 0.026553] landlock: Up and running. vm-test-run-timescaledb> server # [ 0.026609] Yama: becoming mindful. vm-test-run-timescaledb> server # [ 0.030027] LSM support for eBPF active vm-test-run-timescaledb> server # [ 0.033615] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.033742] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.064455] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-timescaledb> server # [ 0.076954] rcu: Hierarchical SRCU implementation. vm-test-run-timescaledb> server # [ 0.077061] rcu: Max phase no-delay instances is 1000. vm-test-run-timescaledb> server # [ 0.078639] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-timescaledb> server # [ 0.086528] fsl-mc MSI: its@8080000 domain created vm-test-run-timescaledb> server # [ 0.088528] EFI services will not be available. vm-test-run-timescaledb> server # [ 0.091289] smp: Bringing up secondary CPUs ... vm-test-run-timescaledb> server # [ 0.096248] Detected PIPT I-cache on CPU1 vm-test-run-timescaledb> server # [ 0.097613] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-timescaledb> server # [ 0.098350] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000 vm-test-run-timescaledb> server # [ 0.100025] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-timescaledb> server # [ 0.104055] smp: Brought up 1 node, 2 CPUs vm-test-run-timescaledb> server # [ 0.104348] SMP: Total of 2 processors activated. vm-test-run-timescaledb> server # [ 0.104396] CPU: All CPU(s) started at EL1 vm-test-run-timescaledb> server # [ 0.104572] CPU features: detected: Branch Target Identification vm-test-run-timescaledb> server # [ 0.104631] CPU features: detected: 32-bit EL0 Support vm-test-run-timescaledb> server # [ 0.104662] CPU features: detected: 32-bit EL1 Support vm-test-run-timescaledb> server # [ 0.104689] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-timescaledb> server # [ 0.104726] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-timescaledb> server # [ 0.104769] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-timescaledb> server # [ 0.104836] CPU features: detected: Common not Private translations vm-test-run-timescaledb> server # [ 0.104863] CPU features: detected: CRC32 instructions vm-test-run-timescaledb> server # [ 0.104888] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-timescaledb> server # [ 0.104918] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-timescaledb> server # [ 0.104945] CPU features: detected: Data independent timing control (DIT) vm-test-run-timescaledb> server # [ 0.104972] CPU features: detected: E0PD vm-test-run-timescaledb> server # [ 0.104991] CPU features: detected: Enhanced Counter Virtualization vm-test-run-timescaledb> server # [ 0.105012] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-timescaledb> server # [ 0.105036] CPU features: detected: Enhanced Privileged Access Never vm-test-run-timescaledb> server # [ 0.105057] CPU features: detected: Enhanced Virtualization Traps vm-test-run-timescaledb> server # [ 0.105079] CPU features: detected: Fine Grained Traps vm-test-run-timescaledb> server # [ 0.105135] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.105223] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-timescaledb> server # [ 0.105274] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-timescaledb> server # [ 0.105303] CPU features: detected: LSE atomic instructions vm-test-run-timescaledb> server # [ 0.105326] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-timescaledb> server # [ 0.105354] CPU features: detected: Privileged Access Never vm-test-run-timescaledb> server # [ 0.105420] CPU features: detected: RAS Extension Support vm-test-run-timescaledb> server # [ 0.105457] CPU features: detected: Random Number Generator vm-test-run-timescaledb> server # [ 0.105485] CPU features: detected: Speculation barrier (SB) vm-test-run-timescaledb> server # [ 0.105511] CPU features: detected: Stage-2 Force Write-Back vm-test-run-timescaledb> server # [ 0.105533] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-timescaledb> server # [ 0.105559] CPU features: detected: TLB range maintenance instructions vm-test-run-timescaledb> server # [ 0.105582] CPU features: detected: WFx with timeout vm-test-run-timescaledb> server # [ 0.105635] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-timescaledb> server # [ 0.105665] CPU features: detected: Scalable Vector Extension vm-test-run-timescaledb> server # [ 0.112173] alternatives: applying system-wide alternatives vm-test-run-timescaledb> server # [ 0.128899] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-timescaledb> server # [ 0.129922] SVE: maximum available vector length 256 bytes per vector vm-test-run-timescaledb> server # [ 0.130022] SVE: default vector length 64 bytes per vector vm-test-run-timescaledb> server # [ 0.143005] Memory: 3922844K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-timescaledb> server # [ 0.164868] devtmpfs: initialized vm-test-run-timescaledb> server # [ 0.193394] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-timescaledb> server # [ 0.193927] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.196783] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-timescaledb> server # [ 0.196868] 0 pages in range for non-PLT usage vm-test-run-timescaledb> server # [ 0.196908] 509248 pages in range for PLT usage vm-test-run-timescaledb> server # [ 0.199315] pinctrl core: initialized pinctrl subsystem vm-test-run-timescaledb> server # [ 0.211140] DMI not present or invalid. vm-test-run-timescaledb> server # [ 0.230468] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-timescaledb> server # [ 0.243404] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-timescaledb> server # [ 0.244609] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-timescaledb> server # [ 0.246144] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-timescaledb> server # [ 0.246438] audit: initializing netlink subsys (disabled) vm-test-run-timescaledb> server # [ 0.248933] audit: type=2000 audit(0.196:1): state=initialized audit_enabled=0 res=1 vm-test-run-timescaledb> server # [ 0.254608] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-timescaledb> server # [ 0.254668] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-timescaledb> server # [ 0.254729] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-timescaledb> server # [ 0.254760] thermal_sys: Registered thermal governor 'user_space' vm-test-run-timescaledb> server # [ 0.254789] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-timescaledb> server # [ 0.255675] cpuidle: using governor ladder vm-test-run-timescaledb> server # [ 0.256200] cpuidle: using governor menu vm-test-run-timescaledb> server # [ 0.258648] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-timescaledb> server # [ 0.259514] ASID allocator initialised with 65536 entries vm-test-run-timescaledb> server # [ 0.266724] Serial: AMBA PL011 UART driver vm-test-run-timescaledb> server # [ 0.314728] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-timescaledb> server # [ 0.316432] printk: legacy console [ttyAMA0] enabled vm-test-run-timescaledb> server # [ 0.356367] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.356582] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-timescaledb> server # [ 0.356727] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.356861] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-timescaledb> server # [ 0.356967] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.357111] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-timescaledb> server # [ 0.357296] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.357523] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-timescaledb> server # [ 0.370676] fbcon: Taking over console vm-test-run-timescaledb> server # [ 0.371855] ACPI: Interpreter disabled. vm-test-run-timescaledb> server # [ 0.379479] iommu: Default domain type: Translated vm-test-run-timescaledb> server # [ 0.379651] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-timescaledb> server # [ 0.385984] SCSI subsystem initialized vm-test-run-timescaledb> server # [ 0.388999] usbcore: registered new interface driver usbfs vm-test-run-timescaledb> server # [ 0.389460] usbcore: registered new interface driver hub vm-test-run-timescaledb> server # [ 0.389697] usbcore: registered new device driver usb vm-test-run-timescaledb> server # [ 0.391945] pps_core: LinuxPPS API ver. 1 registered vm-test-run-timescaledb> server # [ 0.392063] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-timescaledb> server # [ 0.393759] PTP clock support registered vm-test-run-timescaledb> server # [ 0.394878] EDAC MC: Ver: 3.0.0 vm-test-run-timescaledb> server # [ 0.396774] scmi_core: SCMI protocol bus registered vm-test-run-timescaledb> server # [ 0.399998] FPGA manager framework vm-test-run-timescaledb> server # [ 0.401198] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-timescaledb> server # [ 0.410854] vgaarb: loaded vm-test-run-timescaledb> server # [ 0.416906] clocksource: Switched to clocksource arch_sys_counter vm-test-run-timescaledb> server # [ 0.420065] VFS: Disk quotas dquot_6.6.0 vm-test-run-timescaledb> server # [ 0.420379] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-timescaledb> server # [ 0.423056] netfs: FS-Cache loaded vm-test-run-timescaledb> server # [ 0.424465] pnp: PnP ACPI: disabled vm-test-run-timescaledb> server # [ 0.451208] NET: Registered PF_INET protocol family vm-test-run-timescaledb> server # [ 0.452427] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-timescaledb> server # [ 0.565522] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.566237] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.566574] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.567618] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-timescaledb> server # [ 0.568349] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-timescaledb> server # [ 0.570869] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-timescaledb> server # [ 0.571505] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.571865] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.573335] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-timescaledb> server # [ 0.573921] NET: Registered PF_XDP protocol family vm-test-run-timescaledb> server # [ 0.574162] PCI: CLS 0 bytes, default 64 vm-test-run-timescaledb> server # [ 0.575978] kvm [1]: HYP mode not available vm-test-run-timescaledb> server # [ 0.578732] Trying to unpack rootfs image as initramfs... vm-test-run-timescaledb> server # [ 0.681279] Initialise system trusted keyrings vm-test-run-timescaledb> server # [ 0.683585] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-timescaledb> server # [ 0.687520] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-timescaledb> server # [ 0.688167] 9p: Installing v9fs 9p2000 file system support vm-test-run-timescaledb> server # [ 0.749503] Key type asymmetric registered vm-test-run-timescaledb> server # [ 0.749748] Asymmetric key parser 'x509' registered vm-test-run-timescaledb> server # [ 0.750200] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-timescaledb> server # [ 0.751714] io scheduler mq-deadline registered vm-test-run-timescaledb> server # [ 0.751869] io scheduler kyber registered vm-test-run-timescaledb> server # [ 0.778117] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-timescaledb> server # [ 0.782002] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-timescaledb> server # [ 0.785677] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-timescaledb> server # [ 0.786505] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-timescaledb> server # [ 0.787043] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-timescaledb> server # [ 0.787228] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-timescaledb> server # [ 0.787947] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-timescaledb> server # [ 0.788654] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-timescaledb> server # [ 0.791070] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-timescaledb> server # [ 0.791436] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-timescaledb> server # [ 0.791893] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.792128] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.792245] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.793945] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.796787] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.797566] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.797998] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.798323] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.798706] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.799481] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.799896] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.800145] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.800291] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.800817] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.801559] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.802074] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.802290] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.802905] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.803210] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.803308] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.803420] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.803877] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.804155] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.804259] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.804377] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.804888] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.805745] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-timescaledb> server # [ 0.805941] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.806064] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.806603] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.806764] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.806860] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.806968] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.807081] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.807559] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.807882] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.808018] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.808499] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.809059] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.809180] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.810513] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.810699] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.811182] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.811906] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.812019] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.812125] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.812592] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.813423] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.813545] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.813667] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.815598] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.816095] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.816476] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.817986] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.818605] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.818820] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.818974] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.819112] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.819249] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.819382] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.819517] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.819651] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.819799] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.819928] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-timescaledb> server # [ 0.820302] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-timescaledb> server # [ 0.820610] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-timescaledb> server # [ 0.821286] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-timescaledb> server # [ 0.821979] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-timescaledb> server # [ 0.822233] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-timescaledb> server # [ 0.822409] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-timescaledb> server # [ 0.822514] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-timescaledb> server # [ 0.823122] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-timescaledb> server # [ 0.823281] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-timescaledb> server # [ 0.823388] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-timescaledb> server # [ 0.823496] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-timescaledb> server # [ 0.823616] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-timescaledb> server # [ 0.823745] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-timescaledb> server # [ 0.823847] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-timescaledb> server # [ 0.824269] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-timescaledb> server # [ 0.824434] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-timescaledb> server # [ 0.824802] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-timescaledb> server # [ 0.825138] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-timescaledb> server # [ 0.826478] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-timescaledb> server # [ 0.826651] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-timescaledb> server # [ 0.827082] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.827207] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.827309] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.828192] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.884098] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.888184] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.890724] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.892763] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.895507] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.897966] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.899847] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.902490] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.904577] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.907480] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.910362] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.930225] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-timescaledb> server # [ 0.939077] msm_serial: driver initialized vm-test-run-timescaledb> server # [ 0.940113] SuperH (H)SCI(F) driver initialized vm-test-run-timescaledb> server # [ 0.940671] STM32 USART driver initialized vm-test-run-timescaledb> server # [ 0.986405] loop: module loaded vm-test-run-timescaledb> server # [ 0.987065] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-timescaledb> server # [ 0.991849] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-timescaledb> server # [ 1.005908] megasas: 07.727.03.00-rc1 vm-test-run-timescaledb> server # [ 1.008663] Freeing initrd memory: 10684K vm-test-run-timescaledb> server # [ 1.011510] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-timescaledb> server # [ 1.014568] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 1.015427] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 1.017082] Using buffer write method vm-test-run-timescaledb> server # [ 1.018686] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-timescaledb> server # [ 1.020548] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 1.020877] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 1.022261] Using buffer write method vm-test-run-timescaledb> server # [ 1.023583] Concatenating MTD devices: vm-test-run-timescaledb> server # [ 1.023884] (0): "0.flash" vm-test-run-timescaledb> server # [ 1.023946] (1): "0.flash" vm-test-run-timescaledb> server # [ 1.024001] into device "0.flash" vm-test-run-timescaledb> server # [ 1.050785] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-timescaledb> server # [ 1.063457] thunder_xcv, ver 1.0 vm-test-run-timescaledb> server # [ 1.063713] thunder_bgx, ver 1.0 vm-test-run-timescaledb> server # [ 1.063921] nicpf, ver 1.0 vm-test-run-timescaledb> server # [ 1.067140] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-timescaledb> server # [ 1.067303] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-timescaledb> server # [ 1.067700] hclge is initializing vm-test-run-timescaledb> server # [ 1.068193] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.068604] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-timescaledb> server # [ 1.069269] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.069537] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-timescaledb> server # [ 1.070129] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-timescaledb> server # [ 1.070331] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-timescaledb> server # [ 1.070587] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-timescaledb> server # [ 1.070702] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-timescaledb> server # [ 1.071454] sky2: driver version 1.30 vm-test-run-timescaledb> server # [ 1.079940] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-timescaledb> server # [ 1.080626] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-timescaledb> server # [ 1.082399] usbcore: registered new interface driver usb-storage vm-test-run-timescaledb> server # [ 1.083404] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-timescaledb> server # [ 1.083924] usbcore: registered new interface driver usbserial_generic vm-test-run-timescaledb> server # [ 1.084293] usbserial: USB Serial support registered for generic vm-test-run-timescaledb> server # [ 1.093942] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-timescaledb> server # [ 1.095694] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-timescaledb> server # [ 1.096503] rtc-pl031 9010000.pl031: setting system clock to 2026-10-26T08:16:20 UTC (1793002580) vm-test-run-timescaledb> server # [ 1.098901] i2c_dev: i2c /dev entries driver vm-test-run-timescaledb> server # [ 1.104082] hub 1-0:1.0: USB hub found vm-test-run-timescaledb> server # [ 1.105672] hub 1-0:1.0: 6 ports detected vm-test-run-timescaledb> server # [ 1.114568] sdhci: Secure Digital Host Controller Interface driver vm-test-run-timescaledb> server # [ 1.114778] sdhci: Copyright(c) Pierre Ossman vm-test-run-timescaledb> server # [ 1.116540] Synopsys Designware Multimedia Card Interface Driver vm-test-run-timescaledb> server # [ 1.119354] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-timescaledb> server # [ 1.126221] hid: raw HID events driver (C) Jiri Kosina vm-test-run-timescaledb> server # [ 1.128544] usbcore: registered new interface driver usbhid vm-test-run-timescaledb> server # [ 1.128673] usbhid: USB HID core driver vm-test-run-timescaledb> server # [ 1.137914] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-timescaledb> server # [ 1.151278] drop_monitor: Initializing network drop monitor service vm-test-run-timescaledb> server # [ 1.153853] NET: Registered PF_INET6 protocol family vm-test-run-timescaledb> server # [ 1.169795] Segment Routing with IPv6 vm-test-run-timescaledb> server # [ 1.170153] In-situ OAM (IOAM) with IPv6 vm-test-run-timescaledb> server # [ 1.170766] NET: Registered PF_PACKET protocol family vm-test-run-timescaledb> server # [ 1.172566] 9pnet: Installing 9P2000 support vm-test-run-timescaledb> server # [ 1.177209] Key type dns_resolver registered vm-test-run-timescaledb> server # [ 1.213285] registered taskstats version 1 vm-test-run-timescaledb> server # [ 1.216342] Loading compiled-in X.509 certificates vm-test-run-timescaledb> server # [ 1.274904] Demotion targets for Node 0: null vm-test-run-timescaledb> server # [ 1.277860] Key type .fscrypt registered vm-test-run-timescaledb> server # [ 1.278046] Key type fscrypt-provisioning registered vm-test-run-timescaledb> server # [ 1.288045] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-timescaledb> server # [ 1.332429] clk: Disabling unused clocks vm-test-run-timescaledb> server # [ 1.333713] PM: genpd: Disabling unused power domains vm-test-run-timescaledb> server # [ 1.334084] ALSA device list: vm-test-run-timescaledb> server # [ 1.334220] No soundcards found. vm-test-run-timescaledb> server # [ 1.416695] Freeing unused kernel memory: 4416K vm-test-run-timescaledb> server # [ 1.419016] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-timescaledb> server # [ 1.419199] Run /init as init process vm-test-run-timescaledb> server # [ 1.623426] 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.753280] 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.878529] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-timescaledb> server # [ 2.066368] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-timescaledb> server # [ 2.070468] 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.072764] 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 # [ 2.213370] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-timescaledb> server # [ 2.214485] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-timescaledb> server # [ 2.214514] [drm] features: -context_init vm-test-run-timescaledb> server # [ 2.216653] [drm] number of scanouts: 1 vm-test-run-timescaledb> server # [ 2.216771] [drm] number of cap sets: 0 vm-test-run-timescaledb> server # [ 2.230059] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-timescaledb> server # [ 2.264428] Console: switching to colour frame buffer device 160x50 vm-test-run-timescaledb> server # [ 2.276719] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-timescaledb> server # [ 5.161779] EXT4-fs (vda): mounted filesystem 9b2fe437-dcf5-4130-93d3-cf4dd0d1b229 r/w with ordered data mode. Quota mode: none. vm-test-run-timescaledb> server # [ 7.651310] EXT4-fs (vda): re-mounted 9b2fe437-dcf5-4130-93d3-cf4dd0d1b229. vm-test-run-timescaledb> server # [ 7.673973] booting system configuration /nix/store/28zxnlhnmf0az0j1p73f6y41srrawafj-nixos-system-server-test vm-test-run-timescaledb> server # [ 20.399383] 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 # [ 20.410109] systemd[1]: Detected virtualization qemu. vm-test-run-timescaledb> server # [ 20.413750] systemd[1]: Detected architecture arm64. vm-test-run-timescaledb> server # [ 20.419812] systemd[1]: Detected first boot. vm-test-run-timescaledb> server # [ 20.446967] systemd[1]: Initializing machine ID from random generator. vm-test-run-timescaledb> server # [ 20.478992] systemd[1]: Hostname set to . vm-test-run-timescaledb> server # [ 21.729981] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-timescaledb> server # [ 23.150241] systemd[1]: Applying preset policy. vm-test-run-timescaledb> server # [ 26.941978] systemd[1]: Populated /etc with preset unit settings. 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 # [ 30.531592] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-timescaledb> server # [ 30.757831] systemd[1]: Created slice Slice /system/getty. vm-test-run-timescaledb> server # [ 30.773643] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-timescaledb> server # [ 30.787596] systemd[1]: Created slice User and Session Slice. vm-test-run-timescaledb> server # [ 30.796645] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-timescaledb> server # [ 30.803383] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-timescaledb> server # [ 30.809697] systemd[1]: Expecting device /dev/hvc0... vm-test-run-timescaledb> server # [ 30.814610] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-timescaledb> server # [ 30.819243] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-timescaledb> server # [ 30.823765] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-timescaledb> server # [ 30.828773] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-timescaledb> server # [ 30.833669] systemd[1]: Reached target Path Units. vm-test-run-timescaledb> server # [ 30.837906] systemd[1]: Reached target Remote File Systems. vm-test-run-timescaledb> server # [ 30.842832] systemd[1]: Reached target Slice Units. vm-test-run-timescaledb> server # [ 30.847106] systemd[1]: Reached target Swaps. vm-test-run-timescaledb> server # [ 30.882312] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-timescaledb> server # [ 30.903763] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-timescaledb> server # [ 30.914443] systemd[1]: Listening on Journal Audit Socket. vm-test-run-timescaledb> server # [ 30.921506] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-timescaledb> server # [ 30.927339] systemd[1]: Listening on Journal Sockets. vm-test-run-timescaledb> server # [ 30.935387] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-timescaledb> server # [ 30.940045] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 30.947046] systemd[1]: Listening on udev Control Socket. vm-test-run-timescaledb> server # [ 30.952535] systemd[1]: Listening on udev Kernel Socket. vm-test-run-timescaledb> server # [ 31.001518] systemd[1]: Mounting Huge Pages File System... vm-test-run-timescaledb> server # [ 31.028220] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-timescaledb> server # [ 31.068679] systemd[1]: Mounting Kernel Debug File System... vm-test-run-timescaledb> server # [ 31.167733] systemd[1]: Mounting Kernel Trace File System... vm-test-run-timescaledb> server # [ 31.272079] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-timescaledb> server # [ 31.381201] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-timescaledb> server # [ 31.411251] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-timescaledb> server # [ 31.551059] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-timescaledb> server # [ 31.574710] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-timescaledb> server # [ 31.607366] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-timescaledb> server # [ 31.702288] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-timescaledb> server # [ 31.714567] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-timescaledb> server # [ 31.729879] 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 # [ 31.831844] systemd[1]: Starting Journal Service... vm-test-run-timescaledb> server # [ 31.918155] systemd[1]: Starting Load Kernel Modules... vm-test-run-timescaledb> server # [ 32.020209] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-timescaledb> server # [ 32.083437] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-timescaledb> server # [ 32.090514] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 32.160414] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-timescaledb> server # [ 32.233835] systemd[1]: Mounted Huge Pages File System. vm-test-run-timescaledb> server # [ 32.248959] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-timescaledb> server # [ 32.262785] systemd[1]: Mounted Kernel Debug File System. vm-test-run-timescaledb> server # [ 32.275651] systemd[1]: Mounted Kernel Trace File System. vm-test-run-timescaledb> server # [ 32.303219] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-timescaledb> server # [ 32.325952] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-timescaledb> server # [ 32.391921] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-timescaledb> server # [ 32.519085] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 32.533332] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-timescaledb> server # [ 33.064959] fuse: init (API version 7.41) vm-test-run-timescaledb> server # [ 33.098384] systemd[1]: Finished Load Kernel Modules. vm-test-run-timescaledb> server # [ 33.172409] systemd[1]: Starting Firewall... vm-test-run-timescaledb> server # [ 33.236205] systemd[1]: Starting Apply Kernel Variables... vm-test-run-timescaledb> server # [ 33.250920] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 33.276512] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-timescaledb> server # [ 33.334802] systemd[1]: Mounting FUSE Control File System... vm-test-run-timescaledb> server # [ 33.461943] EXT4-fs (vda): re-mounted 9b2fe437-dcf5-4130-93d3-cf4dd0d1b229. vm-test-run-timescaledb> server # [ 33.648317] systemd[1]: Mounted FUSE Control File System. vm-test-run-timescaledb> server # [ 33.686685] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-timescaledb> server # [ 33.700483] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-timescaledb> server # [ 33.767228] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-timescaledb> server # [ 33.774575] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 33.883621] systemd-journald[399]: Collecting audit messages is enabled. vm-test-run-timescaledb> server # [ 34.830871] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-timescaledb> server # [ 34.839267] systemd[1]: Reached target First Boot Complete. vm-test-run-timescaledb> server # [ 34.893271] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-timescaledb> server # [ 34.932931] systemd[1]: Finished Apply Kernel Variables. vm-test-run-timescaledb> server # [ 34.979675] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-timescaledb> server # [ 35.159396] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-timescaledb> server # [ 35.981138] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-timescaledb> server # [ 36.008778] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-timescaledb> server # [ 36.060585] systemd[1]: Mounting /run/wrappers... vm-test-run-timescaledb> server # [ 36.095872] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-timescaledb> server # [ 36.609959] systemd[1]: Mounted /run/wrappers. vm-test-run-timescaledb> server # [ 36.618984] systemd[1]: Reached target Local File Systems. vm-test-run-timescaledb> server # [ 36.649278] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-timescaledb> server # [ 36.693991] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-timescaledb> server # [ 36.699474] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-timescaledb> server # [ 36.751929] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-timescaledb> server # [ 36.992078] systemd[1]: Started Journal Service. vm-test-run-timescaledb> server # [ 36.946898] systemd-modules-load[400]: Module 'atkbd' is built in vm-test-run-timescaledb> server # [ 36.979569] systemd-modules-load[400]: Module 'loop' is built in vm-test-run-timescaledb> server # [ 37.039360] systemd-oomd[401]: No swap; memory pressure usage will be degraded vm-test-run-timescaledb> server # [ 37.079052] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-timescaledb> server # [ 37.634834] systemd-udevd[428]: Using default interface naming scheme 'v258'. vm-test-run-timescaledb> server # [ 37.831630] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-timescaledb> server # [ 37.912235] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-timescaledb> server # [ 38.067391] systemd-journald[399]: Received client request to flush runtime journal. vm-test-run-timescaledb> server # [ 38.715279] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-timescaledb> server # [ 38.767031] systemd[1]: Starting Create System Files and Directories... vm-test-run-timescaledb> server # [ 39.947701] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-timescaledb> server # [ 41.028976] systemd[1]: Finished Create System Files and Directories. vm-test-run-timescaledb> server # [ 41.109259] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-timescaledb> server # [ 41.157747] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-timescaledb> server # [ 42.103468] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-timescaledb> server # [ 43.057507] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-timescaledb> server # [ 43.125602] systemd[1]: Starting Update is Completed... vm-test-run-timescaledb> server # [ 43.741453] systemd[1]: Finished Update is Completed. vm-test-run-timescaledb> server # [ 47.038343] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 47.049950] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-timescaledb> server # [ 47.052093] systemd[1]: suid-sgid-wrappers.service: Consumed 2.854s CPU time, 5.6M memory peak. vm-test-run-timescaledb> server # [ 49.307108] systemd[1]: Finished Firewall. vm-test-run-timescaledb> server # [ 50.847904] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-timescaledb> server # [ 50.862728] systemd[1]: Reached target System Initialization. vm-test-run-timescaledb> server # [ 50.871417] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-timescaledb> server # [ 50.881970] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-timescaledb> server # [ 50.885760] systemd[1]: Reached target Timer Units. vm-test-run-timescaledb> server # [ 50.889692] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-timescaledb> server # [ 50.895206] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-timescaledb> server # [ 50.906852] systemd[1]: Listening on Hostname Service Socket. vm-test-run-timescaledb> server # [ 50.913695] systemd[1]: Reached target Socket Units. vm-test-run-timescaledb> server # [ 50.918119] systemd[1]: Reached target Basic System. vm-test-run-timescaledb> server # [ 50.945974] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-timescaledb> server # [ 50.987579] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 51.050628] systemd[1]: Started Reset console on configuration changes. vm-test-run-timescaledb> server # [ 51.128965] systemd[1]: Starting resolvconf update... vm-test-run-timescaledb> server # [ 51.181823] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-timescaledb> server # [ 52.255513] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-timescaledb> server # [ 52.380212] nsncd[632]: Oct 26 08:17:11.797 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 52.390482] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 52.400088] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 52.408106] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 52.485571] systemd[1]: Starting User Login Management... vm-test-run-timescaledb> server # [ 52.762418] dbus-daemon[635]: dbus[635]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-timescaledb> server # [ 53.167742] systemd[1]: Started D-Bus System Message Bus. vm-test-run-timescaledb> server # [ 53.984321] systemd-logind[653]: New seat seat0. vm-test-run-timescaledb> server # [ 54.047114] systemd[1]: Started User Login Management. vm-test-run-timescaledb> server # [ 54.063217] systemd[1]: Starting linger-users.service... vm-test-run-timescaledb> server # [ 54.181573] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 54.197489] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-timescaledb> server # [ 54.207439] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 54.226436] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-timescaledb> server # [ 54.230884] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 54.311111] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 54.321477] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 54.465260] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 54.757409] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 54.767480] systemd[1]: Finished linger-users.service. vm-test-run-timescaledb> server # [ 55.251226] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 55.270969] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 55.283816] nsncd[694]: Oct 26 08:17:14.730 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 55.289585] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 55.633689] systemd[1]: Finished resolvconf update. vm-test-run-timescaledb> server # [ 55.658134] systemd[1]: Reached target Preparation for Network. vm-test-run-timescaledb> server # [ 55.710197] systemd[1]: Starting DHCP Client... vm-test-run-timescaledb> server # [ 57.022598] dhcpcd[743]: dhcpcd-10.2.4 starting vm-test-run-timescaledb> server # [ 57.219423] dhcpcd[748]: dev: loaded udev vm-test-run-timescaledb> server # [ 57.723584] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-timescaledb> server # [ 58.192884] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-timescaledb> server # [ 58.444450] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-timescaledb> server # [ 58.456410] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-timescaledb> server # [ 58.486751] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-timescaledb> server # [ 58.502488] cfg80211: failed to load regulatory.db vm-test-run-timescaledb> server # [ 58.951438] systemd[1]: Found device /dev/hvc0. 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 # [ 59.282765] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-timescaledb> server # [ 59.222865] dhcpcd[748]: eth0: waiting for carrier vm-test-run-timescaledb> server # [ 59.241558] dhcpcd[748]: libudev: received NULL device vm-test-run-timescaledb> server # [ 59.247179] dhcpcd[748]: libudev: received NULL device vm-test-run-timescaledb> server # [ 59.253323] dhcpcd[748]: eth0: carrier acquired vm-test-run-timescaledb> server # [ 59.335852] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-timescaledb> server # [ 59.399216] systemd[1]: Started backdoor.service. vm-test-run-timescaledb> server # [ 59.446101] dhcpcd[748]: DUID 00:01:00:01:32:71:c9:0e:52:54:00:12:34:56 vm-test-run-timescaledb> server # [ 59.459264] dhcpcd[748]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 59.472317] dhcpcd[748]: eth0: adding address fe80::5054:ff:fe12:3456 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 61.14 seconds) vm-test-run-timescaledb> server: (finished: waiting for the VM to finish booting, in 61.14 seconds) vm-test-run-timescaledb> server # [ 61.184556] dhcpcd[748]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 61.211416] dhcpcd[748]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 61.241255] dhcpcd[748]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 61.469706] dhcpcd[748]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 61.489475] dhcpcd[748]: eth0: Router Advertisement from fe80::2 vm-test-run-timescaledb> server # [ 61.491259] dhcpcd[748]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-timescaledb> server # [ 61.507865] dhcpcd[748]: eth0: adding route to fec0::/64 vm-test-run-timescaledb> server # [ 61.510017] dhcpcd[748]: eth0: adding default route via fe80::2 vm-test-run-timescaledb> server # [ 62.352106] (udev-worker)[810]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-timescaledb> server # [ 62.364410] (udev-worker)[810]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 62.371232] (udev-worker)[807]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 62.907295] systemd[1]: Found device Virtio network device. vm-test-run-timescaledb> server # [ 62.935203] dhcpcd[748]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 62.935934] dhcpcd[748]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 62.949679] dhcpcd[748]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 62.950628] dhcpcd[748]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 62.997228] systemd[1]: Starting Address configuration of eth1... vm-test-run-timescaledb> server # [ 64.135086] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-timescaledb> server # [ 64.384805] network-addresses-eth1-start[822]: adding address 192.168.1.1/24... done vm-test-run-timescaledb> server # [ 64.458123] dhcpcd[748]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 64.613741] network-addresses-eth1-start[822]: adding address 2001:db8:1::1/64... done vm-test-run-timescaledb> server # [ 64.923037] systemd[1]: Finished Address configuration of eth1. vm-test-run-timescaledb> server # [ 64.990723] systemd[1]: Starting Networking Setup... vm-test-run-timescaledb> server # [ 65.735505] systemd-logind[653]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-timescaledb> server # [ 67.198356] systemd[1]: Finished Networking Setup. vm-test-run-timescaledb> server # [ 67.218855] systemd[1]: Reached target Network. vm-test-run-timescaledb> server # [ 67.261964] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-timescaledb> server # [ 67.307183] systemd[1]: Starting Permit User Sessions... vm-test-run-timescaledb> server # [ 67.865478] systemd[1]: Finished Permit User Sessions. vm-test-run-timescaledb> server # [ 67.951142] systemd[1]: Started Getty on tty1. vm-test-run-timescaledb> server # [ 67.963013] systemd[1]: Reached target Login Prompts. vm-test-run-timescaledb> server # [ 68.599066] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[937]: Initializing database at /var/lib/postgresql/data vm-test-run-timescaledb> server # [ 68.863778] dhcpcd[748]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-timescaledb> server # [ 68.874194] dhcpcd[748]: eth0: adding route to 10.0.2.0/24 vm-test-run-timescaledb> server # [ 68.875495] dhcpcd[748]: eth0: adding default route via 10.0.2.2 vm-test-run-timescaledb> server # [ 70.847913] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: The files belonging to this database system will be owned by user "postgres". vm-test-run-timescaledb> server # [ 70.855077] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: This user must also own the server process. vm-test-run-timescaledb> server # [ 70.930431] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-timescaledb> server # [ 70.931870] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: The default database encoding has accordingly been set to "UTF8". vm-test-run-timescaledb> server # [ 70.938539] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: The default text search configuration will be set to "english". vm-test-run-timescaledb> server # [ 70.939737] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: Data page checksums are enabled. vm-test-run-timescaledb> server # [ 70.940126] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-timescaledb> server # [ 70.969186] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: creating subdirectories ... ok vm-test-run-timescaledb> server # [ 70.986959] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: selecting dynamic shared memory implementation ... posix vm-test-run-timescaledb> server # [ 72.398655] systemd[1]: Started DHCP Client. vm-test-run-timescaledb> server # [ 72.623435] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: selecting default max_connections ... 100 vm-test-run-timescaledb> server # [ 73.495851] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: selecting default shared_buffers ... 128MB vm-test-run-timescaledb> server # [ 79.246028] mousedev: PS/2 mouse device common for all mice vm-test-run-timescaledb> server # [ 83.551331] systemd-logind[653]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-timescaledb> server # [ 84.382221] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: selecting default time zone ... UTC vm-test-run-timescaledb> server # [ 84.423031] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: creating configuration files ... ok vm-test-run-timescaledb> server # [ 88.443161] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: running bootstrap script ... ok vm-test-run-timescaledb> server # [ 99.129384] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: performing post-bootstrap initialization ... ok vm-test-run-timescaledb> server # [ 101.650919] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: syncing data to disk ... ok vm-test-run-timescaledb> server # [ 101.654123] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-timescaledb> server # [ 101.661921] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: 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 # [ 101.663699] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: Success. You can now start the database server using: vm-test-run-timescaledb> server # [ 101.664250] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[949]: /nix/store/i45yhjwwac2d5ygyv0s5gbg2cgdjclf9-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-timescaledb> server # [ 103.183669] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[937]: Validating PostgreSQL configuration... vm-test-run-timescaledb> server # [ 103.715645] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[1344]: 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 # [ 104.637199] postgres[1360]: 2026-10-26 08:18:04.106 UTC [1360] LOG: pgaudit extension initialized vm-test-run-timescaledb> server # [ 105.308858] postgres[1360]: 2026-10-26 08:18:04.788 UTC [1360] LOG: pgsodium primary server secret key loaded vm-test-run-timescaledb> server # [ 105.699854] postgres[1360]: 2026-10-26 08:18:05.168 UTC [1360] LOG: vault primary server secret key loaded vm-test-run-timescaledb> server # [ 106.183959] postgres[1360]: 2026-10-26 08:18:05.664 UTC [1360] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-timescaledb> server # [ 106.229726] postgres[1360]: 2026-10-26 08:18:05.702 UTC [1360] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-timescaledb> server # [ 106.235439] postgres[1360]: 2026-10-26 08:18:05.706 UTC [1360] LOG: listening on IPv6 address "::", port 5432 vm-test-run-timescaledb> server # [ 106.255225] postgres[1360]: 2026-10-26 08:18:05.734 UTC [1360] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-timescaledb> server # [ 106.440008] postgres[1394]: 2026-10-26 08:18:05.902 UTC [1394] LOG: database system was shut down at 2026-10-26 08:17:58 UTC vm-test-run-timescaledb> server # [ 106.733351] postgres[1401]: 2026-10-26 08:18:06.201 UTC [1401] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 106.762875] postgres[1360]: 2026-10-26 08:18:06.202 UTC [1360] LOG: database system is ready to accept connections vm-test-run-timescaledb> server # [ 106.850479] postgres[1400]: 2026-10-26 08:18:06.290 UTC [1400] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-timescaledb> server # [ 106.859520] systemd[1]: Started PostgreSQL Database Server. vm-test-run-timescaledb> server # [ 106.916772] systemd[1]: Starting Supabase Database Initialization... vm-test-run-timescaledb> server # [ 106.959460] postgres[1360]: 2026-10-26 08:18:06.438 UTC [1360] LOG: background worker "pg_net 0.20.4 worker" (PID 1401) exited with exit code 1 vm-test-run-timescaledb> server # [ 107.255471] postgres[1403]: 2026-10-26 08:18:06.722 UTC [1403] LOG: pg_cron scheduler started vm-test-run-timescaledb> server # [ 107.338744] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Waiting for PostgreSQL to be ready... vm-test-run-timescaledb> server # [ 107.826644] postgres[1412]: ::1 2026-10-26 08:18:07.302 UTC [1412] root@root FATAL: role "root" does not exist vm-test-run-timescaledb> server # [ 107.867684] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: PostgreSQL is ready vm-test-run-timescaledb> server # [ 107.870845] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Creating postgres role... vm-test-run-timescaledb> server # [ 108.014106] postgres[1414]: 2026-10-26 08:18:07.476 UTC [1414] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 108.071127] postgres[1360]: 2026-10-26 08:18:07.539 UTC [1360] LOG: background worker "pg_net 0.20.4 worker" (PID 1414) exited with exit code 1 vm-test-run-timescaledb> server # [ 108.259534] postgres[1415]: ::1 2026-10-26 08:18:07.733 UTC [1415] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-timescaledb> server # [ 108.304385] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1413]: CREATE ROLE vm-test-run-timescaledb> server # [ 108.700678] postgres[1421]: ::1 2026-10-26 08:18:08.174 UTC [1421] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-timescaledb> server # [ 108.750524] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1420]: ALTER DATABASE vm-test-run-timescaledb> server # [ 108.784140] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running init-script: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-timescaledb> server # [ 109.109950] postgres[1423]: ::1 2026-10-26 08:18:08.575 UTC [1423] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-timescaledb> server # [ 109.145930] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: CREATE PUBLICATION vm-test-run-timescaledb> server # [ 109.147815] postgres[1423]: ::1 2026-10-26 08:18:08.618 UTC [1423] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-timescaledb> server # [ 109.158357] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: ALTER ROLE vm-test-run-timescaledb> server # [ 109.164789] postgres[1423]: ::1 2026-10-26 08:18:08.642 UTC [1423] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-timescaledb> server # [ 109.178877] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 109.179967] postgres[1423]: ::1 2026-10-26 08:18:08.660 UTC [1423] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-timescaledb> server # [ 109.194881] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 109.198097] postgres[1423]: ::1 2026-10-26 08:18:08.678 UTC [1423] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-timescaledb> server # [ 109.215351] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 109.221303] postgres[1423]: ::1 2026-10-26 08:18:08.697 UTC [1423] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-timescaledb> server # [ 109.225553] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: GRANT vm-test-run-timescaledb> server # [ 109.227916] postgres[1423]: ::1 2026-10-26 08:18:08.706 UTC [1423] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-timescaledb> server # [ 109.233248] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 109.233874] postgres[1423]: ::1 2026-10-26 08:18:08.714 UTC [1423] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-timescaledb> server # [ 109.244622] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 109.245799] postgres[1423]: ::1 2026-10-26 08:18:08.725 UTC [1423] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-timescaledb> server # [ 109.265097] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 109.266431] postgres[1423]: ::1 2026-10-26 08:18:08.745 UTC [1423] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-timescaledb> server # [ 111.247395] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 111.257055] postgres[1423]: ::1 2026-10-26 08:18:10.719 UTC [1423] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-timescaledb> server # [ 112.170864] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 112.179314] postgres[1423]: ::1 2026-10-26 08:18:11.659 UTC [1423] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-timescaledb> server # [ 112.189192] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 112.197000] postgres[1423]: ::1 2026-10-26 08:18:11.673 UTC [1423] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-timescaledb> server # [ 112.205697] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 112.207440] postgres[1423]: ::1 2026-10-26 08:18:11.686 UTC [1423] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-timescaledb> server # [ 112.222164] postgres[1423]: ::1 2026-10-26 08:18:11.694 UTC [1423] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-timescaledb> server # [ 112.224331] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 112.227034] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 112.240643] postgres[1423]: ::1 2026-10-26 08:18:11.707 UTC [1423] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-timescaledb> server # [ 112.242445] postgres[1423]: ::1 2026-10-26 08:18:11.722 UTC [1423] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-timescaledb> server # [ 112.254895] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 112.255737] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 112.279474] postgres[1423]: ::1 2026-10-26 08:18:11.735 UTC [1423] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-timescaledb> server # [ 112.298340] postgres[1423]: ::1 2026-10-26 08:18:11.745 UTC [1423] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-timescaledb> server # [ 112.317160] postgres[1423]: ::1 2026-10-26 08:18:11.755 UTC [1423] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.318632] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 112.327873] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 112.337382] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: GRANT vm-test-run-timescaledb> server # [ 112.340099] postgres[1423]: ::1 2026-10-26 08:18:11.810 UTC [1423] 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 # [ 112.385833] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 112.399556] postgres[1423]: ::1 2026-10-26 08:18:11.878 UTC [1423] 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 # [ 112.419637] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 112.425548] postgres[1423]: ::1 2026-10-26 08:18:11.902 UTC [1423] 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 # [ 112.441668] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 112.446157] postgres[1423]: ::1 2026-10-26 08:18:11.926 UTC [1423] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.462688] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: GRANT vm-test-run-timescaledb> server # [ 112.471317] postgres[1423]: ::1 2026-10-26 08:18:11.944 UTC [1423] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-timescaledb> server # [ 112.487369] postgres[1423]: ::1 2026-10-26 08:18:11.967 UTC [1423] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 112.497361] postgres[1423]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.502674] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: ALTER ROLE vm-test-run-timescaledb> server # [ 112.514733] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 112.521931] postgres[1423]: ::1 2026-10-26 08:18:11.986 UTC [1423] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 112.527095] postgres[1423]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.527710] postgres[1423]: ::1 2026-10-26 08:18:11.997 UTC [1423] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 112.533615] postgres[1423]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.535197] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 112.536100] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 112.561741] postgres[1423]: ::1 2026-10-26 08:18:12.007 UTC [1423] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-timescaledb> server # [ 112.573328] postgres[1423]: ::1 2026-10-26 08:18:12.018 UTC [1423] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 112.575132] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: ALTER ROLE vm-test-run-timescaledb> server # [ 112.575602] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1422]: ALTER ROLE vm-test-run-timescaledb> server # [ 112.629680] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running init-script: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-timescaledb> server # [ 112.917944] postgres[1464]: ::1 2026-10-26 08:18:12.390 UTC [1464] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 112.927449] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 112.933918] postgres[1464]: ::1 2026-10-26 08:18:12.406 UTC [1464] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-timescaledb> server # [ 112.934552] postgres[1464]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 112.935305] postgres[1464]: id uuid NOT NULL UNIQUE, vm-test-run-timescaledb> server # [ 112.941469] postgres[1464]: aud varchar(255) NULL, vm-test-run-timescaledb> server # [ 112.942111] postgres[1464]: "role" varchar(255) NULL, vm-test-run-timescaledb> server # [ 112.943487] postgres[1464]: email varchar(255) NULL UNIQUE, vm-test-run-timescaledb> server # [ 112.944124] postgres[1464]: encrypted_password varchar(255) NULL, vm-test-run-timescaledb> server # [ 112.949681] postgres[1464]: confirmed_at timestamptz NULL, vm-test-run-timescaledb> server # [ 112.950177] postgres[1464]: invited_at timestamptz NULL, vm-test-run-timescaledb> server # [ 112.951690] postgres[1464]: confirmation_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 112.954621] postgres[1464]: confirmation_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 112.955771] postgres[1464]: recovery_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 112.961059] postgres[1464]: recovery_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 112.961738] postgres[1464]: email_change_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 112.962448] postgres[1464]: email_change varchar(255) NULL, vm-test-run-timescaledb> server # [ 112.963325] postgres[1464]: email_change_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 112.964024] postgres[1464]: last_sign_in_at timestamptz NULL, vm-test-run-timescaledb> server # [ 112.968976] postgres[1464]: raw_app_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 112.970003] postgres[1464]: raw_user_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 112.970677] postgres[1464]: is_super_admin bool NULL, vm-test-run-timescaledb> server # [ 112.972019] postgres[1464]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 112.981890] postgres[1464]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 112.993740] postgres[1464]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 112.994816] postgres[1464]: ); vm-test-run-timescaledb> server # [ 113.076946] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE TABLE vm-test-run-timescaledb> server # [ 113.093020] postgres[1464]: ::1 2026-10-26 08:18:12.572 UTC [1464] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-timescaledb> server # [ 113.141691] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE INDEX vm-test-run-timescaledb> server # [ 113.153093] postgres[1464]: ::1 2026-10-26 08:18:12.625 UTC [1464] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-timescaledb> server # [ 113.191497] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE INDEX vm-test-run-timescaledb> server # [ 113.201587] postgres[1464]: ::1 2026-10-26 08:18:12.673 UTC [1464] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-timescaledb> server # [ 113.212927] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: COMMENT vm-test-run-timescaledb> server # [ 113.214597] postgres[1464]: ::1 2026-10-26 08:18:12.688 UTC [1464] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-timescaledb> server # [ 113.215394] postgres[1464]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 113.215835] postgres[1464]: id bigserial NOT NULL, vm-test-run-timescaledb> server # [ 113.216452] postgres[1464]: "token" varchar(255) NULL, vm-test-run-timescaledb> server # [ 113.221204] postgres[1464]: user_id varchar(255) NULL, vm-test-run-timescaledb> server # [ 113.222219] postgres[1464]: revoked bool NULL, vm-test-run-timescaledb> server # [ 113.222844] postgres[1464]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 113.223460] postgres[1464]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 113.223979] postgres[1464]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 113.233403] postgres[1464]: ); vm-test-run-timescaledb> server # [ 113.301845] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE TABLE vm-test-run-timescaledb> server # [ 113.305078] postgres[1464]: ::1 2026-10-26 08:18:12.784 UTC [1464] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-timescaledb> server # [ 113.336033] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE INDEX vm-test-run-timescaledb> server # [ 113.345150] postgres[1464]: ::1 2026-10-26 08:18:12.821 UTC [1464] 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 # [ 113.366193] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE INDEX vm-test-run-timescaledb> server # [ 113.368474] postgres[1464]: ::1 2026-10-26 08:18:12.848 UTC [1464] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-timescaledb> server # [ 113.397931] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE INDEX vm-test-run-timescaledb> server # [ 113.407814] postgres[1464]: ::1 2026-10-26 08:18:12.883 UTC [1464] 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 # [ 113.415420] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: COMMENT vm-test-run-timescaledb> server # [ 113.425172] postgres[1464]: ::1 2026-10-26 08:18:12.899 UTC [1464] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-timescaledb> server # [ 113.426475] postgres[1464]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 113.427687] postgres[1464]: uuid uuid NULL, vm-test-run-timescaledb> server # [ 113.434639] postgres[1464]: raw_base_config text NULL, vm-test-run-timescaledb> server # [ 113.435214] postgres[1464]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 113.435772] postgres[1464]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 113.436396] postgres[1464]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 113.441566] postgres[1464]: ); vm-test-run-timescaledb> server # [ 113.485610] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE TABLE vm-test-run-timescaledb> server # [ 113.490489] postgres[1464]: ::1 2026-10-26 08:18:12.968 UTC [1464] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-timescaledb> server # [ 113.495376] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: COMMENT vm-test-run-timescaledb> server # [ 113.501412] postgres[1464]: ::1 2026-10-26 08:18:12.978 UTC [1464] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-timescaledb> server # [ 113.502432] postgres[1464]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 113.502784] postgres[1464]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 113.503646] postgres[1464]: payload json NULL, vm-test-run-timescaledb> server # [ 113.507467] postgres[1464]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 113.508980] postgres[1464]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 113.509725] postgres[1464]: ); vm-test-run-timescaledb> server # [ 113.549531] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE TABLE vm-test-run-timescaledb> server # [ 113.553715] postgres[1464]: ::1 2026-10-26 08:18:13.030 UTC [1464] 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 # [ 113.570798] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE INDEX vm-test-run-timescaledb> server # [ 113.571669] postgres[1464]: ::1 2026-10-26 08:18:13.051 UTC [1464] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-timescaledb> server # [ 113.578545] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: COMMENT vm-test-run-timescaledb> server # [ 113.585235] postgres[1464]: ::1 2026-10-26 08:18:13.061 UTC [1464] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-timescaledb> server # [ 113.587187] postgres[1464]: "version" varchar(255) NOT NULL, vm-test-run-timescaledb> server # [ 113.587743] postgres[1464]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-timescaledb> server # [ 113.588099] postgres[1464]: ); vm-test-run-timescaledb> server # [ 113.618040] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE TABLE vm-test-run-timescaledb> server # [ 113.623450] postgres[1464]: ::1 2026-10-26 08:18:13.101 UTC [1464] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-timescaledb> server # [ 113.629873] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: COMMENT vm-test-run-timescaledb> server # [ 113.653155] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: INSERT 0 7 vm-test-run-timescaledb> server # [ 113.654373] postgres[1464]: ::1 2026-10-26 08:18:13.134 UTC [1464] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-timescaledb> server # [ 113.655456] postgres[1464]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-timescaledb> server # [ 113.655955] postgres[1464]: $$ language sql stable; vm-test-run-timescaledb> server # [ 113.668017] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 113.669973] postgres[1464]: ::1 2026-10-26 08:18:13.148 UTC [1464] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-timescaledb> server # [ 113.670699] postgres[1464]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-timescaledb> server # [ 113.671048] postgres[1464]: $$ language sql stable; vm-test-run-timescaledb> server # [ 113.679571] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 113.683951] postgres[1464]: ::1 2026-10-26 08:18:13.163 UTC [1464] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-timescaledb> server # [ 113.685726] postgres[1464]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-timescaledb> server # [ 113.687495] postgres[1464]: $$ language sql stable; vm-test-run-timescaledb> server # [ 113.694536] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 113.695827] postgres[1464]: ::1 2026-10-26 08:18:13.174 UTC [1464] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 113.703723] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: GRANT vm-test-run-timescaledb> server # [ 113.707681] postgres[1464]: ::1 2026-10-26 08:18:13.185 UTC [1464] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 113.713408] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: CREATE ROLE vm-test-run-timescaledb> server # [ 113.717772] postgres[1464]: ::1 2026-10-26 08:18:13.195 UTC [1464] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 113.722874] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: GRANT vm-test-run-timescaledb> server # [ 113.729001] postgres[1464]: ::1 2026-10-26 08:18:13.206 UTC [1464] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 113.737684] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: GRANT vm-test-run-timescaledb> server # [ 113.740261] postgres[1464]: ::1 2026-10-26 08:18:13.219 UTC [1464] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 113.748200] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: GRANT vm-test-run-timescaledb> server # [ 113.751074] postgres[1464]: ::1 2026-10-26 08:18:13.230 UTC [1464] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-timescaledb> server # [ 113.762256] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: ALTER ROLE vm-test-run-timescaledb> server # [ 113.763303] postgres[1464]: ::1 2026-10-26 08:18:13.240 UTC [1464] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 113.773904] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: ALTER TABLE vm-test-run-timescaledb> server # [ 113.775428] postgres[1464]: ::1 2026-10-26 08:18:13.254 UTC [1464] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 113.786659] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: ALTER TABLE vm-test-run-timescaledb> server # [ 113.789663] postgres[1464]: ::1 2026-10-26 08:18:13.269 UTC [1464] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 113.798651] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: ALTER TABLE vm-test-run-timescaledb> server # [ 113.803309] postgres[1464]: ::1 2026-10-26 08:18:13.281 UTC [1464] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 113.813030] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: ALTER TABLE vm-test-run-timescaledb> server # [ 113.813923] postgres[1464]: ::1 2026-10-26 08:18:13.294 UTC [1464] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 113.826026] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1461]: ALTER TABLE vm-test-run-timescaledb> server # [ 113.882573] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running init-script: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-timescaledb> server # [ 114.244057] postgres[1480]: ::1 2026-10-26 08:18:13.722 UTC [1480] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 114.285935] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1478]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 114.293859] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1478]: CREATE ROLE vm-test-run-timescaledb> server # [ 114.295057] postgres[1480]: ::1 2026-10-26 08:18:13.751 UTC [1480] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 114.306481] postgres[1480]: ::1 2026-10-26 08:18:13.764 UTC [1480] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-timescaledb> server # [ 114.308130] postgres[1480]: ::1 2026-10-26 08:18:13.779 UTC [1480] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-timescaledb> server # [ 114.318911] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1478]: ALTER ROLE vm-test-run-timescaledb> server # [ 114.333133] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1478]: GRANT vm-test-run-timescaledb> server # [ 114.371007] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1478]: DO vm-test-run-timescaledb> server # [ 114.419564] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running init-script: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-timescaledb> server # [ 114.684033] postgres[1482]: ::1 2026-10-26 08:18:14.155 UTC [1482] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-timescaledb> server # [ 114.703432] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: ALTER ROLE vm-test-run-timescaledb> server # [ 114.705333] postgres[1482]: ::1 2026-10-26 08:18:14.175 UTC [1482] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-timescaledb> server # [ 114.706513] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: ALTER ROLE vm-test-run-timescaledb> server # [ 114.713187] postgres[1482]: ::1 2026-10-26 08:18:14.188 UTC [1482] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-timescaledb> server # [ 114.714183] postgres[1482]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 114.715642] postgres[1482]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 114.719326] postgres[1482]: AS $$ vm-test-run-timescaledb> server # [ 114.719978] postgres[1482]: DECLARE vm-test-run-timescaledb> server # [ 114.722143] postgres[1482]: schema_is_cron bool; vm-test-run-timescaledb> server # [ 114.723162] postgres[1482]: BEGIN vm-test-run-timescaledb> server # [ 114.725101] postgres[1482]: schema_is_cron = ( vm-test-run-timescaledb> server # [ 114.725535] postgres[1482]: SELECT n.nspname = 'cron' vm-test-run-timescaledb> server # [ 114.727028] postgres[1482]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 114.729026] postgres[1482]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-timescaledb> server # [ 114.729923] postgres[1482]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 114.730335] postgres[1482]: ); vm-test-run-timescaledb> server # [ 114.730941] postgres[1482]: vm-test-run-timescaledb> server # [ 114.731382] postgres[1482]: IF schema_is_cron vm-test-run-timescaledb> server # [ 114.731963] postgres[1482]: THEN vm-test-run-timescaledb> server # [ 114.733311] postgres[1482]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 114.733856] postgres[1482]: vm-test-run-timescaledb> server # [ 114.734641] postgres[1482]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 114.735361] postgres[1482]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 114.736920] postgres[1482]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 114.737516] postgres[1482]: vm-test-run-timescaledb> server # [ 114.739208] postgres[1482]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 114.741671] postgres[1482]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 114.742717] postgres[1482]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 114.744074] postgres[1482]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 114.745350] postgres[1482]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 114.745865] postgres[1482]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 114.746630] postgres[1482]: vm-test-run-timescaledb> server # [ 114.747254] postgres[1482]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 114.749167] postgres[1482]: vm-test-run-timescaledb> server # [ 114.750495] postgres[1482]: END IF; vm-test-run-timescaledb> server # [ 114.751120] postgres[1482]: vm-test-run-timescaledb> server # [ 114.751928] postgres[1482]: END; vm-test-run-timescaledb> server # [ 114.753458] postgres[1482]: $$; vm-test-run-timescaledb> server # [ 114.765738] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 114.767163] postgres[1482]: ::1 2026-10-26 08:18:14.242 UTC [1482] 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 # [ 114.767950] postgres[1482]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 114.778214] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 114.785086] postgres[1482]: ::1 2026-10-26 08:18:14.263 UTC [1482] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-timescaledb> server # [ 114.793113] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: COMMENT vm-test-run-timescaledb> server # [ 114.797496] postgres[1482]: ::1 2026-10-26 08:18:14.275 UTC [1482] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-timescaledb> server # [ 114.802513] postgres[1482]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 114.804207] postgres[1482]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 114.805375] postgres[1482]: AS $$ vm-test-run-timescaledb> server # [ 114.805668] postgres[1482]: BEGIN vm-test-run-timescaledb> server # [ 114.806352] postgres[1482]: IF EXISTS ( vm-test-run-timescaledb> server # [ 114.806647] postgres[1482]: SELECT 1 vm-test-run-timescaledb> server # [ 114.807519] postgres[1482]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 114.808621] postgres[1482]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 114.809516] postgres[1482]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 114.809838] postgres[1482]: WHERE ext.extname = 'pg_net' vm-test-run-timescaledb> server # [ 114.810423] postgres[1482]: ) vm-test-run-timescaledb> server # [ 114.811440] postgres[1482]: THEN vm-test-run-timescaledb> server # [ 114.812972] postgres[1482]: IF NOT EXISTS ( vm-test-run-timescaledb> server # [ 114.813349] postgres[1482]: SELECT 1 vm-test-run-timescaledb> server # [ 114.813622] postgres[1482]: FROM pg_roles vm-test-run-timescaledb> server # [ 114.813994] postgres[1482]: WHERE rolname = 'supabase_functions_admin' vm-test-run-timescaledb> server # [ 114.814462] postgres[1482]: ) vm-test-run-timescaledb> server # [ 114.814767] postgres[1482]: THEN vm-test-run-timescaledb> server # [ 114.816587] postgres[1482]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 114.817357] postgres[1482]: END IF; vm-test-run-timescaledb> server # [ 114.819200] postgres[1482]: vm-test-run-timescaledb> server # [ 114.819697] postgres[1482]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 114.821693] postgres[1482]: vm-test-run-timescaledb> server # [ 114.822458] postgres[1482]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 114.823688] postgres[1482]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 114.825377] postgres[1482]: vm-test-run-timescaledb> server # [ 114.825971] postgres[1482]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-timescaledb> server # [ 114.827976] postgres[1482]: 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 # [ 114.835928] postgres[1482]: vm-test-run-timescaledb> server # [ 114.838778] postgres[1482]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-timescaledb> server # [ 114.845601] postgres[1482]: 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 # [ 114.847884] postgres[1482]: vm-test-run-timescaledb> server # [ 114.850648] postgres[1482]: 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 # [ 114.852178] postgres[1482]: 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 # [ 114.853780] postgres[1482]: END IF; vm-test-run-timescaledb> server # [ 114.854069] postgres[1482]: END; vm-test-run-timescaledb> server # [ 114.854306] postgres[1482]: $$; vm-test-run-timescaledb> server # [ 114.854717] postgres[1482]: ::1 2026-10-26 08:18:14.291 UTC [1482] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-timescaledb> server # [ 114.855451] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 114.855773] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: COMMENT vm-test-run-timescaledb> server # [ 114.856007] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: DO vm-test-run-timescaledb> server # [ 114.857089] postgres[1482]: ::1 2026-10-26 08:18:14.336 UTC [1482] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-timescaledb> server # [ 114.865579] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: CREATE ROLE vm-test-run-timescaledb> server # [ 114.866419] postgres[1482]: ::1 2026-10-26 08:18:14.346 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-timescaledb> server # [ 114.874406] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 114.875417] postgres[1482]: ::1 2026-10-26 08:18:14.355 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 114.886318] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 114.887348] postgres[1482]: ::1 2026-10-26 08:18:14.367 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 114.893829] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 114.897924] postgres[1482]: ::1 2026-10-26 08:18:14.376 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 114.907317] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 114.910297] postgres[1482]: ::1 2026-10-26 08:18:14.388 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 114.917051] postgres[1482]: ::1 2026-10-26 08:18:14.395 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 114.918452] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 114.925304] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 114.928827] postgres[1482]: ::1 2026-10-26 08:18:14.407 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 114.933316] postgres[1482]: ::1 2026-10-26 08:18:14.411 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 114.934645] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 114.960925] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 114.961902] postgres[1482]: ::1 2026-10-26 08:18:14.438 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 115.036318] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: GRANT vm-test-run-timescaledb> server # [ 115.056770] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1481]: DO vm-test-run-timescaledb> server # [ 115.095744] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running pgbouncer auth schema... vm-test-run-timescaledb> server # [ 115.366594] postgres[1492]: ::1 2026-10-26 08:18:14.843 UTC [1492] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-timescaledb> server # [ 115.393852] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1488]: CREATE ROLE vm-test-run-timescaledb> server # [ 115.395510] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1488]: REVOKE vm-test-run-timescaledb> server # [ 115.397410] postgres[1492]: ::1 2026-10-26 08:18:14.860 UTC [1492] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-timescaledb> server # [ 115.399055] postgres[1492]: ::1 2026-10-26 08:18:14.870 UTC [1492] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-timescaledb> server # [ 115.460783] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1488]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 115.463811] postgres[1492]: ::1 2026-10-26 08:18:14.940 UTC [1492] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-timescaledb> server # [ 115.469716] postgres[1492]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-timescaledb> server # [ 115.470416] postgres[1492]: $$ vm-test-run-timescaledb> server # [ 115.472275] postgres[1492]: BEGIN vm-test-run-timescaledb> server # [ 115.477172] postgres[1492]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-timescaledb> server # [ 115.478584] postgres[1492]: vm-test-run-timescaledb> server # [ 115.485824] postgres[1492]: RETURN QUERY vm-test-run-timescaledb> server # [ 115.486649] postgres[1492]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-timescaledb> server # [ 115.487719] postgres[1492]: WHERE usename = p_usename; vm-test-run-timescaledb> server # [ 115.489760] postgres[1492]: END; vm-test-run-timescaledb> server # [ 115.490594] postgres[1492]: $$ LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 115.492091] postgres[1492]: SET search_path = '' vm-test-run-timescaledb> server # [ 115.497519] postgres[1492]: SECURITY DEFINER; vm-test-run-timescaledb> server # [ 115.498308] postgres[1492]: ::1 2026-10-26 08:18:14.965 UTC [1492] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-timescaledb> server # [ 115.502406] postgres[1492]: ::1 2026-10-26 08:18:14.975 UTC [1492] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-timescaledb> server # [ 115.503763] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1488]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 115.505440] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1488]: REVOKE vm-test-run-timescaledb> server # [ 115.506099] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1488]: GRANT vm-test-run-timescaledb> server # [ 115.545104] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running stat extension... vm-test-run-timescaledb> server # [ 115.977931] postgres[1507]: ::1 2026-10-26 08:18:15.420 UTC [1507] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-timescaledb> server # [ 116.014719] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1499]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-timescaledb> server # [ 116.054713] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1499]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 116.055815] postgres[1507]: ::1 2026-10-26 08:18:15.534 UTC [1507] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-timescaledb> server # [ 116.879773] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1499]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 116.943015] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-timescaledb> server # [ 117.130786] postgres[1512]: ::1 2026-10-26 08:18:16.608 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-timescaledb> server # [ 117.156010] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 117.166023] postgres[1512]: ::1 2026-10-26 08:18:16.622 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 117.167487] postgres[1512]: ::1 2026-10-26 08:18:16.632 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 117.171477] postgres[1512]: ::1 2026-10-26 08:18:16.642 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 117.173790] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 117.174468] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 117.179402] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 117.184968] postgres[1512]: ::1 2026-10-26 08:18:16.661 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 117.191463] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 117.194162] postgres[1512]: ::1 2026-10-26 08:18:16.673 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 117.201159] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 117.206230] postgres[1512]: ::1 2026-10-26 08:18:16.686 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 117.210819] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 117.211786] postgres[1512]: ::1 2026-10-26 08:18:16.690 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 117.223709] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 117.227128] postgres[1512]: ::1 2026-10-26 08:18:16.705 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 117.258493] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 117.277788] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1511]: DO vm-test-run-timescaledb> server # [ 117.280899] postgres[1512]: ::1 2026-10-26 08:18:16.760 UTC [1512] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-timescaledb> server # [ 117.287821] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1511]: ALTER ROLE vm-test-run-timescaledb> server # [ 117.330107] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-timescaledb> server # [ 117.663112] postgres[1518]: ::1 2026-10-26 08:18:17.132 UTC [1518] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 117.673867] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: GRANT vm-test-run-timescaledb> server # [ 117.674909] postgres[1518]: ::1 2026-10-26 08:18:17.152 UTC [1518] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 117.684487] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: GRANT vm-test-run-timescaledb> server # [ 117.686429] postgres[1518]: ::1 2026-10-26 08:18:17.165 UTC [1518] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 117.697026] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: GRANT vm-test-run-timescaledb> server # [ 117.698814] postgres[1518]: ::1 2026-10-26 08:18:17.178 UTC [1518] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 117.722692] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: ALTER TABLE vm-test-run-timescaledb> server # [ 117.732747] postgres[1518]: ::1 2026-10-26 08:18:17.205 UTC [1518] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 117.752099] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: ALTER TABLE vm-test-run-timescaledb> server # [ 117.753335] postgres[1518]: ::1 2026-10-26 08:18:17.229 UTC [1518] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 117.765394] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: ALTER TABLE vm-test-run-timescaledb> server # [ 117.767414] postgres[1518]: ::1 2026-10-26 08:18:17.243 UTC [1518] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 117.775452] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: ALTER TABLE vm-test-run-timescaledb> server # [ 117.786797] postgres[1518]: ::1 2026-10-26 08:18:17.266 UTC [1518] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 117.803303] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: ALTER TABLE vm-test-run-timescaledb> server # [ 117.809619] postgres[1518]: ::1 2026-10-26 08:18:17.286 UTC [1518] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 117.823281] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: GRANT vm-test-run-timescaledb> server # [ 117.824971] postgres[1518]: ::1 2026-10-26 08:18:17.304 UTC [1518] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 117.838045] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: GRANT vm-test-run-timescaledb> server # [ 117.839781] postgres[1518]: ::1 2026-10-26 08:18:17.316 UTC [1518] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 117.850731] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: GRANT vm-test-run-timescaledb> server # [ 117.853002] postgres[1518]: ::1 2026-10-26 08:18:17.325 UTC [1518] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 117.863215] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: GRANT vm-test-run-timescaledb> server # [ 117.863924] postgres[1518]: ::1 2026-10-26 08:18:17.344 UTC [1518] 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 # [ 117.886072] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 117.887689] postgres[1518]: ::1 2026-10-26 08:18:17.365 UTC [1518] 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 # [ 117.898576] postgres[1518]: ::1 2026-10-26 08:18:17.375 UTC [1518] 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 # [ 117.900634] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 117.915139] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1515]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 117.950839] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-timescaledb> server # [ 118.256059] postgres[1528]: ::1 2026-10-26 08:18:17.726 UTC [1528] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-timescaledb> server # [ 118.283347] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1526]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 118.311569] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 118.581139] postgres[1542]: ::1 2026-10-26 08:18:18.047 UTC [1542] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-timescaledb> server # [ 118.599728] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1535]: GRANT vm-test-run-timescaledb> server # [ 118.603523] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1535]: GRANT vm-test-run-timescaledb> server # [ 118.607761] postgres[1542]: ::1 2026-10-26 08:18:18.073 UTC [1542] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 118.615376] postgres[1542]: ::1 2026-10-26 08:18:18.085 UTC [1542] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 118.619707] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1535]: GRANT vm-test-run-timescaledb> server # [ 118.633090] postgres[1542]: ::1 2026-10-26 08:18:18.090 UTC [1542] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 118.634315] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1535]: GRANT vm-test-run-timescaledb> server # [ 118.656627] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-timescaledb> server # [ 118.910966] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1543]: DO vm-test-run-timescaledb> server # [ 118.915767] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1543]: DO vm-test-run-timescaledb> server # [ 118.927608] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1543]: DO vm-test-run-timescaledb> server # [ 118.970082] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 119.168840] postgres[1546]: ::1 2026-10-26 08:18:18.642 UTC [1546] 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 # [ 119.216948] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1545]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 119.218924] postgres[1546]: ::1 2026-10-26 08:18:18.671 UTC [1546] 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 # [ 119.226278] postgres[1546]: ::1 2026-10-26 08:18:18.689 UTC [1546] 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 # [ 119.228070] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1545]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 119.235890] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1545]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 119.275536] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-timescaledb> server # [ 119.537906] postgres[1552]: ::1 2026-10-26 08:18:19.008 UTC [1552] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-timescaledb> server # [ 119.566783] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1550]: ALTER ROLE vm-test-run-timescaledb> server # [ 119.591864] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-timescaledb> server # [ 119.850920] postgres[1554]: ::1 2026-10-26 08:18:19.312 UTC [1554] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 119.853291] postgres[1554]: ::1 2026-10-26 08:18:19.327 UTC [1554] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 119.857558] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: psql:/nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-timescaledb> server # [ 119.860954] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 119.861870] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: psql:/nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-timescaledb> server # [ 119.863176] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: DROP FUNCTION vm-test-run-timescaledb> server # [ 119.865084] postgres[1554]: ::1 2026-10-26 08:18:19.343 UTC [1554] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 119.866312] postgres[1554]: DECLARE vm-test-run-timescaledb> server # [ 119.867259] postgres[1554]: cmd record; vm-test-run-timescaledb> server # [ 119.867731] postgres[1554]: BEGIN vm-test-run-timescaledb> server # [ 119.869632] postgres[1554]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 119.870956] postgres[1554]: LOOP vm-test-run-timescaledb> server # [ 119.871350] postgres[1554]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 119.873259] postgres[1554]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 119.874118] postgres[1554]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 119.875475] postgres[1554]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 119.876955] postgres[1554]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 119.878050] postgres[1554]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 119.879419] postgres[1554]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 119.882034] postgres[1554]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 119.882917] postgres[1554]: , 'CREATE TYPE' vm-test-run-timescaledb> server # [ 119.883652] postgres[1554]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 119.885194] postgres[1554]: , 'COMMENT' vm-test-run-timescaledb> server # [ 119.886322] postgres[1554]: ) vm-test-run-timescaledb> server # [ 119.886613] postgres[1554]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 119.887487] postgres[1554]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 119.891743] postgres[1554]: THEN vm-test-run-timescaledb> server # [ 119.892581] postgres[1554]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 119.897658] postgres[1554]: END IF; vm-test-run-timescaledb> server # [ 119.898340] postgres[1554]: END LOOP; vm-test-run-timescaledb> server # [ 119.899500] postgres[1554]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 119.915409] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 119.921536] postgres[1554]: ::1 2026-10-26 08:18:19.399 UTC [1554] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 119.923289] postgres[1554]: DECLARE vm-test-run-timescaledb> server # [ 119.928040] postgres[1554]: obj record; vm-test-run-timescaledb> server # [ 119.930572] postgres[1554]: BEGIN vm-test-run-timescaledb> server # [ 119.931329] postgres[1554]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 119.937090] postgres[1554]: LOOP vm-test-run-timescaledb> server # [ 119.937642] postgres[1554]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 119.938787] postgres[1554]: 'schema' vm-test-run-timescaledb> server # [ 119.939250] postgres[1554]: , 'table' vm-test-run-timescaledb> server # [ 119.939870] postgres[1554]: , 'foreign table' vm-test-run-timescaledb> server # [ 119.942904] postgres[1554]: , 'view' vm-test-run-timescaledb> server # [ 119.943482] postgres[1554]: , 'materialized view' vm-test-run-timescaledb> server # [ 119.951938] postgres[1554]: , 'function' vm-test-run-timescaledb> server # [ 119.953498] postgres[1554]: , 'trigger' vm-test-run-timescaledb> server # [ 119.954048] postgres[1554]: , 'type' vm-test-run-timescaledb> server # [ 119.954710] postgres[1554]: , 'rule' vm-test-run-timescaledb> server # [ 119.955397] postgres[1554]: ) vm-test-run-timescaledb> server # [ 119.955870] postgres[1554]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 119.959455] postgres[1554]: THEN vm-test-run-timescaledb> server # [ 119.960060] postgres[1554]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 119.962756] postgres[1554]: END IF; vm-test-run-timescaledb> server # [ 119.970532] postgres[1554]: END LOOP; vm-test-run-timescaledb> server # [ 119.971031] postgres[1554]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 119.971923] postgres[1554]: ::1 2026-10-26 08:18:19.414 UTC [1554] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 119.977344] postgres[1554]: ::1 2026-10-26 08:18:19.418 UTC [1554] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 119.978302] postgres[1554]: ON ddl_command_end vm-test-run-timescaledb> server # [ 119.978970] postgres[1554]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 119.979292] postgres[1554]: ::1 2026-10-26 08:18:19.430 UTC [1554] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 119.979834] postgres[1554]: ::1 2026-10-26 08:18:19.434 UTC [1554] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 119.991840] postgres[1554]: ON sql_drop vm-test-run-timescaledb> server # [ 120.003875] postgres[1554]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 120.006397] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 120.006895] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: psql:/nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 120.007672] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 120.008241] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 120.018400] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: psql:/nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 120.019492] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 120.019956] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1553]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 120.032095] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-timescaledb> server # [ 120.838148] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1555]: DO vm-test-run-timescaledb> server # [ 120.865339] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-timescaledb> server # [ 121.365127] postgres[1562]: ::1 2026-10-26 08:18:20.818 UTC [1562] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-timescaledb> server # [ 121.462991] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 121.474047] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: psql:/nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-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 # [ 121.487513] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: DROP FUNCTION vm-test-run-timescaledb> server # [ 121.488954] postgres[1562]: ::1 2026-10-26 08:18:20.913 UTC [1562] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-timescaledb> server # [ 121.491894] postgres[1562]: ::1 2026-10-26 08:18:20.949 UTC [1562] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 121.506695] postgres[1562]: "operationName" text default null, vm-test-run-timescaledb> server # [ 121.516580] postgres[1562]: query text default null, vm-test-run-timescaledb> server # [ 121.519043] postgres[1562]: variables jsonb default null, vm-test-run-timescaledb> server # [ 121.522460] postgres[1562]: extensions jsonb default null vm-test-run-timescaledb> server # [ 121.523307] postgres[1562]: ) vm-test-run-timescaledb> server # [ 121.537315] postgres[1562]: returns jsonb vm-test-run-timescaledb> server # [ 121.539904] postgres[1562]: language plpgsql vm-test-run-timescaledb> server # [ 121.546820] postgres[1562]: as $$ vm-test-run-timescaledb> server # [ 121.554991] postgres[1562]: DECLARE vm-test-run-timescaledb> server # [ 121.558293] postgres[1562]: server_version float; vm-test-run-timescaledb> server # [ 121.559171] postgres[1562]: BEGIN vm-test-run-timescaledb> server # [ 121.566241] postgres[1562]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 121.567356] postgres[1562]: vm-test-run-timescaledb> server # [ 121.568056] postgres[1562]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 121.573375] postgres[1562]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 121.574940] postgres[1562]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 121.575908] postgres[1562]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 121.587190] postgres[1562]: ); vm-test-run-timescaledb> server # [ 121.592800] postgres[1562]: ELSE vm-test-run-timescaledb> server # [ 121.595448] postgres[1562]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 121.596203] postgres[1562]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 121.599844] postgres[1562]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 121.604018] postgres[1562]: ); vm-test-run-timescaledb> server # [ 121.609044] postgres[1562]: END IF; vm-test-run-timescaledb> server # [ 121.610209] postgres[1562]: END; vm-test-run-timescaledb> server # [ 121.615522] postgres[1562]: $$; vm-test-run-timescaledb> server # [ 121.623529] postgres[1562]: ::1 2026-10-26 08:18:21.014 UTC [1562] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.629284] postgres[1562]: ::1 2026-10-26 08:18:21.043 UTC [1562] 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 # [ 121.640339] postgres[1562]: ::1 2026-10-26 08:18:21.062 UTC [1562] 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 # [ 121.642579] postgres[1562]: ::1 2026-10-26 08:18:21.086 UTC [1562] 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 # [ 121.653600] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 121.654474] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: GRANT vm-test-run-timescaledb> server # [ 121.654834] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.655110] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.655853] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.656686] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.661280] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.670999] postgres[1562]: ::1 2026-10-26 08:18:21.106 UTC [1562] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 121.671916] postgres[1562]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.674709] postgres[1562]: ::1 2026-10-26 08:18:21.118 UTC [1562] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 121.677274] postgres[1562]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.678835] postgres[1562]: ::1 2026-10-26 08:18:21.130 UTC [1562] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 121.680847] postgres[1562]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.682680] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 121.689068] postgres[1562]: ::1 2026-10-26 08:18:21.167 UTC [1562] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 121.690881] postgres[1562]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 121.691433] postgres[1562]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 121.692030] postgres[1562]: AS $func$ vm-test-run-timescaledb> server # [ 121.697051] postgres[1562]: DECLARE vm-test-run-timescaledb> server # [ 121.697744] postgres[1562]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 121.698309] postgres[1562]: BEGIN vm-test-run-timescaledb> server # [ 121.698594] postgres[1562]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 121.699008] postgres[1562]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 121.699340] postgres[1562]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 121.702067] postgres[1562]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 121.703555] postgres[1562]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 121.710897] postgres[1562]: ); vm-test-run-timescaledb> server # [ 121.713445] postgres[1562]: vm-test-run-timescaledb> server # [ 121.714596] postgres[1562]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 121.715405] postgres[1562]: THEN vm-test-run-timescaledb> server # [ 121.715845] postgres[1562]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.721332] postgres[1562]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.723810] postgres[1562]: vm-test-run-timescaledb> server # [ 121.730463] postgres[1562]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.748563] postgres[1562]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.765302] postgres[1562]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.767467] postgres[1562]: vm-test-run-timescaledb> server # [ 121.776040] postgres[1562]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 121.781112] postgres[1562]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 121.781797] postgres[1562]: "operationName" text default null, vm-test-run-timescaledb> server # [ 121.787949] postgres[1562]: query text default null, vm-test-run-timescaledb> server # [ 121.789862] postgres[1562]: variables jsonb default null, vm-test-run-timescaledb> server # [ 121.790326] postgres[1562]: extensions jsonb default null vm-test-run-timescaledb> server # [ 121.791627] postgres[1562]: ) vm-test-run-timescaledb> server # [ 121.797172] postgres[1562]: returns jsonb vm-test-run-timescaledb> server # [ 121.797916] postgres[1562]: language sql vm-test-run-timescaledb> server # [ 121.798844] postgres[1562]: as $$ vm-test-run-timescaledb> server # [ 121.804270] postgres[1562]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-timescaledb> server # [ 121.816878] postgres[1562]: $$; vm-test-run-timescaledb> server # [ 121.820445] postgres[1562]: vm-test-run-timescaledb> server # [ 121.830741] postgres[1562]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.837083] postgres[1562]: END IF; vm-test-run-timescaledb> server # [ 121.838502] postgres[1562]: vm-test-run-timescaledb> server # [ 121.838995] postgres[1562]: END; vm-test-run-timescaledb> server # [ 121.839272] postgres[1562]: $func$; vm-test-run-timescaledb> server # [ 121.839727] postgres[1562]: ::1 2026-10-26 08:18:21.220 UTC [1562] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-timescaledb> server # [ 121.846505] postgres[1562]: ::1 2026-10-26 08:18:21.244 UTC [1562] 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 # [ 121.850120] postgres[1562]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-timescaledb> server # [ 121.851473] postgres[1562]: ::1 2026-10-26 08:18:21.268 UTC [1562] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-timescaledb> server # [ 121.858065] postgres[1562]: ::1 2026-10-26 08:18:21.289 UTC [1562] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 121.866536] postgres[1562]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 121.867756] postgres[1562]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 121.875889] postgres[1562]: AS $func$ vm-test-run-timescaledb> server # [ 121.883015] postgres[1562]: DECLARE vm-test-run-timescaledb> server # [ 121.884669] postgres[1562]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 121.889981] postgres[1562]: BEGIN vm-test-run-timescaledb> server # [ 121.891712] postgres[1562]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 121.892207] postgres[1562]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 121.903962] postgres[1562]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 121.911693] postgres[1562]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 121.919662] postgres[1562]: ); vm-test-run-timescaledb> server # [ 121.927033] postgres[1562]: vm-test-run-timescaledb> server # [ 121.933536] postgres[1562]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 121.936139] postgres[1562]: THEN vm-test-run-timescaledb> server # [ 121.944196] postgres[1562]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 121.965874] postgres[1562]: "operationName" text default null, vm-test-run-timescaledb> server # [ 121.967093] postgres[1562]: query text default null, vm-test-run-timescaledb> server # [ 121.968570] postgres[1562]: variables jsonb default null, vm-test-run-timescaledb> server # [ 121.976567] postgres[1562]: extensions jsonb default null vm-test-run-timescaledb> server # [ 121.986723] postgres[1562]: ) vm-test-run-timescaledb> server # [ 121.987738] postgres[1562]: returns jsonb vm-test-run-timescaledb> server # [ 121.989836] postgres[1562]: language plpgsql vm-test-run-timescaledb> server # [ 121.991011] postgres[1562]: as $$ vm-test-run-timescaledb> server # [ 121.991405] postgres[1562]: DECLARE vm-test-run-timescaledb> server # [ 121.991705] postgres[1562]: server_version float; vm-test-run-timescaledb> server # [ 121.991981] postgres[1562]: BEGIN vm-test-run-timescaledb> server # [ 121.992239] postgres[1562]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 122.001772] postgres[1562]: vm-test-run-timescaledb> server # [ 122.011482] postgres[1562]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 122.023914] postgres[1562]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 122.043937] postgres[1562]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 122.048206] postgres[1562]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 122.049413] postgres[1562]: ); vm-test-run-timescaledb> server # [ 122.059079] postgres[1562]: ELSE vm-test-run-timescaledb> server # [ 122.060510] postgres[1562]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 122.070394] postgres[1562]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 122.077564] postgres[1562]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 122.079778] postgres[1562]: ); vm-test-run-timescaledb> server # [ 122.080190] postgres[1562]: END IF; vm-test-run-timescaledb> server # [ 122.080515] postgres[1562]: END; vm-test-run-timescaledb> server # [ 122.095137] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 122.103319] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: psql:/nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping vm-test-run-timescaledb> server # [ 122.114632] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 122.115562] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 122.116156] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: COMMENT vm-test-run-timescaledb> server # [ 122.125385] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 122.127664] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: psql:/nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping vm-test-run-timescaledb> server # [ 122.141515] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 122.143564] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 122.155578] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1557]: COMMENT vm-test-run-timescaledb> server # [ 122.156907] postgres[1562]: $$; vm-test-run-timescaledb> server # [ 122.158477] postgres[1562]: END IF; vm-test-run-timescaledb> server # [ 122.165154] postgres[1562]: vm-test-run-timescaledb> server # [ 122.167430] postgres[1562]: END; vm-test-run-timescaledb> server # [ 122.177188] postgres[1562]: $func$; vm-test-run-timescaledb> server # [ 122.179352] postgres[1562]: ::1 2026-10-26 08:18:21.443 UTC [1562] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-timescaledb> server # [ 122.181255] postgres[1562]: ::1 2026-10-26 08:18:21.449 UTC [1562] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-timescaledb> server # [ 122.182495] postgres[1562]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-timescaledb> server # [ 122.184708] postgres[1562]: ::1 2026-10-26 08:18:21.468 UTC [1562] 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 # [ 122.189167] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-timescaledb> server # [ 122.545676] postgres[1578]: ::1 2026-10-26 08:18:22.005 UTC [1578] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 122.554784] postgres[1578]: ::1 2026-10-26 08:18:22.017 UTC [1578] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 122.579468] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1574]: psql:/nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-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 # [ 122.586433] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1574]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 122.592883] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1574]: psql:/nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-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 # [ 122.602772] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1574]: DROP FUNCTION vm-test-run-timescaledb> server # [ 122.603849] postgres[1578]: ::1 2026-10-26 08:18:22.071 UTC [1578] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 122.609250] postgres[1578]: DECLARE vm-test-run-timescaledb> server # [ 122.612113] postgres[1578]: cmd record; vm-test-run-timescaledb> server # [ 122.622158] postgres[1578]: BEGIN vm-test-run-timescaledb> server # [ 122.625414] postgres[1578]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 122.626380] postgres[1578]: LOOP vm-test-run-timescaledb> server # [ 122.626794] postgres[1578]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 122.627068] postgres[1578]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 122.628093] postgres[1578]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 122.637234] postgres[1578]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 122.637860] postgres[1578]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 122.638676] postgres[1578]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 122.639778] postgres[1578]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 122.640344] postgres[1578]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 122.649523] postgres[1578]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-timescaledb> server # [ 122.650082] postgres[1578]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 122.650378] postgres[1578]: , 'COMMENT' vm-test-run-timescaledb> server # [ 122.650916] postgres[1578]: ) vm-test-run-timescaledb> server # [ 122.651214] postgres[1578]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 122.651528] postgres[1578]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 122.651872] postgres[1578]: THEN vm-test-run-timescaledb> server # [ 122.652122] postgres[1578]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 122.652357] postgres[1578]: END IF; vm-test-run-timescaledb> server # [ 122.662014] postgres[1578]: END LOOP; vm-test-run-timescaledb> server # [ 122.662500] postgres[1578]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 122.677878] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1574]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 122.679049] postgres[1578]: ::1 2026-10-26 08:18:22.158 UTC [1578] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 122.685383] postgres[1578]: DECLARE vm-test-run-timescaledb> server # [ 122.686087] postgres[1578]: obj record; vm-test-run-timescaledb> server # [ 122.686905] postgres[1578]: BEGIN vm-test-run-timescaledb> server # [ 122.687948] postgres[1578]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 122.690002] postgres[1578]: LOOP vm-test-run-timescaledb> server # [ 122.690768] postgres[1578]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 122.691193] postgres[1578]: 'schema' vm-test-run-timescaledb> server # [ 122.691470] postgres[1578]: , 'table' vm-test-run-timescaledb> server # [ 122.692335] postgres[1578]: , 'foreign table' vm-test-run-timescaledb> server # [ 122.697671] postgres[1578]: , 'view' vm-test-run-timescaledb> server # [ 122.698238] postgres[1578]: , 'materialized view' vm-test-run-timescaledb> server # [ 122.698525] postgres[1578]: , 'function' vm-test-run-timescaledb> server # [ 122.699300] postgres[1578]: , 'trigger' vm-test-run-timescaledb> server # [ 122.699730] postgres[1578]: , 'type' vm-test-run-timescaledb> server # [ 122.705619] postgres[1578]: , 'rule' vm-test-run-timescaledb> server # [ 122.706084] postgres[1578]: ) vm-test-run-timescaledb> server # [ 122.706591] postgres[1578]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 122.707260] postgres[1578]: THEN vm-test-run-timescaledb> server # [ 122.707772] postgres[1578]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 122.708528] postgres[1578]: END IF; vm-test-run-timescaledb> server # [ 122.711138] postgres[1578]: END LOOP; vm-test-run-timescaledb> server # [ 122.711617] postgres[1578]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 122.717500] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1574]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 122.719794] postgres[1578]: ::1 2026-10-26 08:18:22.196 UTC [1578] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 122.755776] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1574]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 122.774240] postgres[1578]: ::1 2026-10-26 08:18:22.242 UTC [1578] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 122.777834] postgres[1578]: ON ddl_command_end vm-test-run-timescaledb> server # [ 122.780214] postgres[1578]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 122.793205] postgres[1578]: ::1 2026-10-26 08:18:22.268 UTC [1578] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 122.794241] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1574]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 122.809295] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1574]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 122.810198] postgres[1578]: ::1 2026-10-26 08:18:22.290 UTC [1578] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 122.810648] postgres[1578]: ON sql_drop vm-test-run-timescaledb> server # [ 122.811211] postgres[1578]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 122.825127] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1574]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 122.875439] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-timescaledb> server # [ 123.257837] postgres[1590]: ::1 2026-10-26 08:18:22.721 UTC [1590] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-timescaledb> server # [ 123.272008] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1587]: ALTER ROLE vm-test-run-timescaledb> server # [ 123.347679] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-timescaledb> server # [ 123.717182] postgres[1592]: ::1 2026-10-26 08:18:23.171 UTC [1592] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 123.721758] postgres[1592]: returns event_trigger vm-test-run-timescaledb> server # [ 123.728850] postgres[1592]: language plpgsql vm-test-run-timescaledb> server # [ 123.730477] postgres[1592]: AS $func$ vm-test-run-timescaledb> server # [ 123.733998] postgres[1592]: DECLARE vm-test-run-timescaledb> server # [ 123.735183] postgres[1592]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 123.737444] postgres[1592]: BEGIN vm-test-run-timescaledb> server # [ 123.738569] postgres[1592]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 123.739301] postgres[1592]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 123.739587] postgres[1592]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 123.739864] postgres[1592]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 123.740327] postgres[1592]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 123.741756] postgres[1592]: ); vm-test-run-timescaledb> server # [ 123.742079] postgres[1592]: vm-test-run-timescaledb> server # [ 123.742878] postgres[1592]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 123.743343] postgres[1592]: THEN vm-test-run-timescaledb> server # [ 123.743644] postgres[1592]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.744419] postgres[1592]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.745864] postgres[1592]: vm-test-run-timescaledb> server # [ 123.746180] postgres[1592]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.747143] postgres[1592]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.747707] postgres[1592]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.749378] postgres[1592]: vm-test-run-timescaledb> server # [ 123.749709] postgres[1592]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 123.750040] postgres[1592]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 123.751300] postgres[1592]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 123.752076] postgres[1592]: "operationName" text default null, vm-test-run-timescaledb> server # [ 123.753560] postgres[1592]: query text default null, vm-test-run-timescaledb> server # [ 123.754836] postgres[1592]: variables jsonb default null, vm-test-run-timescaledb> server # [ 123.755553] postgres[1592]: extensions jsonb default null vm-test-run-timescaledb> server # [ 123.757558] postgres[1592]: ) vm-test-run-timescaledb> server # [ 123.757934] postgres[1592]: returns jsonb vm-test-run-timescaledb> server # [ 123.758177] postgres[1592]: language sql vm-test-run-timescaledb> server # [ 123.760642] postgres[1592]: as $$ vm-test-run-timescaledb> server # [ 123.761050] postgres[1592]: -- This changed vm-test-run-timescaledb> server # [ 123.762042] postgres[1592]: select graphql.resolve( vm-test-run-timescaledb> server # [ 123.762704] postgres[1592]: query := query, vm-test-run-timescaledb> server # [ 123.763616] postgres[1592]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 123.765118] postgres[1592]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 123.765950] postgres[1592]: extensions := extensions vm-test-run-timescaledb> server # [ 123.771227] postgres[1592]: ); vm-test-run-timescaledb> server # [ 123.772092] postgres[1592]: $$; vm-test-run-timescaledb> server # [ 123.778467] postgres[1592]: vm-test-run-timescaledb> server # [ 123.778904] postgres[1592]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.779385] postgres[1592]: END IF; vm-test-run-timescaledb> server # [ 123.788072] postgres[1592]: vm-test-run-timescaledb> server # [ 123.789608] postgres[1592]: END; vm-test-run-timescaledb> server # [ 123.789979] postgres[1592]: $func$; vm-test-run-timescaledb> server # [ 123.806300] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1591]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 123.814204] postgres[1592]: ::1 2026-10-26 08:18:23.289 UTC [1592] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 123.815012] postgres[1592]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 123.815486] postgres[1592]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 123.815781] postgres[1592]: AS $func$ vm-test-run-timescaledb> server # [ 123.816094] postgres[1592]: DECLARE vm-test-run-timescaledb> server # [ 123.816335] postgres[1592]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 123.827461] postgres[1592]: BEGIN vm-test-run-timescaledb> server # [ 123.829307] postgres[1592]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 123.829726] postgres[1592]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 123.830441] postgres[1592]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 123.830770] postgres[1592]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 123.831049] postgres[1592]: ); vm-test-run-timescaledb> server # [ 123.831262] postgres[1592]: vm-test-run-timescaledb> server # [ 123.831465] postgres[1592]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 123.831702] postgres[1592]: THEN vm-test-run-timescaledb> server # [ 123.832221] postgres[1592]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 123.835034] postgres[1592]: "operationName" text default null, vm-test-run-timescaledb> server # [ 123.846546] postgres[1592]: query text default null, vm-test-run-timescaledb> server # [ 123.847136] postgres[1592]: variables jsonb default null, vm-test-run-timescaledb> server # [ 123.853383] postgres[1592]: extensions jsonb default null vm-test-run-timescaledb> server # [ 123.855195] postgres[1592]: ) vm-test-run-timescaledb> server # [ 123.857246] postgres[1592]: returns jsonb vm-test-run-timescaledb> server # [ 123.858106] postgres[1592]: language plpgsql vm-test-run-timescaledb> server # [ 123.858772] postgres[1592]: as $$ vm-test-run-timescaledb> server # [ 123.859463] postgres[1592]: DECLARE vm-test-run-timescaledb> server # [ 123.859832] postgres[1592]: server_version float; vm-test-run-timescaledb> server # [ 123.863395] postgres[1592]: BEGIN vm-test-run-timescaledb> server # [ 123.864022] postgres[1592]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 123.867493] postgres[1592]: vm-test-run-timescaledb> server # [ 123.867886] postgres[1592]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 123.878111] postgres[1592]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 123.879196] postgres[1592]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 123.880334] postgres[1592]: jsonb_build_object( vm-test-run-timescaledb> server # [ 123.885964] postgres[1592]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 123.887289] postgres[1592]: ) vm-test-run-timescaledb> server # [ 123.887811] postgres[1592]: ) vm-test-run-timescaledb> server # [ 123.888237] postgres[1592]: ); vm-test-run-timescaledb> server # [ 123.893848] postgres[1592]: ELSE vm-test-run-timescaledb> server # [ 123.894362] postgres[1592]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 123.895313] postgres[1592]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 123.899477] postgres[1592]: jsonb_build_object( vm-test-run-timescaledb> server # [ 123.900057] postgres[1592]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 123.909919] postgres[1592]: ) vm-test-run-timescaledb> server # [ 123.913263] postgres[1592]: ) vm-test-run-timescaledb> server # [ 123.913987] postgres[1592]: ); vm-test-run-timescaledb> server # [ 123.914336] postgres[1592]: END IF; vm-test-run-timescaledb> server # [ 123.914782] postgres[1592]: END; vm-test-run-timescaledb> server # [ 123.915722] postgres[1592]: $$; vm-test-run-timescaledb> server # [ 123.916129] postgres[1592]: END IF; vm-test-run-timescaledb> server # [ 123.916675] postgres[1592]: vm-test-run-timescaledb> server # [ 123.917655] postgres[1592]: END; vm-test-run-timescaledb> server # [ 123.918222] postgres[1592]: $func$; vm-test-run-timescaledb> server # [ 123.919794] postgres[1592]: ::1 2026-10-26 08:18:23.320 UTC [1592] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 123.921350] postgres[1592]: "operationName" text default null, vm-test-run-timescaledb> server # [ 123.921941] postgres[1592]: query text default null, vm-test-run-timescaledb> server # [ 123.922722] postgres[1592]: variables jsonb default null, vm-test-run-timescaledb> server # [ 123.923279] postgres[1592]: extensions jsonb default null vm-test-run-timescaledb> server # [ 123.925326] postgres[1592]: ) vm-test-run-timescaledb> server # [ 123.926765] postgres[1592]: returns jsonb vm-test-run-timescaledb> server # [ 123.930358] postgres[1592]: language plpgsql vm-test-run-timescaledb> server # [ 123.931699] postgres[1592]: as $$ vm-test-run-timescaledb> server # [ 123.933923] postgres[1592]: DECLARE vm-test-run-timescaledb> server # [ 123.935411] postgres[1592]: server_version float; vm-test-run-timescaledb> server # [ 123.936077] postgres[1592]: BEGIN vm-test-run-timescaledb> server # [ 123.937472] postgres[1592]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 123.937846] postgres[1592]: vm-test-run-timescaledb> server # [ 123.938951] postgres[1592]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 123.941029] postgres[1592]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 123.942818] postgres[1592]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 123.943557] postgres[1592]: jsonb_build_object( vm-test-run-timescaledb> server # [ 123.945000] postgres[1592]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 123.946847] postgres[1592]: ) vm-test-run-timescaledb> server # [ 123.949472] postgres[1592]: ) vm-test-run-timescaledb> server # [ 123.950931] postgres[1592]: ); vm-test-run-timescaledb> server # [ 123.951952] postgres[1592]: ELSE vm-test-run-timescaledb> server # [ 123.953370] postgres[1592]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 123.953763] postgres[1592]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 123.954058] postgres[1592]: jsonb_build_object( vm-test-run-timescaledb> server # [ 123.954476] postgres[1592]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 123.957488] postgres[1592]: ) vm-test-run-timescaledb> server # [ 123.959954] postgres[1592]: ) vm-test-run-timescaledb> server # [ 123.961883] postgres[1592]: ); vm-test-run-timescaledb> server # [ 123.962426] postgres[1592]: END IF; vm-test-run-timescaledb> server # [ 123.963333] postgres[1592]: END; vm-test-run-timescaledb> server # [ 123.963653] postgres[1592]: $$; vm-test-run-timescaledb> server # [ 123.964624] postgres[1592]: ::1 2026-10-26 08:18:23.354 UTC [1592] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 123.969327] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1591]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 123.971189] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1591]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 123.971981] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1591]: psql:/nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping vm-test-run-timescaledb> server # [ 123.975422] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1591]: DROP EXTENSION vm-test-run-timescaledb> server # [ 125.695334] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1591]: DO vm-test-run-timescaledb> server # [ 125.771167] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql vm-test-run-timescaledb> server # [ 126.254356] postgres[1613]: ::1 2026-10-26 08:18:25.710 UTC [1613] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-timescaledb> server # [ 126.332159] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1608]: GRANT ROLE vm-test-run-timescaledb> server # [ 126.355177] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-timescaledb> server # [ 126.655642] postgres[1620]: ::1 2026-10-26 08:18:26.126 UTC [1620] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 126.661709] postgres[1620]: returns event_trigger vm-test-run-timescaledb> server # [ 126.663250] postgres[1620]: language plpgsql vm-test-run-timescaledb> server # [ 126.663749] postgres[1620]: AS $func$ vm-test-run-timescaledb> server # [ 126.664233] postgres[1620]: DECLARE vm-test-run-timescaledb> server # [ 126.665674] postgres[1620]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 126.666090] postgres[1620]: BEGIN vm-test-run-timescaledb> server # [ 126.666442] postgres[1620]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 126.667935] postgres[1620]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 126.669770] postgres[1620]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 126.671371] postgres[1620]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 126.671812] postgres[1620]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 126.677891] postgres[1620]: ); vm-test-run-timescaledb> server # [ 126.678454] postgres[1620]: vm-test-run-timescaledb> server # [ 126.679459] postgres[1620]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 126.679892] postgres[1620]: THEN vm-test-run-timescaledb> server # [ 126.692753] postgres[1620]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 126.705394] postgres[1620]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 126.706272] postgres[1620]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 126.706629] postgres[1620]: "operationName" text default null, vm-test-run-timescaledb> server # [ 126.707376] postgres[1620]: query text default null, vm-test-run-timescaledb> server # [ 126.717199] postgres[1620]: variables jsonb default null, vm-test-run-timescaledb> server # [ 126.717800] postgres[1620]: extensions jsonb default null vm-test-run-timescaledb> server # [ 126.718322] postgres[1620]: ) vm-test-run-timescaledb> server # [ 126.718578] postgres[1620]: returns jsonb vm-test-run-timescaledb> server # [ 126.719238] postgres[1620]: language sql vm-test-run-timescaledb> server # [ 126.719634] postgres[1620]: as $$ vm-test-run-timescaledb> server # [ 126.720039] postgres[1620]: select graphql.resolve( vm-test-run-timescaledb> server # [ 126.726848] postgres[1620]: query := query, vm-test-run-timescaledb> server # [ 126.727442] postgres[1620]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 126.727746] postgres[1620]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 126.728037] postgres[1620]: extensions := extensions vm-test-run-timescaledb> server # [ 126.728484] postgres[1620]: ); vm-test-run-timescaledb> server # [ 126.729556] postgres[1620]: $$; vm-test-run-timescaledb> server # [ 126.730291] postgres[1620]: vm-test-run-timescaledb> server # [ 126.730781] postgres[1620]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 126.731350] postgres[1620]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 126.738312] postgres[1620]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 126.738907] postgres[1620]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.739239] postgres[1620]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.739547] postgres[1620]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.739859] postgres[1620]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.745472] postgres[1620]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.746385] postgres[1620]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.747002] postgres[1620]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.747597] postgres[1620]: END IF; vm-test-run-timescaledb> server # [ 126.754193] postgres[1620]: vm-test-run-timescaledb> server # [ 126.755206] postgres[1620]: END; vm-test-run-timescaledb> server # [ 126.755543] postgres[1620]: $func$; vm-test-run-timescaledb> server # [ 126.761493] postgres[1620]: ::1 2026-10-26 08:18:26.238 UTC [1620] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 126.770791] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1618]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.827746] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1618]: DROP EXTENSION vm-test-run-timescaledb> server # [ 128.355906] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1618]: DO vm-test-run-timescaledb> server # [ 128.410356] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-timescaledb> server # [ 129.537551] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1629]: DO vm-test-run-timescaledb> server # [ 130.098553] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1629]: DO vm-test-run-timescaledb> server # [ 130.141601] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-timescaledb> server # [ 130.369869] postgres[1652]: ::1 2026-10-26 08:18:29.843 UTC [1652] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 130.380197] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1651]: ALTER ROLE vm-test-run-timescaledb> server # [ 130.412633] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-timescaledb> server # [ 130.644681] postgres[1654]: ::1 2026-10-26 08:18:30.117 UTC [1654] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-timescaledb> server # [ 130.690235] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1653]: REVOKE ROLE vm-test-run-timescaledb> server # [ 130.702042] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-timescaledb> server # [ 132.953303] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1655]: DO vm-test-run-timescaledb> server # [ 133.001693] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 133.283226] postgres[1686]: ::1 2026-10-26 08:18:32.754 UTC [1686] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-timescaledb> server # [ 133.321608] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1685]: GRANT ROLE vm-test-run-timescaledb> server # [ 133.344407] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-timescaledb> server # [ 133.577211] postgres[1688]: ::1 2026-10-26 08:18:33.044 UTC [1688] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 133.611261] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1687]: GRANT vm-test-run-timescaledb> server # [ 133.614362] postgres[1688]: ::1 2026-10-26 08:18:33.079 UTC [1688] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 133.631246] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1687]: GRANT vm-test-run-timescaledb> server # [ 133.634653] postgres[1688]: ::1 2026-10-26 08:18:33.112 UTC [1688] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 133.638362] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1687]: GRANT vm-test-run-timescaledb> server # [ 133.641143] postgres[1688]: ::1 2026-10-26 08:18:33.117 UTC [1688] 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 # [ 133.656017] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1687]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.661594] postgres[1688]: ::1 2026-10-26 08:18:33.139 UTC [1688] 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 # [ 133.672973] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1687]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.678144] postgres[1688]: ::1 2026-10-26 08:18:33.156 UTC [1688] 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 # [ 133.692782] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1687]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.714860] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-timescaledb> server # [ 133.982534] postgres[1690]: ::1 2026-10-26 08:18:33.450 UTC [1690] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-timescaledb> server # [ 133.992014] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1689]: GRANT ROLE vm-test-run-timescaledb> server # [ 134.042868] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 134.406652] postgres[1696]: ::1 2026-10-26 08:18:33.875 UTC [1696] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-timescaledb> server # [ 134.452244] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1691]: GRANT ROLE vm-test-run-timescaledb> server # [ 134.481347] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-timescaledb> server # [ 134.855394] postgres[1711]: ::1 2026-10-26 08:18:34.332 UTC [1711] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-timescaledb> server # [ 134.889860] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1702]: ALTER ROLE vm-test-run-timescaledb> server # [ 134.902694] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1702]: ALTER ROLE vm-test-run-timescaledb> server # [ 134.904275] postgres[1711]: ::1 2026-10-26 08:18:34.366 UTC [1711] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-timescaledb> server # [ 134.917803] postgres[1711]: ::1 2026-10-26 08:18:34.378 UTC [1711] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-timescaledb> server # [ 134.923503] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1702]: ALTER ROLE vm-test-run-timescaledb> server # [ 134.959614] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1702]: DO vm-test-run-timescaledb> server # [ 135.002114] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 135.381765] postgres[1719]: ::1 2026-10-26 08:18:34.849 UTC [1719] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-timescaledb> server # [ 135.398784] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1715]: GRANT ROLE vm-test-run-timescaledb> server # [ 135.404172] postgres[1719]: ::1 2026-10-26 08:18:34.874 UTC [1719] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-timescaledb> server # [ 135.417505] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1715]: REVOKE ROLE vm-test-run-timescaledb> server # [ 135.455311] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-timescaledb> server # [ 135.730019] postgres[1722]: ::1 2026-10-26 08:18:35.206 UTC [1722] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 135.733236] postgres[1722]: returns event_trigger vm-test-run-timescaledb> server # [ 135.734371] postgres[1722]: language plpgsql vm-test-run-timescaledb> server # [ 135.734938] postgres[1722]: AS $func$ vm-test-run-timescaledb> server # [ 135.735504] postgres[1722]: DECLARE vm-test-run-timescaledb> server # [ 135.735958] postgres[1722]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 135.737351] postgres[1722]: BEGIN vm-test-run-timescaledb> server # [ 135.737908] postgres[1722]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 135.738669] postgres[1722]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 135.739152] postgres[1722]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 135.740934] postgres[1722]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 135.741859] postgres[1722]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 135.742852] postgres[1722]: ); vm-test-run-timescaledb> server # [ 135.743978] postgres[1722]: vm-test-run-timescaledb> server # [ 135.745113] postgres[1722]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 135.745729] postgres[1722]: THEN vm-test-run-timescaledb> server # [ 135.745988] postgres[1722]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 135.746877] postgres[1722]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 135.747364] postgres[1722]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 135.747727] postgres[1722]: "operationName" text default null, vm-test-run-timescaledb> server # [ 135.748000] postgres[1722]: query text default null, vm-test-run-timescaledb> server # [ 135.748390] postgres[1722]: variables jsonb default null, vm-test-run-timescaledb> server # [ 135.749376] postgres[1722]: extensions jsonb default null vm-test-run-timescaledb> server # [ 135.750234] postgres[1722]: ) vm-test-run-timescaledb> server # [ 135.750650] postgres[1722]: returns jsonb vm-test-run-timescaledb> server # [ 135.751203] postgres[1722]: language sql vm-test-run-timescaledb> server # [ 135.751486] postgres[1722]: as $$ vm-test-run-timescaledb> server # [ 135.753219] postgres[1722]: select graphql.resolve( vm-test-run-timescaledb> server # [ 135.753858] postgres[1722]: query := query, vm-test-run-timescaledb> server # [ 135.755485] postgres[1722]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 135.756050] postgres[1722]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 135.757310] postgres[1722]: extensions := extensions vm-test-run-timescaledb> server # [ 135.757916] postgres[1722]: ); vm-test-run-timescaledb> server # [ 135.758690] postgres[1722]: $$; vm-test-run-timescaledb> server # [ 135.759780] postgres[1722]: vm-test-run-timescaledb> server # [ 135.761498] postgres[1722]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 135.762434] postgres[1722]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 135.762841] postgres[1722]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 135.763192] postgres[1722]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.763671] postgres[1722]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.765113] postgres[1722]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.765902] postgres[1722]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.766960] postgres[1722]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.769131] postgres[1722]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.769814] postgres[1722]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.770217] postgres[1722]: vm-test-run-timescaledb> server # [ 135.770622] postgres[1722]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-timescaledb> server # [ 135.771360] postgres[1722]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-timescaledb> server # [ 135.772934] postgres[1722]: grant usage on schema graphql to postgres with grant option; vm-test-run-timescaledb> server # [ 135.773651] postgres[1722]: END IF; vm-test-run-timescaledb> server # [ 135.774296] postgres[1722]: vm-test-run-timescaledb> server # [ 135.774946] postgres[1722]: END; vm-test-run-timescaledb> server # [ 135.775283] postgres[1722]: $func$; vm-test-run-timescaledb> server # [ 135.815286] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1721]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 135.825286] postgres[1722]: ::1 2026-10-26 08:18:35.297 UTC [1722] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 135.874227] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1721]: DROP EXTENSION vm-test-run-timescaledb> server # [ 137.526923] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1721]: DO vm-test-run-timescaledb> server # [ 137.574888] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-timescaledb> server # [ 137.900369] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1736]: DO vm-test-run-timescaledb> server # [ 137.915804] postgres[1744]: ::1 2026-10-26 08:18:37.378 UTC [1744] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-timescaledb> server # [ 137.917912] postgres[1744]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 137.918984] postgres[1744]: AS $$ vm-test-run-timescaledb> server # [ 137.919535] postgres[1744]: BEGIN vm-test-run-timescaledb> server # [ 137.925216] postgres[1744]: IF EXISTS ( vm-test-run-timescaledb> server # [ 137.926334] postgres[1744]: SELECT vm-test-run-timescaledb> server # [ 137.926654] postgres[1744]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 137.926922] postgres[1744]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 137.927768] postgres[1744]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 137.928255] postgres[1744]: WHERE ext.extname = 'pg_cron' vm-test-run-timescaledb> server # [ 137.933494] postgres[1744]: ) vm-test-run-timescaledb> server # [ 137.933927] postgres[1744]: THEN vm-test-run-timescaledb> server # [ 137.934179] postgres[1744]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 137.934853] postgres[1744]: vm-test-run-timescaledb> server # [ 137.935823] postgres[1744]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 137.936206] postgres[1744]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 137.939468] postgres[1744]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 137.941159] postgres[1744]: vm-test-run-timescaledb> server # [ 137.941588] postgres[1744]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 137.942750] postgres[1744]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 137.943753] postgres[1744]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 137.951394] postgres[1744]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 137.952185] postgres[1744]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 137.958354] postgres[1744]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 137.958832] postgres[1744]: vm-test-run-timescaledb> server # [ 137.959109] postgres[1744]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 137.959411] postgres[1744]: revoke all on table cron.job from postgres; vm-test-run-timescaledb> server # [ 137.959677] postgres[1744]: grant select on table cron.job to postgres with grant option; vm-test-run-timescaledb> server # [ 137.959940] postgres[1744]: END IF; vm-test-run-timescaledb> server # [ 137.964679] postgres[1744]: END; vm-test-run-timescaledb> server # [ 137.965718] postgres[1744]: $$; vm-test-run-timescaledb> server # [ 137.979187] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1736]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 137.980104] postgres[1744]: ::1 2026-10-26 08:18:37.459 UTC [1744] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-timescaledb> server # [ 137.995549] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1736]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 138.001771] postgres[1744]: ::1 2026-10-26 08:18:37.476 UTC [1744] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-timescaledb> server # [ 138.006129] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1736]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 138.013002] postgres[1744]: ::1 2026-10-26 08:18:37.490 UTC [1744] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-timescaledb> server # [ 138.014611] postgres[1744]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-timescaledb> server # [ 138.015308] postgres[1744]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 138.025371] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1736]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 138.071787] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-timescaledb> server # [ 138.404981] postgres[1752]: ::1 2026-10-26 08:18:37.877 UTC [1752] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-timescaledb> server # [ 138.435325] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1749]: ALTER ROLE vm-test-run-timescaledb> server # [ 138.487807] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-timescaledb> server # [ 138.894342] postgres[1756]: ::1 2026-10-26 08:18:38.366 UTC [1756] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-timescaledb> server # [ 138.926210] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1754]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 138.927529] postgres[1756]: ::1 2026-10-26 08:18:38.399 UTC [1756] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-timescaledb> server # [ 138.942859] postgres[1756]: ::1 2026-10-26 08:18:38.418 UTC [1756] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-timescaledb> server # [ 138.946622] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1754]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 138.950372] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1754]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 139.012421] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 139.242597] postgres[1758]: ::1 2026-10-26 08:18:38.713 UTC [1758] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-timescaledb> server # [ 139.266120] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1757]: GRANT ROLE vm-test-run-timescaledb> server # [ 139.295671] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-timescaledb> server # [ 140.022285] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1759]: DO vm-test-run-timescaledb> server # [ 140.071703] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-timescaledb> server # [ 140.692405] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1763]: DO vm-test-run-timescaledb> server # [ 140.703746] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1763]: DO vm-test-run-timescaledb> server # [ 140.750723] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-timescaledb> server # [ 141.265949] postgres[1779]: ::1 2026-10-26 08:18:40.731 UTC [1779] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-timescaledb> server # [ 141.294625] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1773]: ALTER ROLE vm-test-run-timescaledb> server # [ 141.301685] postgres[1779]: ::1 2026-10-26 08:18:40.758 UTC [1779] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-timescaledb> server # [ 141.305468] postgres[1779]: ::1 2026-10-26 08:18:40.767 UTC [1779] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-timescaledb> server # [ 141.316594] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1773]: ALTER ROLE vm-test-run-timescaledb> server # [ 141.327198] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1773]: ALTER ROLE vm-test-run-timescaledb> server # [ 141.389386] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-timescaledb> server # [ 141.795271] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1786]: DO vm-test-run-timescaledb> server # [ 141.825359] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-timescaledb> server # [ 142.261252] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1791]: DO vm-test-run-timescaledb> server # [ 142.292973] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-timescaledb> server # [ 142.723321] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1797]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 142.730565] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1797]: DO vm-test-run-timescaledb> server # [ 142.781591] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-timescaledb> server # [ 143.037270] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1799]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 143.053017] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1799]: GRANT vm-test-run-timescaledb> server # [ 143.094827] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-timescaledb> server # [ 143.381821] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1801]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 143.445259] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1801]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 143.470568] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1801]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 143.525215] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 144.047185] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1808]: DO vm-test-run-timescaledb> server # [ 144.073982] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-timescaledb> server # [ 144.563475] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1822]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 144.579347] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1822]: GRANT vm-test-run-timescaledb> server # [ 144.611118] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-timescaledb> server # [ 144.944215] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1829]: REVOKE ROLE vm-test-run-timescaledb> server # [ 144.981107] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1829]: DO vm-test-run-timescaledb> server # [ 144.995643] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1829]: DO vm-test-run-timescaledb> server # [ 145.011320] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1829]: REVOKE ROLE vm-test-run-timescaledb> server # [ 145.037545] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1829]: REVOKE vm-test-run-timescaledb> server # [ 145.059587] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1829]: DO vm-test-run-timescaledb> server # [ 145.099791] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 145.345060] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1833]: DO vm-test-run-timescaledb> server # [ 145.375717] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 145.739808] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1835]: DO vm-test-run-timescaledb> server # [ 145.771671] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 146.131337] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1840]: DO vm-test-run-timescaledb> server # [ 146.206406] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-timescaledb> server # [ 146.718840] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1843]: ALTER ROLE vm-test-run-timescaledb> server # [ 146.761898] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-timescaledb> server # [ 147.180398] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1854]: GRANT ROLE vm-test-run-timescaledb> server # [ 147.225070] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1854]: DO vm-test-run-timescaledb> server # [ 147.291527] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-timescaledb> server # [ 147.768977] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1864]: GRANT vm-test-run-timescaledb> server # [ 147.771439] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-timescaledb> server # [ 148.222112] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1872]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 148.247363] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1872]: REVOKE vm-test-run-timescaledb> server # [ 148.266614] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1872]: REVOKE vm-test-run-timescaledb> server # [ 148.287873] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1872]: GRANT vm-test-run-timescaledb> server # [ 148.345526] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-timescaledb> server # [ 148.606693] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1875]: DO vm-test-run-timescaledb> server # [ 148.649601] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-timescaledb> server # [ 148.907947] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1877]: ALTER ROLE vm-test-run-timescaledb> server # [ 148.952667] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-timescaledb> server # [ 149.298735] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1879]: DROP EXTENSION vm-test-run-timescaledb> server # [ 149.347793] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-timescaledb> server # [ 149.851801] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1881]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 149.873242] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1881]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 149.874770] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1881]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 149.920899] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-timescaledb> server # [ 150.358292] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1895]: DO vm-test-run-timescaledb> server # [ 150.382350] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1895]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 150.423952] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-timescaledb> server # [ 150.846693] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1902]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 150.852926] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1902]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 150.902282] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20261010094800_postgres-role-safeupdate.sql vm-test-run-timescaledb> server # [ 151.185011] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1911]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.192215] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1911]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.238784] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running migration: /nix/store/0h06lb1vwg7w4iaf821szsr0lqxw1zd1-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql vm-test-run-timescaledb> server # [ 151.719406] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1913]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 151.746849] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1913]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 151.767160] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1913]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 151.790927] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1913]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 151.807547] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1913]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 151.826417] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1913]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 151.887152] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Running postgresql schema... vm-test-run-timescaledb> server # [ 152.187051] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER DATABASE vm-test-run-timescaledb> server # [ 152.192947] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER DATABASE vm-test-run-timescaledb> server # [ 152.274426] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.331746] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.390580] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.450239] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.514862] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.665506] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.834043] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.962838] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER ROLE vm-test-run-timescaledb> server # [ 153.086028] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER ROLE vm-test-run-timescaledb> server # [ 153.098803] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1919]: ALTER ROLE vm-test-run-timescaledb> server # [ 153.164009] wbxv9r0w3dh2qwz0apw5nxws551l578d-supabase-db-init[1408]: Database initialization complete vm-test-run-timescaledb> server # [ 153.205824] systemd[1]: Finished Supabase Database Initialization. vm-test-run-timescaledb> server # [ 153.226106] systemd[1]: Reached target Multi-User System. vm-test-run-timescaledb> server # [ 153.233519] systemd[1]: Startup finished in 19.649s (kernel) + 2min 13.579s (userspace) = 2min 33.228s. vm-test-run-timescaledb> server: (finished: waiting for unit supabase-db-init.service, in 154.91 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 # [ 154.449733] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 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.54 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 # [ 160.626247] postgres[1955]: [local] 2026-10-26 08:19:00.092 UTC [1955] supabase_admin@postgres WARNING: vm-test-run-timescaledb> server # [ 160.639581] postgres[1955]: WELCOME TO vm-test-run-timescaledb> server # [ 160.644131] postgres[1955]: _____ _ _ ____________ vm-test-run-timescaledb> server # [ 160.650158] postgres[1955]: |_ _(_) | | | _ \ ___ \ vm-test-run-timescaledb> server # [ 160.651399] postgres[1955]: | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ / vm-test-run-timescaledb> server # [ 160.652065] postgres[1955]: | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \ vm-test-run-timescaledb> server # [ 160.658100] postgres[1955]: | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ / vm-test-run-timescaledb> server # [ 160.661538] postgres[1955]: |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/ vm-test-run-timescaledb> server # [ 160.662596] postgres[1955]: Running version 2.9.1 vm-test-run-timescaledb> server # [ 160.663579] postgres[1955]: For more information on TimescaleDB, please visit the following links: vm-test-run-timescaledb> server # [ 160.665066] postgres[1955]: vm-test-run-timescaledb> server # [ 160.666061] postgres[1955]: 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started vm-test-run-timescaledb> server # [ 160.666794] postgres[1955]: 2. API reference documentation: https://docs.timescale.com/api/latest vm-test-run-timescaledb> server # [ 160.667427] postgres[1955]: 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts vm-test-run-timescaledb> server # [ 160.669525] postgres[1955]: vm-test-run-timescaledb> server # [ 160.671883] postgres[1955]: 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 # [ 160.674898] postgres[1955]: vm-test-run-timescaledb> server # [ 160.675301] postgres[1955]: [local] 2026-10-26 08:19:00.092 UTC [1955] 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.33 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 # [ 161.142904] postgres[2000]: 2026-10-26 08:19:00.608 UTC [2000] LOG: job 2 threw an error vm-test-run-timescaledb> server # [ 161.167078] postgres[2000]: 2026-10-26 08:19:00.643 UTC [2000] ERROR: functionality not supported under the current "apache" license vm-test-run-timescaledb> server # [ 161.174581] postgres[2000]: 2026-10-26 08:19:00.643 UTC [2000] HINT: Upgrade your license to 'timescale' to use this free community feature. vm-test-run-timescaledb> server # [ 161.229408] postgres[1360]: 2026-10-26 08:19:00.694 UTC [1360] LOG: background worker "Error Log Retention Policy [2]" (PID 2000) 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.66 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 # [ 162.611528] postgres[1996]: 2026-10-26 08:19:02.088 UTC [1996] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 162.687217] postgres[1360]: 2026-10-26 08:19:02.152 UTC [1360] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 1996) exited with exit code 1 vm-test-run-timescaledb> server # [ 163.503314] systemd[1]: Starting Virtual Console Setup... vm-test-run-timescaledb> server # [ 163.722772] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 163.738184] systemd[1]: Stopped Virtual Console Setup. vm-test-run-timescaledb> server # [ 163.775252] systemd[1]: Starting Virtual Console Setup... vm-test-run-timescaledb> server # [ 165.103875] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-timescaledb> server # [ 168.250692] systemd[1]: Finished Virtual Console Setup. vm-test-run-timescaledb> server # [ 169.648645] systemd-logind[653]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-timescaledb> server # [ 171.515838] postgres[2026]: 2026-10-26 08:19:10.981 UTC [2026] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 171.536125] postgres[1360]: 2026-10-26 08:19:11.012 UTC [1360] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2026) 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 10.38 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 # [ 171.982637] postgres[2075]: 2026-10-26 08:19:11.458 UTC [2075] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 171.984842] postgres[2075]: 2026-10-26 08:19:11.464 UTC [2075] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 171.987978] postgres[2075]: 2026-10-26 08:19:11.464 UTC [2075] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 172.037094] postgres[1360]: 2026-10-26 08:19:11.515 UTC [1360] LOG: background worker "Job History Log Retention Policy [3]" (PID 2075) 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.46 seconds) vm-test-run-timescaledb> (finished: subtest: Check upgrade path with postgresql 15, in 18.36 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 # [ 172.610354] postgres[2072]: 2026-10-26 08:19:12.079 UTC [2072] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 172.638985] postgres[1360]: 2026-10-26 08:19:12.107 UTC [1360] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2072) exited with exit code 1 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.94 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: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" , in 3.51 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 # [ 176.998858] postgres[2091]: 2026-10-26 08:19:16.473 UTC [2091] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 177.002372] postgres[2091]: 2026-10-26 08:19:16.480 UTC [2091] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 177.005106] postgres[2091]: 2026-10-26 08:19:16.480 UTC [2091] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 177.047455] postgres[1360]: 2026-10-26 08:19:16.522 UTC [1360] LOG: background worker "Job History Log Retention Policy [3]" (PID 2091) 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.49 seconds) vm-test-run-timescaledb> (finished: subtest: Check the install of the last version of the extension, in 4.94 seconds) vm-test-run-timescaledb> (finished: run the VM test script, in 178.35 seconds) vm-test-run-timescaledb> test script finished in 178.70s 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