these 2 derivations will be built: /nix/store/m09g2c31phj5k1yrm2086r59ra8zq5qz-nixos-test-driver-timescaledb.drv /nix/store/vgsg6bb34qblzilh8rj7mjaykgvjxp4b-vm-test-run-timescaledb.drv building '/nix/store/m09g2c31phj5k1yrm2086r59ra8zq5qz-nixos-test-driver-timescaledb.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/m09g2c31phj5k1yrm2086r59ra8zq5qz-nixos-test-driver-timescaledb.drv' nixos-test-driver-timescaledb> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-timescaledb> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-timescaledb> Success: no issues found in 1 source file nixos-test-driver-timescaledb> additionally exposed symbols: nixos-test-driver-timescaledb> , nixos-test-driver-timescaledb> , nixos-test-driver-timescaledb> start_all, test_script, machines, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, Machine, t, debug nixos-test-driver-timescaledb> Linting test script (enable/disable: config.skipLint) nixos-test-driver-timescaledb> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint building '/nix/store/vgsg6bb34qblzilh8rj7mjaykgvjxp4b-vm-test-run-timescaledb.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/vgsg6bb34qblzilh8rj7mjaykgvjxp4b-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.lUIwBpArUg', 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: edf7ce55-082f-4d35-9851-6c98296db111 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/w906mgc98ra5f5y3dl60b2xgvy3kp747-nixos-system-server-test/init regInfo=/nix/store/14v3598wf88wsgcgcl8rjn85qd0xgwgy-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-timescaledb> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/14v3598wf88wsgcgcl8rjn85qd0xgwgy-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.004236] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-timescaledb> server # [ 0.014923] Console: colour dummy device 80x25 vm-test-run-timescaledb> server # [ 0.016407] printk: legacy console [tty0] enabled vm-test-run-timescaledb> server # [ 0.022275] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-timescaledb> server # [ 0.022891] pid_max: default: 32768 minimum: 301 vm-test-run-timescaledb> server # [ 0.025778] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-timescaledb> server # [ 0.027481] landlock: Up and running. vm-test-run-timescaledb> server # [ 0.027532] Yama: becoming mindful. vm-test-run-timescaledb> server # [ 0.032023] LSM support for eBPF active vm-test-run-timescaledb> server # [ 0.035686] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.035824] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.067455] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-timescaledb> server # [ 0.079936] rcu: Hierarchical SRCU implementation. vm-test-run-timescaledb> server # [ 0.080044] rcu: Max phase no-delay instances is 1000. vm-test-run-timescaledb> server # [ 0.081504] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-timescaledb> server # [ 0.089530] fsl-mc MSI: its@8080000 domain created vm-test-run-timescaledb> server # [ 0.091762] EFI services will not be available. vm-test-run-timescaledb> server # [ 0.093974] smp: Bringing up secondary CPUs ... vm-test-run-timescaledb> server # [ 0.098393] Detected PIPT I-cache on CPU1 vm-test-run-timescaledb> server # [ 0.099714] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-timescaledb> server # [ 0.100374] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000 vm-test-run-timescaledb> server # [ 0.101989] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-timescaledb> server # [ 0.105660] smp: Brought up 1 node, 2 CPUs vm-test-run-timescaledb> server # [ 0.105793] SMP: Total of 2 processors activated. vm-test-run-timescaledb> server # [ 0.105838] CPU: All CPU(s) started at EL1 vm-test-run-timescaledb> server # [ 0.106002] CPU features: detected: Branch Target Identification vm-test-run-timescaledb> server # [ 0.106060] CPU features: detected: 32-bit EL0 Support vm-test-run-timescaledb> server # [ 0.106091] CPU features: detected: 32-bit EL1 Support vm-test-run-timescaledb> server # [ 0.106117] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-timescaledb> server # [ 0.106151] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-timescaledb> server # [ 0.106194] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-timescaledb> server # [ 0.106265] CPU features: detected: Common not Private translations vm-test-run-timescaledb> server # [ 0.106294] CPU features: detected: CRC32 instructions vm-test-run-timescaledb> server # [ 0.106316] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-timescaledb> server # [ 0.106348] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-timescaledb> server # [ 0.106375] CPU features: detected: Data independent timing control (DIT) vm-test-run-timescaledb> server # [ 0.106462] CPU features: detected: E0PD vm-test-run-timescaledb> server # [ 0.106592] CPU features: detected: Enhanced Counter Virtualization vm-test-run-timescaledb> server # [ 0.106625] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-timescaledb> server # [ 0.106656] CPU features: detected: Enhanced Privileged Access Never vm-test-run-timescaledb> server # [ 0.106685] CPU features: detected: Enhanced Virtualization Traps vm-test-run-timescaledb> server # [ 0.106712] CPU features: detected: Fine Grained Traps vm-test-run-timescaledb> server # [ 0.106779] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.106874] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-timescaledb> server # [ 0.106926] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-timescaledb> server # [ 0.106951] CPU features: detected: LSE atomic instructions vm-test-run-timescaledb> server # [ 0.106972] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-timescaledb> server # [ 0.106996] CPU features: detected: Privileged Access Never vm-test-run-timescaledb> server # [ 0.107017] CPU features: detected: RAS Extension Support vm-test-run-timescaledb> server # [ 0.107039] CPU features: detected: Random Number Generator vm-test-run-timescaledb> server # [ 0.107065] CPU features: detected: Speculation barrier (SB) vm-test-run-timescaledb> server # [ 0.107089] CPU features: detected: Stage-2 Force Write-Back vm-test-run-timescaledb> server # [ 0.107114] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-timescaledb> server # [ 0.107145] CPU features: detected: TLB range maintenance instructions vm-test-run-timescaledb> server # [ 0.107172] CPU features: detected: WFx with timeout vm-test-run-timescaledb> server # [ 0.107219] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-timescaledb> server # [ 0.107248] CPU features: detected: Scalable Vector Extension vm-test-run-timescaledb> server # [ 0.116284] alternatives: applying system-wide alternatives vm-test-run-timescaledb> server # [ 0.132955] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-timescaledb> server # [ 0.133731] SVE: maximum available vector length 256 bytes per vector vm-test-run-timescaledb> server # [ 0.133831] SVE: default vector length 64 bytes per vector vm-test-run-timescaledb> server # [ 0.146898] Memory: 3922824K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-timescaledb> server # [ 0.168733] devtmpfs: initialized vm-test-run-timescaledb> server # [ 0.198349] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-timescaledb> server # [ 0.199001] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.201586] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-timescaledb> server # [ 0.201661] 0 pages in range for non-PLT usage vm-test-run-timescaledb> server # [ 0.201702] 509248 pages in range for PLT usage vm-test-run-timescaledb> server # [ 0.205750] pinctrl core: initialized pinctrl subsystem vm-test-run-timescaledb> server # [ 0.218279] DMI not present or invalid. vm-test-run-timescaledb> server # [ 0.239228] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-timescaledb> server # [ 0.251162] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-timescaledb> server # [ 0.252408] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-timescaledb> server # [ 0.253640] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-timescaledb> server # [ 0.253939] audit: initializing netlink subsys (disabled) vm-test-run-timescaledb> server # [ 0.256403] audit: type=2000 audit(0.208:1): state=initialized audit_enabled=0 res=1 vm-test-run-timescaledb> server # [ 0.263333] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-timescaledb> server # [ 0.263392] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-timescaledb> server # [ 0.263453] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-timescaledb> server # [ 0.263487] thermal_sys: Registered thermal governor 'user_space' vm-test-run-timescaledb> server # [ 0.263517] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-timescaledb> server # [ 0.264371] cpuidle: using governor ladder vm-test-run-timescaledb> server # [ 0.264844] cpuidle: using governor menu vm-test-run-timescaledb> server # [ 0.267040] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-timescaledb> server # [ 0.268560] ASID allocator initialised with 65536 entries vm-test-run-timescaledb> server # [ 0.276083] Serial: AMBA PL011 UART driver vm-test-run-timescaledb> server # [ 0.330380] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-timescaledb> server # [ 0.331891] printk: legacy console [ttyAMA0] enabled vm-test-run-timescaledb> server # [ 0.375872] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.376392] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-timescaledb> server # [ 0.377127] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.377368] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-timescaledb> server # [ 0.377542] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.377646] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-timescaledb> server # [ 0.377918] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.378018] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-timescaledb> server # [ 0.394998] fbcon: Taking over console vm-test-run-timescaledb> server # [ 0.396206] ACPI: Interpreter disabled. vm-test-run-timescaledb> server # [ 0.403629] iommu: Default domain type: Translated vm-test-run-timescaledb> server # [ 0.403825] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-timescaledb> server # [ 0.413649] SCSI subsystem initialized vm-test-run-timescaledb> server # [ 0.416890] usbcore: registered new interface driver usbfs vm-test-run-timescaledb> server # [ 0.417235] usbcore: registered new interface driver hub vm-test-run-timescaledb> server # [ 0.417439] usbcore: registered new device driver usb vm-test-run-timescaledb> server # [ 0.420015] pps_core: LinuxPPS API ver. 1 registered vm-test-run-timescaledb> server # [ 0.420179] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-timescaledb> server # [ 0.420797] PTP clock support registered vm-test-run-timescaledb> server # [ 0.421554] EDAC MC: Ver: 3.0.0 vm-test-run-timescaledb> server # [ 0.423468] scmi_core: SCMI protocol bus registered vm-test-run-timescaledb> server # [ 0.427054] FPGA manager framework vm-test-run-timescaledb> server # [ 0.428193] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-timescaledb> server # [ 0.436870] vgaarb: loaded vm-test-run-timescaledb> server # [ 0.440942] clocksource: Switched to clocksource arch_sys_counter vm-test-run-timescaledb> server # [ 0.444830] VFS: Disk quotas dquot_6.6.0 vm-test-run-timescaledb> server # [ 0.445065] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-timescaledb> server # [ 0.450623] netfs: FS-Cache loaded vm-test-run-timescaledb> server # [ 0.451776] pnp: PnP ACPI: disabled vm-test-run-timescaledb> server # [ 0.478363] NET: Registered PF_INET protocol family vm-test-run-timescaledb> server # [ 0.479770] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-timescaledb> server # [ 0.596480] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.596876] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.597190] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.599053] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-timescaledb> server # [ 0.599768] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-timescaledb> server # [ 0.601109] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-timescaledb> server # [ 0.601520] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.602242] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.603810] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-timescaledb> server # [ 0.604314] NET: Registered PF_XDP protocol family vm-test-run-timescaledb> server # [ 0.604570] PCI: CLS 0 bytes, default 64 vm-test-run-timescaledb> server # [ 0.607380] kvm [1]: HYP mode not available vm-test-run-timescaledb> server # [ 0.608652] Trying to unpack rootfs image as initramfs... vm-test-run-timescaledb> server # [ 0.721555] Initialise system trusted keyrings vm-test-run-timescaledb> server # [ 0.723609] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-timescaledb> server # [ 0.729430] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-timescaledb> server # [ 0.730246] 9p: Installing v9fs 9p2000 file system support vm-test-run-timescaledb> server # [ 0.792664] Key type asymmetric registered vm-test-run-timescaledb> server # [ 0.792899] Asymmetric key parser 'x509' registered vm-test-run-timescaledb> server # [ 0.793982] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-timescaledb> server # [ 0.795186] io scheduler mq-deadline registered vm-test-run-timescaledb> server # [ 0.795425] io scheduler kyber registered vm-test-run-timescaledb> server # [ 0.823309] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-timescaledb> server # [ 0.827823] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-timescaledb> server # [ 0.831638] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-timescaledb> server # [ 0.832268] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-timescaledb> server # [ 0.832774] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-timescaledb> server # [ 0.832959] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-timescaledb> server # [ 0.833443] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-timescaledb> server # [ 0.833958] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-timescaledb> server # [ 0.835959] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-timescaledb> server # [ 0.836378] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-timescaledb> server # [ 0.837168] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.837996] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.838123] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.839549] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.844228] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.844714] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.844844] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.844978] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.845710] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.846962] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.847511] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.847775] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.847908] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.848484] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.848642] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.848741] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.848859] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.849769] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.850285] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.850393] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.850822] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.851329] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.851481] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.851578] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.851692] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.852125] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.852267] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-timescaledb> server # [ 0.852360] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.852468] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.852863] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.853005] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.853097] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.853209] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.853317] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.854782] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.854974] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.855102] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.855561] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.855713] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.855827] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.856376] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.856531] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.856949] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.859515] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.859823] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.859951] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.860483] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.860689] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.860785] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.860908] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.863624] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.863968] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.864170] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.864387] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.864688] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.865962] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.866178] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.866334] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.866479] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.866899] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.867051] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.867185] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.867494] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.867642] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-timescaledb> server # [ 0.867764] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-timescaledb> server # [ 0.867951] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-timescaledb> server # [ 0.868186] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-timescaledb> server # [ 0.868312] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-timescaledb> server # [ 0.868710] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-timescaledb> server # [ 0.869109] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-timescaledb> server # [ 0.869304] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-timescaledb> server # [ 0.869834] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-timescaledb> server # [ 0.870914] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-timescaledb> server # [ 0.871407] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-timescaledb> server # [ 0.871728] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-timescaledb> server # [ 0.871855] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-timescaledb> server # [ 0.871985] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-timescaledb> server # [ 0.872091] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-timescaledb> server # [ 0.872190] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-timescaledb> server # [ 0.872290] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-timescaledb> server # [ 0.872387] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-timescaledb> server # [ 0.872490] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-timescaledb> server # [ 0.872592] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-timescaledb> server # [ 0.872690] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-timescaledb> server # [ 0.873000] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.873175] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.873522] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.874886] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.940317] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.947015] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.950062] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.956056] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.959018] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.961811] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.963830] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.968068] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.971450] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.975681] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.979602] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.998273] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-timescaledb> server # [ 1.009102] msm_serial: driver initialized vm-test-run-timescaledb> server # [ 1.011254] SuperH (H)SCI(F) driver initialized vm-test-run-timescaledb> server # [ 1.012262] STM32 USART driver initialized vm-test-run-timescaledb> server # [ 1.067224] loop: module loaded vm-test-run-timescaledb> server # [ 1.068303] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-timescaledb> server # [ 1.071945] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-timescaledb> server # [ 1.085204] megasas: 07.727.03.00-rc1 vm-test-run-timescaledb> server # [ 1.091689] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-timescaledb> server # [ 1.094607] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 1.095071] Freeing initrd memory: 10684K vm-test-run-timescaledb> server # [ 1.095377] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 1.097426] Using buffer write method vm-test-run-timescaledb> server # [ 1.099195] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-timescaledb> server # [ 1.100653] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 1.101730] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 1.103926] Using buffer write method vm-test-run-timescaledb> server # [ 1.104214] Concatenating MTD devices: vm-test-run-timescaledb> server # [ 1.104441] (0): "0.flash" vm-test-run-timescaledb> server # [ 1.104929] (1): "0.flash" vm-test-run-timescaledb> server # [ 1.105001] into device "0.flash" vm-test-run-timescaledb> server # [ 1.129528] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-timescaledb> server # [ 1.143374] thunder_xcv, ver 1.0 vm-test-run-timescaledb> server # [ 1.143657] thunder_bgx, ver 1.0 vm-test-run-timescaledb> server # [ 1.144160] nicpf, ver 1.0 vm-test-run-timescaledb> server # [ 1.147428] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-timescaledb> server # [ 1.147821] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-timescaledb> server # [ 1.148224] hclge is initializing vm-test-run-timescaledb> server # [ 1.148546] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.148719] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-timescaledb> server # [ 1.148958] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.149058] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-timescaledb> server # [ 1.149663] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-timescaledb> server # [ 1.150428] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-timescaledb> server # [ 1.150739] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-timescaledb> server # [ 1.150979] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-timescaledb> server # [ 1.151743] sky2: driver version 1.30 vm-test-run-timescaledb> server # [ 1.159874] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-timescaledb> server # [ 1.162067] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-timescaledb> server # [ 1.162923] usbcore: registered new interface driver usb-storage vm-test-run-timescaledb> server # [ 1.163510] usbcore: registered new interface driver usbserial_generic vm-test-run-timescaledb> server # [ 1.163804] usbserial: USB Serial support registered for generic vm-test-run-timescaledb> server # [ 1.165481] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-timescaledb> server # [ 1.174977] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-timescaledb> server # [ 1.175605] rtc-pl031 9010000.pl031: setting system clock to 2026-10-20T20:53:46 UTC (1792529626) vm-test-run-timescaledb> server # [ 1.177483] i2c_dev: i2c /dev entries driver vm-test-run-timescaledb> server # [ 1.178968] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-timescaledb> server # [ 1.188122] hub 1-0:1.0: USB hub found vm-test-run-timescaledb> server # [ 1.188845] hub 1-0:1.0: 6 ports detected vm-test-run-timescaledb> server # [ 1.194089] sdhci: Secure Digital Host Controller Interface driver vm-test-run-timescaledb> server # [ 1.194247] sdhci: Copyright(c) Pierre Ossman vm-test-run-timescaledb> server # [ 1.195654] Synopsys Designware Multimedia Card Interface Driver vm-test-run-timescaledb> server # [ 1.197960] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-timescaledb> server # [ 1.205290] hid: raw HID events driver (C) Jiri Kosina vm-test-run-timescaledb> server # [ 1.207558] usbcore: registered new interface driver usbhid vm-test-run-timescaledb> server # [ 1.207725] usbhid: USB HID core driver vm-test-run-timescaledb> server # [ 1.215743] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-timescaledb> server # [ 1.231116] drop_monitor: Initializing network drop monitor service vm-test-run-timescaledb> server # [ 1.232403] NET: Registered PF_INET6 protocol family vm-test-run-timescaledb> server # [ 1.248702] Segment Routing with IPv6 vm-test-run-timescaledb> server # [ 1.250202] In-situ OAM (IOAM) with IPv6 vm-test-run-timescaledb> server # [ 1.250948] NET: Registered PF_PACKET protocol family vm-test-run-timescaledb> server # [ 1.252704] 9pnet: Installing 9P2000 support vm-test-run-timescaledb> server # [ 1.258298] Key type dns_resolver registered vm-test-run-timescaledb> server # [ 1.296332] registered taskstats version 1 vm-test-run-timescaledb> server # [ 1.299525] Loading compiled-in X.509 certificates vm-test-run-timescaledb> server # [ 1.359911] Demotion targets for Node 0: null vm-test-run-timescaledb> server # [ 1.362465] Key type .fscrypt registered vm-test-run-timescaledb> server # [ 1.362729] Key type fscrypt-provisioning registered vm-test-run-timescaledb> server # [ 1.372713] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-timescaledb> server # [ 1.420635] clk: Disabling unused clocks vm-test-run-timescaledb> server # [ 1.421728] PM: genpd: Disabling unused power domains vm-test-run-timescaledb> server # [ 1.422081] ALSA device list: vm-test-run-timescaledb> server # [ 1.422197] No soundcards found. vm-test-run-timescaledb> server # [ 1.510159] Freeing unused kernel memory: 4416K vm-test-run-timescaledb> server # [ 1.511484] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-timescaledb> server # [ 1.513805] Run /init as init process vm-test-run-timescaledb> server # [ 1.711091] 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.857893] 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.980594] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-timescaledb> server # [ 2.159959] 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.162241] 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.179058] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-timescaledb> server # [ 2.308808] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-timescaledb> server # [ 2.309997] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-timescaledb> server # [ 2.310029] [drm] features: -context_init vm-test-run-timescaledb> server # [ 2.312156] [drm] number of scanouts: 1 vm-test-run-timescaledb> server # [ 2.312340] [drm] number of cap sets: 0 vm-test-run-timescaledb> server # [ 2.323389] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-timescaledb> server # [ 2.357491] Console: switching to colour frame buffer device 160x50 vm-test-run-timescaledb> server # [ 2.367120] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-timescaledb> server # [ 5.501929] EXT4-fs (vda): mounted filesystem edf7ce55-082f-4d35-9851-6c98296db111 r/w with ordered data mode. Quota mode: none. vm-test-run-timescaledb> server # [ 8.217873] EXT4-fs (vda): re-mounted edf7ce55-082f-4d35-9851-6c98296db111. vm-test-run-timescaledb> server # [ 8.236623] booting system configuration /nix/store/w906mgc98ra5f5y3dl60b2xgvy3kp747-nixos-system-server-test vm-test-run-timescaledb> server # [ 21.645520] 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 # [ 21.655642] systemd[1]: Detected virtualization qemu. vm-test-run-timescaledb> server # [ 21.660625] systemd[1]: Detected architecture arm64. vm-test-run-timescaledb> server # [ 21.665675] systemd[1]: Detected first boot. vm-test-run-timescaledb> server # [ 21.695551] systemd[1]: Initializing machine ID from random generator. vm-test-run-timescaledb> server # [ 21.728415] systemd[1]: Hostname set to . vm-test-run-timescaledb> server # [ 23.019734] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-timescaledb> server # [ 24.573955] systemd[1]: Applying preset policy. vm-test-run-timescaledb> server # [ 28.682298] 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 # [ 32.503946] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-timescaledb> server # [ 32.735403] systemd[1]: Created slice Slice /system/getty. vm-test-run-timescaledb> server # [ 32.750271] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-timescaledb> server # [ 32.763284] systemd[1]: Created slice User and Session Slice. vm-test-run-timescaledb> server # [ 32.772350] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-timescaledb> server # [ 32.779090] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-timescaledb> server # [ 32.784802] systemd[1]: Expecting device /dev/hvc0... vm-test-run-timescaledb> server # [ 32.790284] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-timescaledb> server # [ 32.794812] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-timescaledb> server # [ 32.799937] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-timescaledb> server # [ 32.806044] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-timescaledb> server # [ 32.810733] systemd[1]: Reached target Path Units. vm-test-run-timescaledb> server # [ 32.815570] systemd[1]: Reached target Remote File Systems. vm-test-run-timescaledb> server # [ 32.820522] systemd[1]: Reached target Slice Units. vm-test-run-timescaledb> server # [ 32.826094] systemd[1]: Reached target Swaps. vm-test-run-timescaledb> server # [ 32.861507] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-timescaledb> server # [ 32.887638] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-timescaledb> server # [ 32.899092] systemd[1]: Listening on Journal Audit Socket. vm-test-run-timescaledb> server # [ 32.906637] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-timescaledb> server # [ 32.912598] systemd[1]: Listening on Journal Sockets. vm-test-run-timescaledb> server # [ 32.920453] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-timescaledb> server # [ 32.925703] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 32.932308] systemd[1]: Listening on udev Control Socket. vm-test-run-timescaledb> server # [ 32.939262] systemd[1]: Listening on udev Kernel Socket. vm-test-run-timescaledb> server # [ 32.994281] systemd[1]: Mounting Huge Pages File System... vm-test-run-timescaledb> server # [ 33.034920] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-timescaledb> server # [ 33.078979] systemd[1]: Mounting Kernel Debug File System... vm-test-run-timescaledb> server # [ 33.124298] systemd[1]: Mounting Kernel Trace File System... vm-test-run-timescaledb> server # [ 33.249179] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-timescaledb> server # [ 33.363845] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-timescaledb> server # [ 33.383548] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-timescaledb> server # [ 33.483736] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-timescaledb> server # [ 33.512541] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-timescaledb> server # [ 33.557487] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-timescaledb> server # [ 33.696758] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-timescaledb> server # [ 33.716346] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-timescaledb> server # [ 33.727882] 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 # [ 33.876217] systemd[1]: Starting Journal Service... vm-test-run-timescaledb> server # [ 33.976681] systemd[1]: Starting Load Kernel Modules... vm-test-run-timescaledb> server # [ 34.071067] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-timescaledb> server # [ 34.132495] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-timescaledb> server # [ 34.143076] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 34.191376] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-timescaledb> server # [ 34.272529] systemd[1]: Mounted Huge Pages File System. vm-test-run-timescaledb> server # [ 34.284673] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-timescaledb> server # [ 34.300099] systemd[1]: Mounted Kernel Debug File System. vm-test-run-timescaledb> server # [ 34.312212] systemd[1]: Mounted Kernel Trace File System. vm-test-run-timescaledb> server # [ 34.334894] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-timescaledb> server # [ 34.341429] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-timescaledb> server # [ 34.442485] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-timescaledb> server # [ 34.962483] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 34.975763] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-timescaledb> server # [ 35.406347] EXT4-fs (vda): re-mounted edf7ce55-082f-4d35-9851-6c98296db111. vm-test-run-timescaledb> server # [ 35.461024] systemd[1]: Finished Load Kernel Modules. vm-test-run-timescaledb> server # [ 35.539961] systemd[1]: Starting Firewall... vm-test-run-timescaledb> server # [ 35.607996] systemd[1]: Starting Apply Kernel Variables... vm-test-run-timescaledb> server # [ 35.619468] fuse: init (API version 7.41) vm-test-run-timescaledb> server # [ 35.627801] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-timescaledb> server # [ 35.650437] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-timescaledb> server # [ 35.711498] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-timescaledb> server # [ 35.721738] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 35.775768] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 35.790406] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-timescaledb> server # [ 35.840007] systemd[1]: Mounting FUSE Control File System... vm-test-run-timescaledb> server # [ 35.870313] systemd-journald[396]: Collecting audit messages is enabled. vm-test-run-timescaledb> server # [ 36.108186] systemd[1]: Mounted FUSE Control File System. vm-test-run-timescaledb> server # [ 36.910756] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-timescaledb> server # [ 36.924547] systemd[1]: Reached target First Boot Complete. vm-test-run-timescaledb> server # [ 37.030971] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-timescaledb> server # [ 37.115028] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-timescaledb> server # [ 37.248357] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-timescaledb> server # [ 37.346328] systemd[1]: Finished Apply Kernel Variables. vm-test-run-timescaledb> server # [ 38.183644] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-timescaledb> server # [ 38.212208] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-timescaledb> server # [ 38.255737] systemd[1]: Mounting /run/wrappers... vm-test-run-timescaledb> server # [ 38.309607] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-timescaledb> server # [ 38.739902] systemd[1]: Mounted /run/wrappers. vm-test-run-timescaledb> server # [ 38.749503] systemd[1]: Reached target Local File Systems. vm-test-run-timescaledb> server # [ 38.783441] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-timescaledb> server # [ 38.836625] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-timescaledb> server # [ 38.843066] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-timescaledb> server # [ 38.891285] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-timescaledb> server # [ 38.929241] systemd[1]: Started Journal Service. vm-test-run-timescaledb> server # [ 38.883145] systemd-modules-load[397]: Module 'atkbd' is built in vm-test-run-timescaledb> server # [ 38.911673] systemd-modules-load[397]: Module 'loop' is built in vm-test-run-timescaledb> server # [ 38.948208] systemd-oomd[398]: No swap; memory pressure usage will be degraded vm-test-run-timescaledb> server # [ 39.020311] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-timescaledb> server # [ 39.891307] systemd-journald[396]: Received client request to flush runtime journal. vm-test-run-timescaledb> server # [ 40.280397] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-timescaledb> server # [ 40.355406] systemd-udevd[423]: Using default interface naming scheme 'v258'. vm-test-run-timescaledb> server # [ 40.391330] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-timescaledb> server # [ 40.410131] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-timescaledb> server # [ 40.415232] systemd[1]: Starting Create System Files and Directories... vm-test-run-timescaledb> server # [ 42.699212] systemd[1]: Finished Create System Files and Directories. vm-test-run-timescaledb> server # [ 42.744149] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-timescaledb> server # [ 42.783023] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-timescaledb> server # [ 42.874530] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-timescaledb> server # [ 43.890644] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-timescaledb> server # [ 45.233617] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-timescaledb> server # [ 45.278542] systemd[1]: Starting Update is Completed... vm-test-run-timescaledb> server # [ 46.022146] systemd[1]: Finished Update is Completed. vm-test-run-timescaledb> server # [ 50.128643] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 50.131912] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-timescaledb> server # [ 50.139609] systemd[1]: suid-sgid-wrappers.service: Consumed 3.064s CPU time, 5.8M memory peak. vm-test-run-timescaledb> server # [ 53.099384] systemd[1]: Finished Firewall. vm-test-run-timescaledb> server # [ 54.699558] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-timescaledb> server # [ 54.706119] systemd[1]: Reached target System Initialization. vm-test-run-timescaledb> server # [ 54.714427] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-timescaledb> server # [ 54.725521] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-timescaledb> server # [ 54.727963] systemd[1]: Reached target Timer Units. vm-test-run-timescaledb> server # [ 54.734869] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-timescaledb> server # [ 54.739616] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-timescaledb> server # [ 54.746655] systemd[1]: Listening on Hostname Service Socket. vm-test-run-timescaledb> server # [ 54.754980] systemd[1]: Reached target Socket Units. vm-test-run-timescaledb> server # [ 54.757762] systemd[1]: Reached target Basic System. vm-test-run-timescaledb> server # [ 54.775131] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-timescaledb> server # [ 54.848940] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 54.898046] systemd[1]: Started Reset console on configuration changes. vm-test-run-timescaledb> server # [ 54.957988] systemd[1]: Starting resolvconf update... vm-test-run-timescaledb> server # [ 55.047785] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-timescaledb> server # [ 56.185436] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-timescaledb> server # [ 56.396849] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 56.411501] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 56.431708] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 56.490097] nsncd[628]: Oct 20 20:54:41.768 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 56.512705] systemd[1]: Starting User Login Management... vm-test-run-timescaledb> server # [ 56.837227] dbus-daemon[631]: dbus[631]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-timescaledb> server # [ 57.357567] systemd[1]: Started D-Bus System Message Bus. vm-test-run-timescaledb> server # [ 58.132857] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 58.175309] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-timescaledb> server # [ 58.197386] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 58.223628] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-timescaledb> server # [ 58.241600] systemd-logind[644]: New seat seat0. vm-test-run-timescaledb> server # [ 58.255490] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 58.288783] systemd[1]: Started User Login Management. vm-test-run-timescaledb> server # [ 58.304089] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 58.319645] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 58.494780] systemd[1]: Starting linger-users.service... vm-test-run-timescaledb> server # [ 58.528711] systemd[1]: Starting Name Service Cache Daemon (nsncd)... 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.153783] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 59.166913] systemd[1]: Finished linger-users.service. vm-test-run-timescaledb> server # [ 59.471511] nsncd[691]: Oct 20 20:54:44.855 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 59.505682] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 59.507100] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 59.520918] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 59.933562] systemd[1]: Finished resolvconf update. vm-test-run-timescaledb> server # [ 59.953023] systemd[1]: Reached target Preparation for Network. vm-test-run-timescaledb> server # [ 60.018572] systemd[1]: Starting DHCP Client... vm-test-run-timescaledb> server # [ 61.718393] dhcpcd[739]: dhcpcd-10.2.4 starting vm-test-run-timescaledb> server # [ 61.837413] dhcpcd[762]: dev: loaded udev vm-test-run-timescaledb> server # [ 62.609561] systemd[1]: Found device /dev/hvc0. vm-test-run-timescaledb> server # [ 63.280425] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-timescaledb> server # [ 63.259110] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-timescaledb> server # [ 63.344825] systemd[1]: Started backdoor.service. vm-test-run-timescaledb> server # [ 63.811350] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-timescaledb> server # [ 64.082863] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-timescaledb> server # [ 64.089893] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-timescaledb> server # [ 64.115876] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-timescaledb> server # [ 64.123798] cfg80211: failed to load regulatory.db 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 65.50 seconds) vm-test-run-timescaledb> server: (finished: waiting for the VM to finish booting, in 65.50 seconds) vm-test-run-timescaledb> server # [ 65.376487] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-timescaledb> server # [ 65.344961] dhcpcd[762]: eth0: waiting for carrier vm-test-run-timescaledb> server # [ 65.367056] dhcpcd[762]: eth0: carrier acquired vm-test-run-timescaledb> server # [ 65.589462] dhcpcd[762]: DUID 00:01:00:01:32:6a:91:9a:52:54:00:12:34:56 vm-test-run-timescaledb> server # [ 65.592244] dhcpcd[762]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 65.599809] dhcpcd[762]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-timescaledb> server # [ 66.526713] (udev-worker)[785]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-timescaledb> server # [ 66.538808] (udev-worker)[785]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 66.553442] (udev-worker)[798]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 66.991472] systemd[1]: Found device Virtio network device. vm-test-run-timescaledb> server # [ 67.010629] systemd[1]: Starting Address configuration of eth1... vm-test-run-timescaledb> server # [ 67.078938] dhcpcd[762]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 67.471899] dhcpcd[762]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 67.508801] dhcpcd[762]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 67.526236] dhcpcd[762]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 67.836088] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-timescaledb> server # [ 67.969083] network-addresses-eth1-start[816]: adding address 192.168.1.1/24... done vm-test-run-timescaledb> server # [ 68.041614] dhcpcd[762]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 68.134403] dhcpcd[762]: eth0: Router Advertisement from fe80::2 vm-test-run-timescaledb> server # [ 68.138078] dhcpcd[762]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-timescaledb> server # [ 68.156903] dhcpcd[762]: eth0: adding route to fec0::/64 vm-test-run-timescaledb> server # [ 68.159534] dhcpcd[762]: eth0: adding default route via fe80::2 vm-test-run-timescaledb> server # [ 68.183267] network-addresses-eth1-start[816]: adding address 2001:db8:1::1/64... done vm-test-run-timescaledb> server # [ 68.491620] systemd[1]: Finished Address configuration of eth1. vm-test-run-timescaledb> server # [ 68.555763] systemd[1]: Starting Networking Setup... vm-test-run-timescaledb> server # [ 69.864062] dhcpcd[859]: /nix/store/hsj50yr7hr62ql9xaynbihkhfhbgprcn-openresolv-3.17.0/sbin/.resolvconf-wrapped: line 1221: kill: (856) - Operation not permitted vm-test-run-timescaledb> server # [ 69.868045] dhcpcd[859]: clearing stale lock pid 856 vm-test-run-timescaledb> server # [ 71.210159] systemd[1]: Finished Networking Setup. vm-test-run-timescaledb> server # [ 71.241389] systemd[1]: Reached target Network. vm-test-run-timescaledb> server # [ 71.290046] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-timescaledb> server # [ 71.345643] systemd[1]: Starting Permit User Sessions... vm-test-run-timescaledb> server # [ 72.014847] systemd[1]: Finished Permit User Sessions. vm-test-run-timescaledb> server # [ 72.128694] systemd[1]: Started Getty on tty1. vm-test-run-timescaledb> server # [ 72.158855] systemd[1]: Reached target Login Prompts. vm-test-run-timescaledb> server # [ 72.772684] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[927]: Initializing database at /var/lib/postgresql/data vm-test-run-timescaledb> server # [ 74.126390] dhcpcd[762]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-timescaledb> server # [ 74.149050] dhcpcd[762]: eth0: adding route to 10.0.2.0/24 vm-test-run-timescaledb> server # [ 74.151945] dhcpcd[762]: eth0: adding default route via 10.0.2.2 vm-test-run-timescaledb> server # [ 74.424465] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: The files belonging to this database system will be owned by user "postgres". vm-test-run-timescaledb> server # [ 74.455681] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: This user must also own the server process. vm-test-run-timescaledb> server # [ 74.528817] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-timescaledb> server # [ 74.539284] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: The default database encoding has accordingly been set to "UTF8". vm-test-run-timescaledb> server # [ 74.550876] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: The default text search configuration will be set to "english". vm-test-run-timescaledb> server # [ 74.560295] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: Data page checksums are enabled. vm-test-run-timescaledb> server # [ 74.574246] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-timescaledb> server # [ 74.595537] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: creating subdirectories ... ok vm-test-run-timescaledb> server # [ 74.613732] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: selecting dynamic shared memory implementation ... posix vm-test-run-timescaledb> server # [ 76.161734] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: selecting default max_connections ... 100 vm-test-run-timescaledb> server # [ 77.486729] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: selecting default shared_buffers ... 128MB vm-test-run-timescaledb> server # [ 77.967945] systemd[1]: Started DHCP Client. vm-test-run-timescaledb> server # [ 80.340750] systemd-logind[644]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-timescaledb> server # [ 88.075161] mousedev: PS/2 mouse device common for all mice vm-test-run-timescaledb> server # [ 88.270641] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: selecting default time zone ... UTC vm-test-run-timescaledb> server # [ 88.310571] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: creating configuration files ... ok vm-test-run-timescaledb> server # [ 90.865199] systemd-logind[644]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-timescaledb> server # [ 93.202770] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: running bootstrap script ... ok vm-test-run-timescaledb> server # [ 105.935125] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: performing post-bootstrap initialization ... ok vm-test-run-timescaledb> server # [ 109.143105] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: syncing data to disk ... ok vm-test-run-timescaledb> server # [ 109.150046] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-timescaledb> server # [ 109.151434] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: 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 # [ 109.163126] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: Success. You can now start the database server using: vm-test-run-timescaledb> server # [ 109.185273] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[941]: /nix/store/vjkglhysjmfzxg4jib77l7b05xnmllkm-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-timescaledb> server # [ 110.800028] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[927]: Validating PostgreSQL configuration... vm-test-run-timescaledb> server # [ 111.329482] 11b7d74w6hz4p0vf0wdlaiprkgy6rjrj-postgresql-init[1355]: 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 # [ 112.695456] postgres[1366]: 2026-10-20 20:55:38.083 UTC [1366] LOG: pgaudit extension initialized vm-test-run-timescaledb> server # [ 113.670064] postgres[1366]: 2026-10-20 20:55:39.065 UTC [1366] LOG: pgsodium primary server secret key loaded vm-test-run-timescaledb> server # [ 114.171533] postgres[1366]: 2026-10-20 20:55:39.538 UTC [1366] LOG: vault primary server secret key loaded vm-test-run-timescaledb> server # [ 114.952267] postgres[1366]: 2026-10-20 20:55:40.349 UTC [1366] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-timescaledb> server # [ 114.977371] postgres[1366]: 2026-10-20 20:55:40.369 UTC [1366] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-timescaledb> server # [ 114.979935] postgres[1366]: 2026-10-20 20:55:40.371 UTC [1366] LOG: listening on IPv6 address "::", port 5432 vm-test-run-timescaledb> server # [ 115.015168] postgres[1366]: 2026-10-20 20:55:40.400 UTC [1366] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-timescaledb> server # [ 115.169774] postgres[1412]: 2026-10-20 20:55:40.555 UTC [1412] LOG: database system was shut down at 2026-10-20 20:55:31 UTC vm-test-run-timescaledb> server # [ 115.584528] postgres[1366]: 2026-10-20 20:55:40.976 UTC [1366] LOG: database system is ready to accept connections vm-test-run-timescaledb> server # [ 115.668408] systemd[1]: Started PostgreSQL Database Server. vm-test-run-timescaledb> server # [ 115.726048] postgres[1419]: 2026-10-20 20:55:41.063 UTC [1419] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 115.739303] systemd[1]: Starting Supabase Database Initialization... vm-test-run-timescaledb> server # [ 115.800754] postgres[1418]: 2026-10-20 20:55:41.180 UTC [1418] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-timescaledb> server # [ 115.932077] postgres[1366]: 2026-10-20 20:55:41.326 UTC [1366] LOG: background worker "pg_net 0.20.4 worker" (PID 1419) exited with exit code 1 vm-test-run-timescaledb> server # [ 116.209938] postgres[1422]: 2026-10-20 20:55:41.583 UTC [1422] LOG: pg_cron scheduler started vm-test-run-timescaledb> server # [ 116.332124] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Waiting for PostgreSQL to be ready... vm-test-run-timescaledb> server # [ 116.843344] postgres[1431]: ::1 2026-10-20 20:55:42.235 UTC [1431] root@root FATAL: role "root" does not exist vm-test-run-timescaledb> server # [ 116.886621] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: PostgreSQL is ready vm-test-run-timescaledb> server # [ 116.891722] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Creating postgres role... vm-test-run-timescaledb> server # [ 117.002973] postgres[1433]: 2026-10-20 20:55:42.376 UTC [1433] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 117.041623] postgres[1366]: 2026-10-20 20:55:42.431 UTC [1366] LOG: background worker "pg_net 0.20.4 worker" (PID 1433) exited with exit code 1 vm-test-run-timescaledb> server # [ 117.312045] postgres[1434]: ::1 2026-10-20 20:55:42.694 UTC [1434] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-timescaledb> server # [ 117.351924] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1432]: CREATE ROLE vm-test-run-timescaledb> server # [ 117.840610] postgres[1443]: ::1 2026-10-20 20:55:43.232 UTC [1443] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-timescaledb> server # [ 117.917583] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1436]: ALTER DATABASE vm-test-run-timescaledb> server # [ 117.993547] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-timescaledb> server # [ 118.455151] postgres[1451]: ::1 2026-10-20 20:55:43.842 UTC [1451] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-timescaledb> server # [ 118.503420] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: CREATE PUBLICATION vm-test-run-timescaledb> server # [ 118.506876] postgres[1451]: ::1 2026-10-20 20:55:43.888 UTC [1451] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-timescaledb> server # [ 118.509268] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: ALTER ROLE vm-test-run-timescaledb> server # [ 118.510786] postgres[1451]: ::1 2026-10-20 20:55:43.907 UTC [1451] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-timescaledb> server # [ 118.529645] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: CREATE ROLE vm-test-run-timescaledb> server # [ 118.530941] postgres[1451]: ::1 2026-10-20 20:55:43.927 UTC [1451] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-timescaledb> server # [ 118.536465] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: CREATE ROLE vm-test-run-timescaledb> server # [ 118.538044] postgres[1451]: ::1 2026-10-20 20:55:43.934 UTC [1451] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-timescaledb> server # [ 118.556863] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: GRANT ROLE vm-test-run-timescaledb> server # [ 118.562748] postgres[1451]: ::1 2026-10-20 20:55:43.954 UTC [1451] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-timescaledb> server # [ 118.570594] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: GRANT vm-test-run-timescaledb> server # [ 118.571976] postgres[1451]: ::1 2026-10-20 20:55:43.968 UTC [1451] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-timescaledb> server # [ 118.589238] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: CREATE ROLE vm-test-run-timescaledb> server # [ 118.590901] postgres[1451]: ::1 2026-10-20 20:55:43.987 UTC [1451] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-timescaledb> server # [ 118.597231] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: GRANT ROLE vm-test-run-timescaledb> server # [ 118.598809] postgres[1451]: ::1 2026-10-20 20:55:43.995 UTC [1451] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-timescaledb> server # [ 118.621565] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 118.623262] postgres[1451]: ::1 2026-10-20 20:55:44.017 UTC [1451] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-timescaledb> server # [ 121.176116] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 121.184520] postgres[1451]: ::1 2026-10-20 20:55:46.570 UTC [1451] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-timescaledb> server # [ 122.385464] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 122.394355] postgres[1451]: ::1 2026-10-20 20:55:47.780 UTC [1451] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-timescaledb> server # [ 122.395759] postgres[1451]: ::1 2026-10-20 20:55:47.788 UTC [1451] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-timescaledb> server # [ 122.402441] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: CREATE ROLE vm-test-run-timescaledb> server # [ 122.405212] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: CREATE ROLE vm-test-run-timescaledb> server # [ 122.406057] postgres[1451]: ::1 2026-10-20 20:55:47.802 UTC [1451] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-timescaledb> server # [ 122.411751] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: CREATE ROLE vm-test-run-timescaledb> server # [ 122.415125] postgres[1451]: ::1 2026-10-20 20:55:47.812 UTC [1451] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-timescaledb> server # [ 122.424854] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: CREATE ROLE vm-test-run-timescaledb> server # [ 122.430944] postgres[1451]: ::1 2026-10-20 20:55:47.825 UTC [1451] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-timescaledb> server # [ 122.438770] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: GRANT ROLE vm-test-run-timescaledb> server # [ 122.439915] postgres[1451]: ::1 2026-10-20 20:55:47.836 UTC [1451] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-timescaledb> server # [ 122.454511] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: GRANT ROLE vm-test-run-timescaledb> server # [ 122.463518] postgres[1451]: ::1 2026-10-20 20:55:47.860 UTC [1451] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-timescaledb> server # [ 122.473736] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: GRANT ROLE vm-test-run-timescaledb> server # [ 122.487369] postgres[1451]: ::1 2026-10-20 20:55:47.878 UTC [1451] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-timescaledb> server # [ 122.502579] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: GRANT ROLE vm-test-run-timescaledb> server # [ 122.509723] postgres[1451]: ::1 2026-10-20 20:55:47.903 UTC [1451] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 122.526045] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: GRANT vm-test-run-timescaledb> server # [ 122.530874] postgres[1451]: ::1 2026-10-20 20:55:47.924 UTC [1451] 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 # [ 122.551234] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 122.557234] postgres[1451]: ::1 2026-10-20 20:55:47.952 UTC [1451] 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 # [ 122.563804] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 122.567450] postgres[1451]: ::1 2026-10-20 20:55:47.963 UTC [1451] 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 # [ 122.579509] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 122.581202] postgres[1451]: ::1 2026-10-20 20:55:47.975 UTC [1451] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 122.591093] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: GRANT vm-test-run-timescaledb> server # [ 122.594231] postgres[1451]: ::1 2026-10-20 20:55:47.990 UTC [1451] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-timescaledb> server # [ 122.603954] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: ALTER ROLE vm-test-run-timescaledb> server # [ 122.608180] postgres[1451]: ::1 2026-10-20 20:55:48.003 UTC [1451] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 122.609566] postgres[1451]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 122.618702] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 122.623002] postgres[1451]: ::1 2026-10-20 20:55:48.020 UTC [1451] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 122.623856] postgres[1451]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 122.633021] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 122.635744] postgres[1451]: ::1 2026-10-20 20:55:48.032 UTC [1451] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 122.638569] postgres[1451]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 122.646341] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 122.650753] postgres[1451]: ::1 2026-10-20 20:55:48.045 UTC [1451] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-timescaledb> server # [ 122.656122] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: ALTER ROLE vm-test-run-timescaledb> server # [ 122.657283] postgres[1451]: ::1 2026-10-20 20:55:48.054 UTC [1451] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 122.664146] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1447]: ALTER ROLE vm-test-run-timescaledb> server # [ 122.727543] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-timescaledb> server # [ 122.971845] postgres[1493]: ::1 2026-10-20 20:55:48.365 UTC [1493] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 122.995076] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 122.996151] postgres[1493]: ::1 2026-10-20 20:55:48.385 UTC [1493] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-timescaledb> server # [ 123.006262] postgres[1493]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 123.007598] postgres[1493]: id uuid NOT NULL UNIQUE, vm-test-run-timescaledb> server # [ 123.008086] postgres[1493]: aud varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.014494] postgres[1493]: "role" varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.015978] postgres[1493]: email varchar(255) NULL UNIQUE, vm-test-run-timescaledb> server # [ 123.021757] postgres[1493]: encrypted_password varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.022881] postgres[1493]: confirmed_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.023253] postgres[1493]: invited_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.027109] postgres[1493]: confirmation_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.027994] postgres[1493]: confirmation_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.029418] postgres[1493]: recovery_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.029897] postgres[1493]: recovery_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.030271] postgres[1493]: email_change_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.030723] postgres[1493]: email_change varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.031282] postgres[1493]: email_change_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.041249] postgres[1493]: last_sign_in_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.042536] postgres[1493]: raw_app_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 123.042899] postgres[1493]: raw_user_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 123.043164] postgres[1493]: is_super_admin bool NULL, vm-test-run-timescaledb> server # [ 123.049509] postgres[1493]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.050339] postgres[1493]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.050709] postgres[1493]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 123.052619] postgres[1493]: ); vm-test-run-timescaledb> server # [ 123.110969] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE TABLE vm-test-run-timescaledb> server # [ 123.116862] postgres[1493]: ::1 2026-10-20 20:55:48.512 UTC [1493] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-timescaledb> server # [ 123.146904] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE INDEX vm-test-run-timescaledb> server # [ 123.153778] postgres[1493]: ::1 2026-10-20 20:55:48.544 UTC [1493] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-timescaledb> server # [ 123.200954] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE INDEX vm-test-run-timescaledb> server # [ 123.202279] postgres[1493]: ::1 2026-10-20 20:55:48.599 UTC [1493] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-timescaledb> server # [ 123.228727] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: COMMENT vm-test-run-timescaledb> server # [ 123.237176] postgres[1493]: ::1 2026-10-20 20:55:48.629 UTC [1493] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-timescaledb> server # [ 123.238669] postgres[1493]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 123.239616] postgres[1493]: id bigserial NOT NULL, vm-test-run-timescaledb> server # [ 123.248645] postgres[1493]: "token" varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.251815] postgres[1493]: user_id varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.263322] postgres[1493]: revoked bool NULL, vm-test-run-timescaledb> server # [ 123.263952] postgres[1493]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.265038] postgres[1493]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.266772] postgres[1493]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 123.276612] postgres[1493]: ); vm-test-run-timescaledb> server # [ 123.379966] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE TABLE vm-test-run-timescaledb> server # [ 123.382153] postgres[1493]: ::1 2026-10-20 20:55:48.771 UTC [1493] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-timescaledb> server # [ 123.411267] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE INDEX vm-test-run-timescaledb> server # [ 123.419761] postgres[1493]: ::1 2026-10-20 20:55:48.810 UTC [1493] 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 # [ 123.449460] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE INDEX vm-test-run-timescaledb> server # [ 123.451258] postgres[1493]: ::1 2026-10-20 20:55:48.844 UTC [1493] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-timescaledb> server # [ 123.477635] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE INDEX vm-test-run-timescaledb> server # [ 123.482189] postgres[1493]: ::1 2026-10-20 20:55:48.876 UTC [1493] 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 # [ 123.499192] postgres[1493]: ::1 2026-10-20 20:55:48.890 UTC [1493] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-timescaledb> server # [ 123.500869] postgres[1493]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 123.501896] postgres[1493]: uuid uuid NULL, vm-test-run-timescaledb> server # [ 123.502700] postgres[1493]: raw_base_config text NULL, vm-test-run-timescaledb> server # [ 123.503613] postgres[1493]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.503940] postgres[1493]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.510132] postgres[1493]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 123.511193] postgres[1493]: ); vm-test-run-timescaledb> server # [ 123.512006] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: COMMENT vm-test-run-timescaledb> server # [ 123.562646] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE TABLE vm-test-run-timescaledb> server # [ 123.567982] postgres[1493]: ::1 2026-10-20 20:55:48.960 UTC [1493] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-timescaledb> server # [ 123.578472] postgres[1493]: ::1 2026-10-20 20:55:48.969 UTC [1493] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-timescaledb> server # [ 123.579458] postgres[1493]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 123.581070] postgres[1493]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 123.581886] postgres[1493]: payload json NULL, vm-test-run-timescaledb> server # [ 123.585503] postgres[1493]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.586326] postgres[1493]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 123.587016] postgres[1493]: ); vm-test-run-timescaledb> server # [ 123.587458] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: COMMENT vm-test-run-timescaledb> server # [ 123.640406] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE TABLE vm-test-run-timescaledb> server # [ 123.647138] postgres[1493]: ::1 2026-10-20 20:55:49.043 UTC [1493] 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 # [ 123.683597] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE INDEX vm-test-run-timescaledb> server # [ 123.689474] postgres[1493]: ::1 2026-10-20 20:55:49.081 UTC [1493] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-timescaledb> server # [ 123.696968] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: COMMENT vm-test-run-timescaledb> server # [ 123.701868] postgres[1493]: ::1 2026-10-20 20:55:49.097 UTC [1493] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-timescaledb> server # [ 123.703796] postgres[1493]: "version" varchar(255) NOT NULL, vm-test-run-timescaledb> server # [ 123.715142] postgres[1493]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-timescaledb> server # [ 123.719721] postgres[1493]: ); vm-test-run-timescaledb> server # [ 123.739531] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE TABLE vm-test-run-timescaledb> server # [ 123.745061] postgres[1493]: ::1 2026-10-20 20:55:49.138 UTC [1493] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-timescaledb> server # [ 123.758376] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: COMMENT vm-test-run-timescaledb> server # [ 123.789556] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: INSERT 0 7 vm-test-run-timescaledb> server # [ 123.790494] postgres[1493]: ::1 2026-10-20 20:55:49.184 UTC [1493] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-timescaledb> server # [ 123.791271] postgres[1493]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-timescaledb> server # [ 123.791985] postgres[1493]: $$ language sql stable; vm-test-run-timescaledb> server # [ 123.800051] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 123.808692] postgres[1493]: ::1 2026-10-20 20:55:49.199 UTC [1493] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-timescaledb> server # [ 123.819300] postgres[1493]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-timescaledb> server # [ 123.831519] postgres[1493]: $$ language sql stable; vm-test-run-timescaledb> server # [ 123.834778] postgres[1493]: ::1 2026-10-20 20:55:49.219 UTC [1493] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-timescaledb> server # [ 123.837604] postgres[1493]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-timescaledb> server # [ 123.839089] postgres[1493]: $$ language sql stable; vm-test-run-timescaledb> server # [ 123.841430] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 123.842651] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 123.848699] postgres[1493]: ::1 2026-10-20 20:55:49.241 UTC [1493] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.855149] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 123.861348] postgres[1493]: ::1 2026-10-20 20:55:49.258 UTC [1493] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 123.869642] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: CREATE ROLE vm-test-run-timescaledb> server # [ 123.877757] postgres[1493]: ::1 2026-10-20 20:55:49.271 UTC [1493] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 123.887782] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 123.888573] postgres[1493]: ::1 2026-10-20 20:55:49.285 UTC [1493] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 123.906596] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 123.909611] postgres[1493]: ::1 2026-10-20 20:55:49.305 UTC [1493] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 123.922963] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 123.928008] postgres[1493]: ::1 2026-10-20 20:55:49.321 UTC [1493] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-timescaledb> server # [ 123.941653] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: ALTER ROLE vm-test-run-timescaledb> server # [ 123.942814] postgres[1493]: ::1 2026-10-20 20:55:49.336 UTC [1493] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 123.964270] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: ALTER TABLE vm-test-run-timescaledb> server # [ 123.989995] postgres[1493]: ::1 2026-10-20 20:55:49.362 UTC [1493] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.015292] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: ALTER TABLE vm-test-run-timescaledb> server # [ 124.023702] postgres[1493]: ::1 2026-10-20 20:55:49.399 UTC [1493] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.035787] postgres[1493]: ::1 2026-10-20 20:55:49.424 UTC [1493] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.047218] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: ALTER TABLE vm-test-run-timescaledb> server # [ 124.049605] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: ALTER TABLE vm-test-run-timescaledb> server # [ 124.054043] postgres[1493]: ::1 2026-10-20 20:55:49.443 UTC [1493] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.058594] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1492]: ALTER TABLE vm-test-run-timescaledb> server # [ 124.117498] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-timescaledb> server # [ 124.533424] postgres[1506]: ::1 2026-10-20 20:55:49.927 UTC [1506] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 124.547299] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1499]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 124.552073] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1499]: CREATE ROLE vm-test-run-timescaledb> server # [ 124.565107] postgres[1506]: ::1 2026-10-20 20:55:49.941 UTC [1506] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 124.567054] postgres[1506]: ::1 2026-10-20 20:55:49.951 UTC [1506] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-timescaledb> server # [ 124.578892] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1499]: ALTER ROLE vm-test-run-timescaledb> server # [ 124.586147] postgres[1506]: ::1 2026-10-20 20:55:49.978 UTC [1506] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-timescaledb> server # [ 124.613471] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1499]: GRANT vm-test-run-timescaledb> server # [ 124.667040] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1499]: DO vm-test-run-timescaledb> server # [ 124.716617] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-timescaledb> server # [ 125.151770] postgres[1518]: ::1 2026-10-20 20:55:50.544 UTC [1518] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-timescaledb> server # [ 125.197192] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: ALTER ROLE vm-test-run-timescaledb> server # [ 125.200671] postgres[1518]: ::1 2026-10-20 20:55:50.579 UTC [1518] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-timescaledb> server # [ 125.203901] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: ALTER ROLE vm-test-run-timescaledb> server # [ 125.207438] postgres[1518]: ::1 2026-10-20 20:55:50.601 UTC [1518] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-timescaledb> server # [ 125.208792] postgres[1518]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 125.209385] postgres[1518]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 125.209715] postgres[1518]: AS $$ vm-test-run-timescaledb> server # [ 125.210299] postgres[1518]: DECLARE vm-test-run-timescaledb> server # [ 125.211627] postgres[1518]: schema_is_cron bool; vm-test-run-timescaledb> server # [ 125.218009] postgres[1518]: BEGIN vm-test-run-timescaledb> server # [ 125.219065] postgres[1518]: schema_is_cron = ( vm-test-run-timescaledb> server # [ 125.219410] postgres[1518]: SELECT n.nspname = 'cron' vm-test-run-timescaledb> server # [ 125.219977] postgres[1518]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 125.230143] postgres[1518]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-timescaledb> server # [ 125.231732] postgres[1518]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 125.237414] postgres[1518]: ); vm-test-run-timescaledb> server # [ 125.239550] postgres[1518]: vm-test-run-timescaledb> server # [ 125.245806] postgres[1518]: IF schema_is_cron vm-test-run-timescaledb> server # [ 125.249387] postgres[1518]: THEN vm-test-run-timescaledb> server # [ 125.249751] postgres[1518]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 125.251712] postgres[1518]: vm-test-run-timescaledb> server # [ 125.252088] postgres[1518]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 125.266428] postgres[1518]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 125.267382] postgres[1518]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 125.267870] postgres[1518]: vm-test-run-timescaledb> server # [ 125.268273] postgres[1518]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 125.282904] postgres[1518]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 125.295285] postgres[1518]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 125.301644] postgres[1518]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 125.310256] postgres[1518]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 125.311073] postgres[1518]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 125.311803] postgres[1518]: vm-test-run-timescaledb> server # [ 125.312267] postgres[1518]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 125.319755] postgres[1518]: vm-test-run-timescaledb> server # [ 125.323392] postgres[1518]: END IF; vm-test-run-timescaledb> server # [ 125.327404] postgres[1518]: vm-test-run-timescaledb> server # [ 125.328064] postgres[1518]: END; vm-test-run-timescaledb> server # [ 125.338954] postgres[1518]: $$; vm-test-run-timescaledb> server # [ 125.339626] postgres[1518]: ::1 2026-10-20 20:55:50.661 UTC [1518] 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 # [ 125.345732] postgres[1518]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 125.346322] postgres[1518]: ::1 2026-10-20 20:55:50.686 UTC [1518] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-timescaledb> server # [ 125.347479] postgres[1518]: ::1 2026-10-20 20:55:50.707 UTC [1518] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-timescaledb> server # [ 125.347987] postgres[1518]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 125.361484] postgres[1518]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 125.362142] postgres[1518]: AS $$ vm-test-run-timescaledb> server # [ 125.362634] postgres[1518]: BEGIN vm-test-run-timescaledb> server # [ 125.363372] postgres[1518]: IF EXISTS ( vm-test-run-timescaledb> server # [ 125.363686] postgres[1518]: SELECT 1 vm-test-run-timescaledb> server # [ 125.363945] postgres[1518]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 125.371356] postgres[1518]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 125.380036] postgres[1518]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 125.381753] postgres[1518]: WHERE ext.extname = 'pg_net' vm-test-run-timescaledb> server # [ 125.382277] postgres[1518]: ) vm-test-run-timescaledb> server # [ 125.382595] postgres[1518]: THEN vm-test-run-timescaledb> server # [ 125.382833] postgres[1518]: IF NOT EXISTS ( vm-test-run-timescaledb> server # [ 125.383831] postgres[1518]: SELECT 1 vm-test-run-timescaledb> server # [ 125.384449] postgres[1518]: FROM pg_roles vm-test-run-timescaledb> server # [ 125.384998] postgres[1518]: WHERE rolname = 'supabase_functions_admin' vm-test-run-timescaledb> server # [ 125.394530] postgres[1518]: ) vm-test-run-timescaledb> server # [ 125.395572] postgres[1518]: THEN vm-test-run-timescaledb> server # [ 125.402443] postgres[1518]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 125.403586] postgres[1518]: END IF; vm-test-run-timescaledb> server # [ 125.409185] postgres[1518]: vm-test-run-timescaledb> server # [ 125.410099] postgres[1518]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 125.411012] postgres[1518]: vm-test-run-timescaledb> server # [ 125.411364] postgres[1518]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 125.422523] postgres[1518]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 125.436951] postgres[1518]: vm-test-run-timescaledb> server # [ 125.437775] postgres[1518]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-timescaledb> server # [ 125.439221] postgres[1518]: 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 # [ 125.448196] postgres[1518]: vm-test-run-timescaledb> server # [ 125.453408] postgres[1518]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-timescaledb> server # [ 125.454666] postgres[1518]: 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 # [ 125.455638] postgres[1518]: vm-test-run-timescaledb> server # [ 125.467116] postgres[1518]: 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 # [ 125.491203] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 125.491966] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 125.497296] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: COMMENT vm-test-run-timescaledb> server # [ 125.502258] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 125.502740] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: COMMENT vm-test-run-timescaledb> server # [ 125.503132] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: DO vm-test-run-timescaledb> server # [ 125.503528] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: CREATE ROLE vm-test-run-timescaledb> server # [ 125.507815] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: GRANT vm-test-run-timescaledb> server # [ 125.518171] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: GRANT vm-test-run-timescaledb> server # [ 125.519099] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: GRANT vm-test-run-timescaledb> server # [ 125.519652] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: GRANT vm-test-run-timescaledb> server # [ 125.519966] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: GRANT vm-test-run-timescaledb> server # [ 125.524210] postgres[1518]: 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 # [ 125.528613] postgres[1518]: END IF; vm-test-run-timescaledb> server # [ 125.534266] postgres[1518]: END; vm-test-run-timescaledb> server # [ 125.534863] postgres[1518]: $$; vm-test-run-timescaledb> server # [ 125.535150] postgres[1518]: ::1 2026-10-20 20:55:50.725 UTC [1518] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-timescaledb> server # [ 125.539480] postgres[1518]: ::1 2026-10-20 20:55:50.775 UTC [1518] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-timescaledb> server # [ 125.542224] postgres[1518]: ::1 2026-10-20 20:55:50.792 UTC [1518] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-timescaledb> server # [ 125.543048] postgres[1518]: ::1 2026-10-20 20:55:50.804 UTC [1518] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 125.543655] postgres[1518]: ::1 2026-10-20 20:55:50.822 UTC [1518] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 125.544113] postgres[1518]: ::1 2026-10-20 20:55:50.843 UTC [1518] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 125.555418] postgres[1518]: ::1 2026-10-20 20:55:50.863 UTC [1518] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 125.561720] postgres[1518]: ::1 2026-10-20 20:55:50.888 UTC [1518] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 125.563230] postgres[1518]: ::1 2026-10-20 20:55:50.899 UTC [1518] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 125.563822] postgres[1518]: ::1 2026-10-20 20:55:50.906 UTC [1518] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 125.567338] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: GRANT vm-test-run-timescaledb> server # [ 125.573659] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: GRANT vm-test-run-timescaledb> server # [ 125.574800] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: GRANT vm-test-run-timescaledb> server # [ 125.575714] postgres[1518]: ::1 2026-10-20 20:55:50.930 UTC [1518] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 125.601592] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: GRANT vm-test-run-timescaledb> server # [ 125.645479] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1513]: DO vm-test-run-timescaledb> server # [ 125.730760] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running pgbouncer auth schema... vm-test-run-timescaledb> server # [ 126.077423] postgres[1527]: ::1 2026-10-20 20:55:51.468 UTC [1527] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-timescaledb> server # [ 126.088442] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1526]: CREATE ROLE vm-test-run-timescaledb> server # [ 126.092986] postgres[1527]: ::1 2026-10-20 20:55:51.487 UTC [1527] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-timescaledb> server # [ 126.100010] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1526]: REVOKE vm-test-run-timescaledb> server # [ 126.107201] postgres[1527]: ::1 2026-10-20 20:55:51.502 UTC [1527] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-timescaledb> server # [ 126.153400] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1526]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 126.162047] postgres[1527]: ::1 2026-10-20 20:55:51.553 UTC [1527] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-timescaledb> server # [ 126.163357] postgres[1527]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-timescaledb> server # [ 126.163715] postgres[1527]: $$ vm-test-run-timescaledb> server # [ 126.168067] postgres[1527]: BEGIN vm-test-run-timescaledb> server # [ 126.171067] postgres[1527]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-timescaledb> server # [ 126.173379] postgres[1527]: vm-test-run-timescaledb> server # [ 126.174074] postgres[1527]: RETURN QUERY vm-test-run-timescaledb> server # [ 126.174426] postgres[1527]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-timescaledb> server # [ 126.178275] postgres[1527]: WHERE usename = p_usename; vm-test-run-timescaledb> server # [ 126.179127] postgres[1527]: END; vm-test-run-timescaledb> server # [ 126.179418] postgres[1527]: $$ LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 126.179663] postgres[1527]: SET search_path = '' vm-test-run-timescaledb> server # [ 126.179967] postgres[1527]: SECURITY DEFINER; vm-test-run-timescaledb> server # [ 126.180361] postgres[1527]: ::1 2026-10-20 20:55:51.574 UTC [1527] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-timescaledb> server # [ 126.188271] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1526]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.189629] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1526]: REVOKE vm-test-run-timescaledb> server # [ 126.190062] postgres[1527]: ::1 2026-10-20 20:55:51.587 UTC [1527] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-timescaledb> server # [ 126.201691] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1526]: GRANT vm-test-run-timescaledb> server # [ 126.229878] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running stat extension... vm-test-run-timescaledb> server # [ 126.466656] postgres[1529]: ::1 2026-10-20 20:55:51.856 UTC [1529] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-timescaledb> server # [ 126.480035] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1528]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-timescaledb> server # [ 126.496161] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1528]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 126.499637] postgres[1529]: ::1 2026-10-20 20:55:51.896 UTC [1529] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-timescaledb> server # [ 127.826224] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1528]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 127.900695] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-timescaledb> server # [ 128.320065] postgres[1550]: ::1 2026-10-20 20:55:53.705 UTC [1550] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-timescaledb> server # [ 128.341364] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1546]: GRANT vm-test-run-timescaledb> server # [ 128.343715] postgres[1550]: ::1 2026-10-20 20:55:53.726 UTC [1550] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 128.369153] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1546]: GRANT vm-test-run-timescaledb> server # [ 128.371662] postgres[1550]: ::1 2026-10-20 20:55:53.763 UTC [1550] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 128.389023] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1546]: GRANT vm-test-run-timescaledb> server # [ 128.396923] postgres[1550]: ::1 2026-10-20 20:55:53.790 UTC [1550] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 128.421118] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1546]: GRANT vm-test-run-timescaledb> server # [ 128.422271] postgres[1550]: ::1 2026-10-20 20:55:53.819 UTC [1550] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 128.437487] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1546]: GRANT vm-test-run-timescaledb> server # [ 128.438394] postgres[1550]: ::1 2026-10-20 20:55:53.832 UTC [1550] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 128.449195] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1546]: GRANT vm-test-run-timescaledb> server # [ 128.451631] postgres[1550]: ::1 2026-10-20 20:55:53.847 UTC [1550] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 128.457753] postgres[1550]: ::1 2026-10-20 20:55:53.854 UTC [1550] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 128.459998] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1546]: GRANT vm-test-run-timescaledb> server # [ 128.473342] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1546]: GRANT vm-test-run-timescaledb> server # [ 128.474609] postgres[1550]: ::1 2026-10-20 20:55:53.871 UTC [1550] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 128.561226] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1546]: GRANT vm-test-run-timescaledb> server # [ 128.582784] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1546]: DO vm-test-run-timescaledb> server # [ 128.583652] postgres[1550]: ::1 2026-10-20 20:55:53.980 UTC [1550] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-timescaledb> server # [ 128.591598] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1546]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.619714] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-timescaledb> server # [ 128.887700] postgres[1557]: ::1 2026-10-20 20:55:54.269 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.907489] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: GRANT vm-test-run-timescaledb> server # [ 128.913148] postgres[1557]: ::1 2026-10-20 20:55:54.296 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.928146] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: GRANT vm-test-run-timescaledb> server # [ 128.930303] postgres[1557]: ::1 2026-10-20 20:55:54.327 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.937330] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: GRANT vm-test-run-timescaledb> server # [ 128.941552] postgres[1557]: ::1 2026-10-20 20:55:54.338 UTC [1557] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.954209] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: ALTER TABLE vm-test-run-timescaledb> server # [ 128.955173] postgres[1557]: ::1 2026-10-20 20:55:54.347 UTC [1557] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.961559] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: ALTER TABLE vm-test-run-timescaledb> server # [ 128.962538] postgres[1557]: ::1 2026-10-20 20:55:54.359 UTC [1557] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.967994] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: ALTER TABLE vm-test-run-timescaledb> server # [ 128.970842] postgres[1557]: ::1 2026-10-20 20:55:54.367 UTC [1557] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.985302] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: ALTER TABLE vm-test-run-timescaledb> server # [ 128.986354] postgres[1557]: ::1 2026-10-20 20:55:54.380 UTC [1557] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 128.995477] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: ALTER TABLE vm-test-run-timescaledb> server # [ 129.003965] postgres[1557]: ::1 2026-10-20 20:55:54.395 UTC [1557] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 129.019402] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: GRANT vm-test-run-timescaledb> server # [ 129.023783] postgres[1557]: ::1 2026-10-20 20:55:54.417 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 129.040360] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: GRANT vm-test-run-timescaledb> server # [ 129.043601] postgres[1557]: ::1 2026-10-20 20:55:54.440 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 129.065135] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: GRANT vm-test-run-timescaledb> server # [ 129.067348] postgres[1557]: ::1 2026-10-20 20:55:54.456 UTC [1557] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 129.081748] postgres[1557]: ::1 2026-10-20 20:55:54.476 UTC [1557] 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 # [ 129.092630] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: GRANT vm-test-run-timescaledb> server # [ 129.098527] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 129.105083] postgres[1557]: ::1 2026-10-20 20:55:54.497 UTC [1557] 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 # [ 129.111296] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 129.118284] postgres[1557]: ::1 2026-10-20 20:55:54.511 UTC [1557] 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 # [ 129.127400] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1556]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 129.191688] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-timescaledb> server # [ 129.515948] postgres[1563]: ::1 2026-10-20 20:55:54.897 UTC [1563] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-timescaledb> server # [ 129.544000] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1561]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 129.576535] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 129.839275] postgres[1565]: ::1 2026-10-20 20:55:55.233 UTC [1565] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-timescaledb> server # [ 129.855596] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.863107] postgres[1565]: ::1 2026-10-20 20:55:55.258 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 129.867139] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.874224] postgres[1565]: ::1 2026-10-20 20:55:55.269 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 129.883197] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.884040] postgres[1565]: ::1 2026-10-20 20:55:55.278 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 129.888508] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.931513] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-timescaledb> server # [ 130.238390] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1566]: DO vm-test-run-timescaledb> server # [ 130.241833] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1566]: DO vm-test-run-timescaledb> server # [ 130.255299] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1566]: DO vm-test-run-timescaledb> server # [ 130.326768] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 130.715836] postgres[1574]: ::1 2026-10-20 20:55:56.107 UTC [1574] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 130.750499] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1568]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 130.752264] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1568]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 130.754404] postgres[1574]: ::1 2026-10-20 20:55:56.127 UTC [1574] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 130.764232] postgres[1574]: ::1 2026-10-20 20:55:56.142 UTC [1574] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 130.786059] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1568]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 130.821503] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-timescaledb> server # [ 131.310041] postgres[1586]: ::1 2026-10-20 20:55:56.687 UTC [1586] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-timescaledb> server # [ 131.331440] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1578]: ALTER ROLE vm-test-run-timescaledb> server # [ 131.403567] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-timescaledb> server # [ 131.950551] postgres[1597]: ::1 2026-10-20 20:55:57.337 UTC [1597] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 131.971766] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-timescaledb> server # [ 131.981693] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.983295] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-timescaledb> server # [ 131.988822] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: DROP FUNCTION vm-test-run-timescaledb> server # [ 131.989640] postgres[1597]: ::1 2026-10-20 20:55:57.371 UTC [1597] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 131.991263] postgres[1597]: ::1 2026-10-20 20:55:57.383 UTC [1597] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 131.994738] postgres[1597]: DECLARE vm-test-run-timescaledb> server # [ 131.999699] postgres[1597]: cmd record; vm-test-run-timescaledb> server # [ 132.005419] postgres[1597]: BEGIN vm-test-run-timescaledb> server # [ 132.009515] postgres[1597]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 132.011362] postgres[1597]: LOOP vm-test-run-timescaledb> server # [ 132.012944] postgres[1597]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 132.015367] postgres[1597]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 132.017249] postgres[1597]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 132.019117] postgres[1597]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 132.019754] postgres[1597]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 132.023827] postgres[1597]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 132.025181] postgres[1597]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 132.025758] postgres[1597]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 132.026073] postgres[1597]: , 'CREATE TYPE' vm-test-run-timescaledb> server # [ 132.026629] postgres[1597]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 132.027297] postgres[1597]: , 'COMMENT' vm-test-run-timescaledb> server # [ 132.028016] postgres[1597]: ) vm-test-run-timescaledb> server # [ 132.029445] postgres[1597]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 132.030370] postgres[1597]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 132.031258] postgres[1597]: THEN vm-test-run-timescaledb> server # [ 132.031890] postgres[1597]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 132.032264] postgres[1597]: END IF; vm-test-run-timescaledb> server # [ 132.032690] postgres[1597]: END LOOP; vm-test-run-timescaledb> server # [ 132.033769] postgres[1597]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 132.034936] postgres[1597]: ::1 2026-10-20 20:55:57.420 UTC [1597] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 132.035880] postgres[1597]: DECLARE vm-test-run-timescaledb> server # [ 132.036732] postgres[1597]: obj record; vm-test-run-timescaledb> server # [ 132.037260] postgres[1597]: BEGIN vm-test-run-timescaledb> server # [ 132.037602] postgres[1597]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 132.038017] postgres[1597]: LOOP vm-test-run-timescaledb> server # [ 132.039911] postgres[1597]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 132.040628] postgres[1597]: 'schema' vm-test-run-timescaledb> server # [ 132.041816] postgres[1597]: , 'table' vm-test-run-timescaledb> server # [ 132.042282] postgres[1597]: , 'foreign table' vm-test-run-timescaledb> server # [ 132.042585] postgres[1597]: , 'view' vm-test-run-timescaledb> server # [ 132.042965] postgres[1597]: , 'materialized view' vm-test-run-timescaledb> server # [ 132.044051] postgres[1597]: , 'function' vm-test-run-timescaledb> server # [ 132.044386] postgres[1597]: , 'trigger' vm-test-run-timescaledb> server # [ 132.045539] postgres[1597]: , 'type' vm-test-run-timescaledb> server # [ 132.047613] postgres[1597]: , 'rule' vm-test-run-timescaledb> server # [ 132.048076] postgres[1597]: ) vm-test-run-timescaledb> server # [ 132.049425] postgres[1597]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 132.050104] postgres[1597]: THEN vm-test-run-timescaledb> server # [ 132.050504] postgres[1597]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 132.051885] postgres[1597]: END IF; vm-test-run-timescaledb> server # [ 132.052221] postgres[1597]: END LOOP; vm-test-run-timescaledb> server # [ 132.052464] postgres[1597]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 132.054031] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 132.054403] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 132.054688] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 132.056427] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 132.058190] postgres[1597]: ::1 2026-10-20 20:55:57.436 UTC [1597] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 132.058863] postgres[1597]: ::1 2026-10-20 20:55:57.445 UTC [1597] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 132.059869] postgres[1597]: ON ddl_command_end vm-test-run-timescaledb> server # [ 132.060166] postgres[1597]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 132.065975] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 132.069483] postgres[1597]: ::1 2026-10-20 20:55:57.465 UTC [1597] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 132.072887] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 132.074375] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 132.077134] postgres[1597]: ::1 2026-10-20 20:55:57.472 UTC [1597] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 132.078530] postgres[1597]: ON sql_drop vm-test-run-timescaledb> server # [ 132.079572] postgres[1597]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 132.091819] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1591]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 132.130480] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-timescaledb> server # [ 132.960033] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1598]: DO vm-test-run-timescaledb> server # [ 133.050669] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-timescaledb> server # [ 133.442961] postgres[1605]: ::1 2026-10-20 20:55:58.824 UTC [1605] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-timescaledb> server # [ 133.518800] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 133.520019] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping vm-test-run-timescaledb> server # [ 133.535315] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: DROP FUNCTION vm-test-run-timescaledb> server # [ 133.543192] postgres[1605]: ::1 2026-10-20 20:55:58.896 UTC [1605] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-timescaledb> server # [ 133.544072] postgres[1605]: ::1 2026-10-20 20:55:58.912 UTC [1605] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 133.550527] postgres[1605]: "operationName" text default null, vm-test-run-timescaledb> server # [ 133.561954] postgres[1605]: query text default null, vm-test-run-timescaledb> server # [ 133.562608] postgres[1605]: variables jsonb default null, vm-test-run-timescaledb> server # [ 133.563311] postgres[1605]: extensions jsonb default null vm-test-run-timescaledb> server # [ 133.563838] postgres[1605]: ) vm-test-run-timescaledb> server # [ 133.564086] postgres[1605]: returns jsonb vm-test-run-timescaledb> server # [ 133.570559] postgres[1605]: language plpgsql vm-test-run-timescaledb> server # [ 133.571700] postgres[1605]: as $$ vm-test-run-timescaledb> server # [ 133.583340] postgres[1605]: DECLARE vm-test-run-timescaledb> server # [ 133.590349] postgres[1605]: server_version float; vm-test-run-timescaledb> server # [ 133.590963] postgres[1605]: BEGIN vm-test-run-timescaledb> server # [ 133.598320] postgres[1605]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 133.610509] postgres[1605]: vm-test-run-timescaledb> server # [ 133.611597] postgres[1605]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 133.617444] postgres[1605]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 133.625954] postgres[1605]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 133.635565] postgres[1605]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 133.641671] postgres[1605]: ); vm-test-run-timescaledb> server # [ 133.643237] postgres[1605]: ELSE vm-test-run-timescaledb> server # [ 133.644034] postgres[1605]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 133.649570] postgres[1605]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 133.651351] postgres[1605]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 133.652718] postgres[1605]: ); vm-test-run-timescaledb> server # [ 133.654249] postgres[1605]: END IF; vm-test-run-timescaledb> server # [ 133.655134] postgres[1605]: END; vm-test-run-timescaledb> server # [ 133.655854] postgres[1605]: $$; vm-test-run-timescaledb> server # [ 133.658051] postgres[1605]: ::1 2026-10-20 20:55:58.948 UTC [1605] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.659597] postgres[1605]: ::1 2026-10-20 20:55:58.976 UTC [1605] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.661248] postgres[1605]: ::1 2026-10-20 20:55:59.011 UTC [1605] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.663133] postgres[1605]: ::1 2026-10-20 20:55:59.027 UTC [1605] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.665252] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 133.666084] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: GRANT vm-test-run-timescaledb> server # [ 133.667399] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.669622] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.671255] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.671798] postgres[1605]: ::1 2026-10-20 20:55:59.055 UTC [1605] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 133.672553] postgres[1605]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.694240] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.727308] postgres[1605]: ::1 2026-10-20 20:55:59.081 UTC [1605] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 133.762243] postgres[1605]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.765355] postgres[1605]: ::1 2026-10-20 20:55:59.116 UTC [1605] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 133.766925] postgres[1605]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.767797] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.769542] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.778840] postgres[1605]: ::1 2026-10-20 20:55:59.162 UTC [1605] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 133.793979] postgres[1605]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 133.794635] postgres[1605]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 133.794951] postgres[1605]: AS $func$ vm-test-run-timescaledb> server # [ 133.795214] postgres[1605]: DECLARE vm-test-run-timescaledb> server # [ 133.796256] postgres[1605]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 133.810641] postgres[1605]: BEGIN vm-test-run-timescaledb> server # [ 133.811770] postgres[1605]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 133.830458] postgres[1605]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 133.831179] postgres[1605]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 133.831521] postgres[1605]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 133.831777] postgres[1605]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 133.832363] postgres[1605]: ); vm-test-run-timescaledb> server # [ 133.839707] postgres[1605]: vm-test-run-timescaledb> server # [ 133.840937] postgres[1605]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 133.841494] postgres[1605]: THEN vm-test-run-timescaledb> server # [ 133.842180] postgres[1605]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.842926] postgres[1605]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.850774] postgres[1605]: vm-test-run-timescaledb> server # [ 133.851479] postgres[1605]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.858438] postgres[1605]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.859604] postgres[1605]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.873525] postgres[1605]: vm-test-run-timescaledb> server # [ 133.875117] postgres[1605]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 133.878226] postgres[1605]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 133.892939] postgres[1605]: "operationName" text default null, vm-test-run-timescaledb> server # [ 133.899747] postgres[1605]: query text default null, vm-test-run-timescaledb> server # [ 133.905718] postgres[1605]: variables jsonb default null, vm-test-run-timescaledb> server # [ 133.907928] postgres[1605]: extensions jsonb default null vm-test-run-timescaledb> server # [ 133.909275] postgres[1605]: ) vm-test-run-timescaledb> server # [ 133.910267] postgres[1605]: returns jsonb vm-test-run-timescaledb> server # [ 133.910886] postgres[1605]: language sql vm-test-run-timescaledb> server # [ 133.913534] postgres[1605]: as $$ vm-test-run-timescaledb> server # [ 133.914829] postgres[1605]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-timescaledb> server # [ 133.916897] postgres[1605]: $$; vm-test-run-timescaledb> server # [ 133.917957] postgres[1605]: vm-test-run-timescaledb> server # [ 133.918455] postgres[1605]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.919133] postgres[1605]: END IF; vm-test-run-timescaledb> server # [ 133.920083] postgres[1605]: vm-test-run-timescaledb> server # [ 133.923151] postgres[1605]: END; vm-test-run-timescaledb> server # [ 133.927460] postgres[1605]: $func$; vm-test-run-timescaledb> server # [ 133.929407] postgres[1605]: ::1 2026-10-20 20:55:59.182 UTC [1605] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-timescaledb> server # [ 133.930262] postgres[1605]: ::1 2026-10-20 20:55:59.190 UTC [1605] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION') vm-test-run-timescaledb> server # [ 133.931535] postgres[1605]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-timescaledb> server # [ 133.933365] postgres[1605]: ::1 2026-10-20 20:55:59.203 UTC [1605] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-timescaledb> server # [ 133.935841] postgres[1605]: ::1 2026-10-20 20:55:59.218 UTC [1605] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 133.937085] postgres[1605]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 133.937455] postgres[1605]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 133.937721] postgres[1605]: AS $func$ vm-test-run-timescaledb> server # [ 133.938311] postgres[1605]: DECLARE vm-test-run-timescaledb> server # [ 133.939188] postgres[1605]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 133.940380] postgres[1605]: BEGIN vm-test-run-timescaledb> server # [ 133.947358] postgres[1605]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 133.958819] postgres[1605]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 133.981903] postgres[1605]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 133.984082] postgres[1605]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 134.004903] postgres[1605]: ); vm-test-run-timescaledb> server # [ 134.006493] postgres[1605]: vm-test-run-timescaledb> server # [ 134.008013] postgres[1605]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 134.017722] postgres[1605]: THEN vm-test-run-timescaledb> server # [ 134.026270] postgres[1605]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 134.033690] postgres[1605]: "operationName" text default null, vm-test-run-timescaledb> server # [ 134.034972] postgres[1605]: query text default null, vm-test-run-timescaledb> server # [ 134.035471] postgres[1605]: variables jsonb default null, vm-test-run-timescaledb> server # [ 134.041450] postgres[1605]: extensions jsonb default null vm-test-run-timescaledb> server # [ 134.053336] postgres[1605]: ) vm-test-run-timescaledb> server # [ 134.055075] postgres[1605]: returns jsonb vm-test-run-timescaledb> server # [ 134.055683] postgres[1605]: language plpgsql vm-test-run-timescaledb> server # [ 134.056324] postgres[1605]: as $$ vm-test-run-timescaledb> server # [ 134.066080] postgres[1605]: DECLARE vm-test-run-timescaledb> server # [ 134.066495] postgres[1605]: server_version float; vm-test-run-timescaledb> server # [ 134.066788] postgres[1605]: BEGIN vm-test-run-timescaledb> server # [ 134.067081] postgres[1605]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 134.068244] postgres[1605]: vm-test-run-timescaledb> server # [ 134.076981] postgres[1605]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 134.078374] postgres[1605]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 134.079564] postgres[1605]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 134.079956] postgres[1605]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 134.089252] postgres[1605]: ); vm-test-run-timescaledb> server # [ 134.091031] postgres[1605]: ELSE vm-test-run-timescaledb> server # [ 134.099133] postgres[1605]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 134.101060] postgres[1605]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 134.103274] postgres[1605]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 134.111636] postgres[1605]: ); vm-test-run-timescaledb> server # [ 134.114200] postgres[1605]: END IF; vm-test-run-timescaledb> server # [ 134.116623] postgres[1605]: END; vm-test-run-timescaledb> server # [ 134.118593] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 134.121424] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping vm-test-run-timescaledb> server # [ 134.123909] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.125565] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.126077] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: COMMENT vm-test-run-timescaledb> server # [ 134.126777] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 134.127589] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping vm-test-run-timescaledb> server # [ 134.130576] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.133381] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.134046] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1602]: COMMENT vm-test-run-timescaledb> server # [ 134.135464] postgres[1605]: $$; vm-test-run-timescaledb> server # [ 134.136020] postgres[1605]: END IF; vm-test-run-timescaledb> server # [ 134.137540] postgres[1605]: vm-test-run-timescaledb> server # [ 134.138425] postgres[1605]: END; vm-test-run-timescaledb> server # [ 134.138996] postgres[1605]: $func$; vm-test-run-timescaledb> server # [ 134.139325] postgres[1605]: ::1 2026-10-20 20:55:59.300 UTC [1605] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-timescaledb> server # [ 134.139961] postgres[1605]: ::1 2026-10-20 20:55:59.316 UTC [1605] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-timescaledb> server # [ 134.142668] postgres[1605]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-timescaledb> server # [ 134.143263] postgres[1605]: ::1 2026-10-20 20:55:59.342 UTC [1605] 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 # [ 134.150921] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-timescaledb> server # [ 134.450014] postgres[1618]: ::1 2026-10-20 20:55:59.819 UTC [1618] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 134.452088] postgres[1618]: ::1 2026-10-20 20:55:59.836 UTC [1618] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 134.471805] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1613]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-timescaledb> server # [ 134.483360] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1613]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.497007] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1613]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-timescaledb> server # [ 134.505343] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1613]: DROP FUNCTION vm-test-run-timescaledb> server # [ 134.507404] postgres[1618]: ::1 2026-10-20 20:55:59.876 UTC [1618] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 134.508871] postgres[1618]: DECLARE vm-test-run-timescaledb> server # [ 134.515290] postgres[1618]: cmd record; vm-test-run-timescaledb> server # [ 134.522585] postgres[1618]: BEGIN vm-test-run-timescaledb> server # [ 134.523107] postgres[1618]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 134.523422] postgres[1618]: LOOP vm-test-run-timescaledb> server # [ 134.523665] postgres[1618]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 134.523919] postgres[1618]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 134.524181] postgres[1618]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 134.528040] postgres[1618]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 134.530127] postgres[1618]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 134.531439] postgres[1618]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 134.537304] postgres[1618]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 134.538343] postgres[1618]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 134.538838] postgres[1618]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-timescaledb> server # [ 134.545338] postgres[1618]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 134.550489] postgres[1618]: , 'COMMENT' vm-test-run-timescaledb> server # [ 134.551159] postgres[1618]: ) vm-test-run-timescaledb> server # [ 134.551482] postgres[1618]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 134.551784] postgres[1618]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 134.553266] postgres[1618]: THEN vm-test-run-timescaledb> server # [ 134.553754] postgres[1618]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 134.554332] postgres[1618]: END IF; vm-test-run-timescaledb> server # [ 134.554601] postgres[1618]: END LOOP; vm-test-run-timescaledb> server # [ 134.554851] postgres[1618]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 134.555578] postgres[1618]: ::1 2026-10-20 20:55:59.952 UTC [1618] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 134.556180] postgres[1618]: DECLARE vm-test-run-timescaledb> server # [ 134.563434] postgres[1618]: obj record; vm-test-run-timescaledb> server # [ 134.566363] postgres[1618]: BEGIN vm-test-run-timescaledb> server # [ 134.567122] postgres[1618]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 134.567442] postgres[1618]: LOOP vm-test-run-timescaledb> server # [ 134.567676] postgres[1618]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 134.567918] postgres[1618]: 'schema' vm-test-run-timescaledb> server # [ 134.568142] postgres[1618]: , 'table' vm-test-run-timescaledb> server # [ 134.573297] postgres[1618]: , 'foreign table' vm-test-run-timescaledb> server # [ 134.574173] postgres[1618]: , 'view' vm-test-run-timescaledb> server # [ 134.574488] postgres[1618]: , 'materialized view' vm-test-run-timescaledb> server # [ 134.574963] postgres[1618]: , 'function' vm-test-run-timescaledb> server # [ 134.575223] postgres[1618]: , 'trigger' vm-test-run-timescaledb> server # [ 134.575462] postgres[1618]: , 'type' vm-test-run-timescaledb> server # [ 134.575688] postgres[1618]: , 'rule' vm-test-run-timescaledb> server # [ 134.575914] postgres[1618]: ) vm-test-run-timescaledb> server # [ 134.576139] postgres[1618]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 134.581719] postgres[1618]: THEN vm-test-run-timescaledb> server # [ 134.583082] postgres[1618]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 134.583614] postgres[1618]: END IF; vm-test-run-timescaledb> server # [ 134.583889] postgres[1618]: END LOOP; vm-test-run-timescaledb> server # [ 134.584147] postgres[1618]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 134.590535] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1613]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 134.594513] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1613]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 134.595566] postgres[1618]: ::1 2026-10-20 20:55:59.992 UTC [1618] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 134.609178] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1613]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.610681] postgres[1618]: ::1 2026-10-20 20:56:00.006 UTC [1618] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 134.611338] postgres[1618]: ON ddl_command_end vm-test-run-timescaledb> server # [ 134.612017] postgres[1618]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 134.626537] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1613]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.627551] postgres[1618]: ::1 2026-10-20 20:56:00.024 UTC [1618] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 134.645532] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1613]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.651070] postgres[1618]: ::1 2026-10-20 20:56:00.038 UTC [1618] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 134.652691] postgres[1618]: ON sql_drop vm-test-run-timescaledb> server # [ 134.661089] postgres[1618]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 134.663408] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1613]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 134.702112] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-timescaledb> server # [ 135.012869] postgres[1629]: ::1 2026-10-20 20:56:00.396 UTC [1629] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-timescaledb> server # [ 135.037748] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1627]: ALTER ROLE vm-test-run-timescaledb> server # [ 135.074698] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-timescaledb> server # [ 135.412542] postgres[1635]: ::1 2026-10-20 20:56:00.798 UTC [1635] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 135.417725] postgres[1635]: returns event_trigger vm-test-run-timescaledb> server # [ 135.418921] postgres[1635]: language plpgsql vm-test-run-timescaledb> server # [ 135.419893] postgres[1635]: AS $func$ vm-test-run-timescaledb> server # [ 135.430315] postgres[1635]: DECLARE vm-test-run-timescaledb> server # [ 135.431500] postgres[1635]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 135.432300] postgres[1635]: BEGIN vm-test-run-timescaledb> server # [ 135.441329] postgres[1635]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 135.442240] postgres[1635]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 135.457615] postgres[1635]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 135.458548] postgres[1635]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 135.458981] postgres[1635]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 135.459849] postgres[1635]: ); vm-test-run-timescaledb> server # [ 135.468649] postgres[1635]: vm-test-run-timescaledb> server # [ 135.469414] postgres[1635]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 135.469752] postgres[1635]: THEN vm-test-run-timescaledb> server # [ 135.470407] postgres[1635]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.471315] postgres[1635]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.482101] postgres[1635]: vm-test-run-timescaledb> server # [ 135.483893] postgres[1635]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.494784] postgres[1635]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.496997] postgres[1635]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.498318] postgres[1635]: vm-test-run-timescaledb> server # [ 135.509142] postgres[1635]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 135.510077] postgres[1635]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 135.510823] postgres[1635]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 135.511730] postgres[1635]: "operationName" text default null, vm-test-run-timescaledb> server # [ 135.521785] postgres[1635]: query text default null, vm-test-run-timescaledb> server # [ 135.522554] postgres[1635]: variables jsonb default null, vm-test-run-timescaledb> server # [ 135.523948] postgres[1635]: extensions jsonb default null vm-test-run-timescaledb> server # [ 135.530281] postgres[1635]: ) vm-test-run-timescaledb> server # [ 135.538642] postgres[1635]: returns jsonb vm-test-run-timescaledb> server # [ 135.540093] postgres[1635]: language sql vm-test-run-timescaledb> server # [ 135.546950] postgres[1635]: as $$ vm-test-run-timescaledb> server # [ 135.553376] postgres[1635]: -- This changed vm-test-run-timescaledb> server # [ 135.554768] postgres[1635]: select graphql.resolve( vm-test-run-timescaledb> server # [ 135.560250] postgres[1635]: query := query, vm-test-run-timescaledb> server # [ 135.572846] postgres[1635]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 135.574081] postgres[1635]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 135.574469] postgres[1635]: extensions := extensions vm-test-run-timescaledb> server # [ 135.574939] postgres[1635]: ); vm-test-run-timescaledb> server # [ 135.575376] postgres[1635]: $$; vm-test-run-timescaledb> server # [ 135.576018] postgres[1635]: vm-test-run-timescaledb> server # [ 135.585028] postgres[1635]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.586391] postgres[1635]: END IF; vm-test-run-timescaledb> server # [ 135.587327] postgres[1635]: vm-test-run-timescaledb> server # [ 135.589228] postgres[1635]: END; vm-test-run-timescaledb> server # [ 135.590270] postgres[1635]: $func$; vm-test-run-timescaledb> server # [ 135.591495] postgres[1635]: ::1 2026-10-20 20:56:00.962 UTC [1635] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 135.599107] postgres[1635]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 135.602843] postgres[1635]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 135.607479] postgres[1635]: AS $func$ vm-test-run-timescaledb> server # [ 135.613305] postgres[1635]: DECLARE vm-test-run-timescaledb> server # [ 135.616050] postgres[1635]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 135.621586] postgres[1635]: BEGIN vm-test-run-timescaledb> server # [ 135.622694] postgres[1635]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 135.623246] postgres[1635]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 135.630216] postgres[1635]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 135.631596] postgres[1635]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 135.638587] postgres[1635]: ); vm-test-run-timescaledb> server # [ 135.639035] postgres[1635]: vm-test-run-timescaledb> server # [ 135.639397] postgres[1635]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 135.639834] postgres[1635]: THEN vm-test-run-timescaledb> server # [ 135.640124] postgres[1635]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 135.640400] postgres[1635]: "operationName" text default null, vm-test-run-timescaledb> server # [ 135.641066] postgres[1635]: query text default null, vm-test-run-timescaledb> server # [ 135.642330] postgres[1635]: variables jsonb default null, vm-test-run-timescaledb> server # [ 135.643298] postgres[1635]: extensions jsonb default null vm-test-run-timescaledb> server # [ 135.643644] postgres[1635]: ) vm-test-run-timescaledb> server # [ 135.651760] postgres[1635]: returns jsonb vm-test-run-timescaledb> server # [ 135.656121] postgres[1635]: language plpgsql vm-test-run-timescaledb> server # [ 135.663575] postgres[1635]: as $$ vm-test-run-timescaledb> server # [ 135.664922] postgres[1635]: DECLARE vm-test-run-timescaledb> server # [ 135.665544] postgres[1635]: server_version float; vm-test-run-timescaledb> server # [ 135.666242] postgres[1635]: BEGIN vm-test-run-timescaledb> server # [ 135.667158] postgres[1635]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 135.667660] postgres[1635]: vm-test-run-timescaledb> server # [ 135.672929] postgres[1635]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 135.674498] postgres[1635]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.675297] postgres[1635]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 135.675808] postgres[1635]: jsonb_build_object( vm-test-run-timescaledb> server # [ 135.677065] postgres[1635]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 135.679670] postgres[1635]: ) vm-test-run-timescaledb> server # [ 135.681245] postgres[1635]: ) vm-test-run-timescaledb> server # [ 135.685333] postgres[1635]: ); vm-test-run-timescaledb> server # [ 135.688680] postgres[1635]: ELSE vm-test-run-timescaledb> server # [ 135.689688] postgres[1635]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.690311] postgres[1635]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 135.690767] postgres[1635]: jsonb_build_object( vm-test-run-timescaledb> server # [ 135.692686] postgres[1635]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 135.696353] postgres[1635]: ) vm-test-run-timescaledb> server # [ 135.699109] postgres[1635]: ) vm-test-run-timescaledb> server # [ 135.704916] postgres[1635]: ); vm-test-run-timescaledb> server # [ 135.706170] postgres[1635]: END IF; vm-test-run-timescaledb> server # [ 135.707082] postgres[1635]: END; vm-test-run-timescaledb> server # [ 135.707511] postgres[1635]: $$; vm-test-run-timescaledb> server # [ 135.707959] postgres[1635]: END IF; vm-test-run-timescaledb> server # [ 135.712774] postgres[1635]: vm-test-run-timescaledb> server # [ 135.715552] postgres[1635]: END; vm-test-run-timescaledb> server # [ 135.718922] postgres[1635]: $func$; vm-test-run-timescaledb> server # [ 135.734996] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1632]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 135.736009] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1632]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 135.744030] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1632]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 135.748483] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1632]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping vm-test-run-timescaledb> server # [ 135.769113] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1632]: DROP EXTENSION vm-test-run-timescaledb> server # [ 135.771327] postgres[1635]: ::1 2026-10-20 20:56:01.007 UTC [1635] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 135.773757] postgres[1635]: "operationName" text default null, vm-test-run-timescaledb> server # [ 135.775224] postgres[1635]: query text default null, vm-test-run-timescaledb> server # [ 135.776398] postgres[1635]: variables jsonb default null, vm-test-run-timescaledb> server # [ 135.778394] postgres[1635]: extensions jsonb default null vm-test-run-timescaledb> server # [ 135.787079] postgres[1635]: ) vm-test-run-timescaledb> server # [ 135.788150] postgres[1635]: returns jsonb vm-test-run-timescaledb> server # [ 135.793621] postgres[1635]: language plpgsql vm-test-run-timescaledb> server # [ 135.799043] postgres[1635]: as $$ vm-test-run-timescaledb> server # [ 135.802209] postgres[1635]: DECLARE vm-test-run-timescaledb> server # [ 135.803718] postgres[1635]: server_version float; vm-test-run-timescaledb> server # [ 135.807220] postgres[1635]: BEGIN vm-test-run-timescaledb> server # [ 135.808132] postgres[1635]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 135.809400] postgres[1635]: vm-test-run-timescaledb> server # [ 135.811475] postgres[1635]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 135.814701] postgres[1635]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.815191] postgres[1635]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 135.815491] postgres[1635]: jsonb_build_object( vm-test-run-timescaledb> server # [ 135.816666] postgres[1635]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 135.818125] postgres[1635]: ) vm-test-run-timescaledb> server # [ 135.818461] postgres[1635]: ) vm-test-run-timescaledb> server # [ 135.819211] postgres[1635]: ); vm-test-run-timescaledb> server # [ 135.819525] postgres[1635]: ELSE vm-test-run-timescaledb> server # [ 135.821297] postgres[1635]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.834398] postgres[1635]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 135.838901] postgres[1635]: jsonb_build_object( vm-test-run-timescaledb> server # [ 135.839926] postgres[1635]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 135.843571] postgres[1635]: ) vm-test-run-timescaledb> server # [ 135.845102] postgres[1635]: ) vm-test-run-timescaledb> server # [ 135.846507] postgres[1635]: ); vm-test-run-timescaledb> server # [ 135.847585] postgres[1635]: END IF; vm-test-run-timescaledb> server # [ 135.849111] postgres[1635]: END; vm-test-run-timescaledb> server # [ 135.850473] postgres[1635]: $$; vm-test-run-timescaledb> server # [ 135.851666] postgres[1635]: ::1 2026-10-20 20:56:01.047 UTC [1635] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 137.571623] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1632]: DO vm-test-run-timescaledb> server # [ 137.623148] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql vm-test-run-timescaledb> server # [ 138.051850] postgres[1654]: ::1 2026-10-20 20:56:03.431 UTC [1654] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-timescaledb> server # [ 138.095541] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1651]: GRANT ROLE vm-test-run-timescaledb> server # [ 138.132948] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-timescaledb> server # [ 138.494651] postgres[1663]: ::1 2026-10-20 20:56:03.887 UTC [1663] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 138.496315] postgres[1663]: returns event_trigger vm-test-run-timescaledb> server # [ 138.505418] postgres[1663]: language plpgsql vm-test-run-timescaledb> server # [ 138.506296] postgres[1663]: AS $func$ vm-test-run-timescaledb> server # [ 138.508392] postgres[1663]: DECLARE vm-test-run-timescaledb> server # [ 138.514229] postgres[1663]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 138.516064] postgres[1663]: BEGIN vm-test-run-timescaledb> server # [ 138.518626] postgres[1663]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 138.519714] postgres[1663]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 138.521068] postgres[1663]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 138.523082] postgres[1663]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 138.523849] postgres[1663]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 138.526005] postgres[1663]: ); vm-test-run-timescaledb> server # [ 138.527098] postgres[1663]: vm-test-run-timescaledb> server # [ 138.528012] postgres[1663]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 138.528933] postgres[1663]: THEN vm-test-run-timescaledb> server # [ 138.529494] postgres[1663]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 138.530052] postgres[1663]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 138.530562] postgres[1663]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 138.531874] postgres[1663]: "operationName" text default null, vm-test-run-timescaledb> server # [ 138.532806] postgres[1663]: query text default null, vm-test-run-timescaledb> server # [ 138.534838] postgres[1663]: variables jsonb default null, vm-test-run-timescaledb> server # [ 138.535840] postgres[1663]: extensions jsonb default null vm-test-run-timescaledb> server # [ 138.537893] postgres[1663]: ) vm-test-run-timescaledb> server # [ 138.538436] postgres[1663]: returns jsonb vm-test-run-timescaledb> server # [ 138.538927] postgres[1663]: language sql vm-test-run-timescaledb> server # [ 138.539215] postgres[1663]: as $$ vm-test-run-timescaledb> server # [ 138.539439] postgres[1663]: select graphql.resolve( vm-test-run-timescaledb> server # [ 138.540094] postgres[1663]: query := query, vm-test-run-timescaledb> server # [ 138.541711] postgres[1663]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 138.542542] postgres[1663]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 138.542901] postgres[1663]: extensions := extensions vm-test-run-timescaledb> server # [ 138.543172] postgres[1663]: ); vm-test-run-timescaledb> server # [ 138.543641] postgres[1663]: $$; vm-test-run-timescaledb> server # [ 138.544499] postgres[1663]: vm-test-run-timescaledb> server # [ 138.545571] postgres[1663]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 138.546812] postgres[1663]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 138.547745] postgres[1663]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 138.548518] postgres[1663]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.549636] postgres[1663]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.551369] postgres[1663]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.553186] postgres[1663]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.554200] postgres[1663]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.554961] postgres[1663]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.556052] postgres[1663]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 138.557661] postgres[1663]: END IF; vm-test-run-timescaledb> server # [ 138.558537] postgres[1663]: vm-test-run-timescaledb> server # [ 138.559560] postgres[1663]: END; vm-test-run-timescaledb> server # [ 138.561451] postgres[1663]: $func$; vm-test-run-timescaledb> server # [ 138.621265] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1660]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 138.626494] postgres[1663]: ::1 2026-10-20 20:56:04.012 UTC [1663] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 138.670483] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1660]: DROP EXTENSION vm-test-run-timescaledb> server # [ 140.558222] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1660]: DO vm-test-run-timescaledb> server # [ 140.594342] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-timescaledb> server # [ 141.702471] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1682]: DO vm-test-run-timescaledb> server # [ 142.373227] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1682]: DO vm-test-run-timescaledb> server # [ 142.422290] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-timescaledb> server # [ 142.669578] postgres[1695]: ::1 2026-10-20 20:56:08.060 UTC [1695] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 142.682067] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1694]: ALTER ROLE vm-test-run-timescaledb> server # [ 142.724210] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-timescaledb> server # [ 143.135459] postgres[1700]: ::1 2026-10-20 20:56:08.517 UTC [1700] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-timescaledb> server # [ 143.198986] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1696]: REVOKE ROLE vm-test-run-timescaledb> server # [ 143.224808] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-timescaledb> server # [ 145.877691] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1702]: DO vm-test-run-timescaledb> server # [ 145.916061] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 146.169196] postgres[1729]: ::1 2026-10-20 20:56:11.558 UTC [1729] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-timescaledb> server # [ 146.194691] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1728]: GRANT ROLE vm-test-run-timescaledb> server # [ 146.236229] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-timescaledb> server # [ 146.498775] postgres[1731]: ::1 2026-10-20 20:56:11.889 UTC [1731] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 146.590864] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1730]: GRANT vm-test-run-timescaledb> server # [ 146.592072] postgres[1731]: ::1 2026-10-20 20:56:11.980 UTC [1731] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 146.643157] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1730]: GRANT vm-test-run-timescaledb> server # [ 146.646443] postgres[1731]: ::1 2026-10-20 20:56:12.040 UTC [1731] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 146.649410] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1730]: GRANT vm-test-run-timescaledb> server # [ 146.661427] postgres[1731]: ::1 2026-10-20 20:56:12.049 UTC [1731] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 146.673014] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1730]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 146.674909] postgres[1731]: ::1 2026-10-20 20:56:12.071 UTC [1731] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option; vm-test-run-timescaledb> server # [ 146.685535] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1730]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 146.689278] postgres[1731]: ::1 2026-10-20 20:56:12.083 UTC [1731] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 146.706985] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1730]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 146.793022] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-timescaledb> server # [ 147.256630] postgres[1745]: ::1 2026-10-20 20:56:12.650 UTC [1745] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-timescaledb> server # [ 147.306151] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1738]: GRANT ROLE vm-test-run-timescaledb> server # [ 147.362293] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 147.932396] postgres[1756]: ::1 2026-10-20 20:56:13.279 UTC [1756] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-timescaledb> server # [ 147.981391] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1750]: GRANT ROLE vm-test-run-timescaledb> server # [ 148.001479] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-timescaledb> server # [ 148.369288] postgres[1761]: ::1 2026-10-20 20:56:13.760 UTC [1761] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-timescaledb> server # [ 148.383988] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1759]: ALTER ROLE vm-test-run-timescaledb> server # [ 148.396648] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1759]: ALTER ROLE vm-test-run-timescaledb> server # [ 148.414337] postgres[1761]: ::1 2026-10-20 20:56:13.782 UTC [1761] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-timescaledb> server # [ 148.416281] postgres[1761]: ::1 2026-10-20 20:56:13.789 UTC [1761] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-timescaledb> server # [ 148.438742] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1759]: ALTER ROLE vm-test-run-timescaledb> server # [ 148.439873] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1759]: DO vm-test-run-timescaledb> server # [ 148.499245] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 148.747799] postgres[1763]: ::1 2026-10-20 20:56:14.140 UTC [1763] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-timescaledb> server # [ 148.773307] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1762]: GRANT ROLE vm-test-run-timescaledb> server # [ 148.778863] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1762]: REVOKE ROLE vm-test-run-timescaledb> server # [ 148.781604] postgres[1763]: ::1 2026-10-20 20:56:14.161 UTC [1763] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-timescaledb> server # [ 148.822887] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-timescaledb> server # [ 149.173105] postgres[1766]: ::1 2026-10-20 20:56:14.557 UTC [1766] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 149.174956] postgres[1766]: returns event_trigger vm-test-run-timescaledb> server # [ 149.175748] postgres[1766]: language plpgsql vm-test-run-timescaledb> server # [ 149.182278] postgres[1766]: AS $func$ vm-test-run-timescaledb> server # [ 149.183103] postgres[1766]: DECLARE vm-test-run-timescaledb> server # [ 149.183486] postgres[1766]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 149.184319] postgres[1766]: BEGIN vm-test-run-timescaledb> server # [ 149.189854] postgres[1766]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 149.190700] postgres[1766]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 149.192157] postgres[1766]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 149.201181] postgres[1766]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 149.202231] postgres[1766]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 149.202729] postgres[1766]: ); vm-test-run-timescaledb> server # [ 149.203444] postgres[1766]: vm-test-run-timescaledb> server # [ 149.203750] postgres[1766]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 149.204407] postgres[1766]: THEN vm-test-run-timescaledb> server # [ 149.210285] postgres[1766]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 149.215558] postgres[1766]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 149.221694] postgres[1766]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 149.223974] postgres[1766]: "operationName" text default null, vm-test-run-timescaledb> server # [ 149.233415] postgres[1766]: query text default null, vm-test-run-timescaledb> server # [ 149.234743] postgres[1766]: variables jsonb default null, vm-test-run-timescaledb> server # [ 149.241459] postgres[1766]: extensions jsonb default null vm-test-run-timescaledb> server # [ 149.242684] postgres[1766]: ) vm-test-run-timescaledb> server # [ 149.243730] postgres[1766]: returns jsonb vm-test-run-timescaledb> server # [ 149.258332] postgres[1766]: language sql vm-test-run-timescaledb> server # [ 149.259119] postgres[1766]: as $$ vm-test-run-timescaledb> server # [ 149.259628] postgres[1766]: select graphql.resolve( vm-test-run-timescaledb> server # [ 149.260047] postgres[1766]: query := query, vm-test-run-timescaledb> server # [ 149.263206] postgres[1766]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 149.265144] postgres[1766]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 149.265576] postgres[1766]: extensions := extensions vm-test-run-timescaledb> server # [ 149.266008] postgres[1766]: ); vm-test-run-timescaledb> server # [ 149.266415] postgres[1766]: $$; vm-test-run-timescaledb> server # [ 149.266883] postgres[1766]: vm-test-run-timescaledb> server # [ 149.267890] postgres[1766]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 149.270991] postgres[1766]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 149.273004] postgres[1766]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 149.275579] postgres[1766]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.278524] postgres[1766]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.278980] postgres[1766]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.281152] postgres[1766]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.281685] postgres[1766]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.283213] postgres[1766]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.283874] postgres[1766]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 149.286077] postgres[1766]: vm-test-run-timescaledb> server # [ 149.286557] postgres[1766]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-timescaledb> server # [ 149.287282] postgres[1766]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-timescaledb> server # [ 149.287995] postgres[1766]: grant usage on schema graphql to postgres with grant option; vm-test-run-timescaledb> server # [ 149.288416] postgres[1766]: END IF; vm-test-run-timescaledb> server # [ 149.304929] postgres[1766]: vm-test-run-timescaledb> server # [ 149.305569] postgres[1766]: END; vm-test-run-timescaledb> server # [ 149.306265] postgres[1766]: $func$; vm-test-run-timescaledb> server # [ 149.333603] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1764]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 149.341570] postgres[1766]: ::1 2026-10-20 20:56:14.727 UTC [1766] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 149.453863] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1764]: DROP EXTENSION vm-test-run-timescaledb> server # [ 151.384643] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1764]: DO vm-test-run-timescaledb> server # [ 151.430406] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-timescaledb> server # [ 151.740036] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1794]: DO vm-test-run-timescaledb> server # [ 151.747889] postgres[1795]: ::1 2026-10-20 20:56:17.140 UTC [1795] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-timescaledb> server # [ 151.754802] postgres[1795]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 151.756980] postgres[1795]: AS $$ vm-test-run-timescaledb> server # [ 151.758004] postgres[1795]: BEGIN vm-test-run-timescaledb> server # [ 151.758557] postgres[1795]: IF EXISTS ( vm-test-run-timescaledb> server # [ 151.761167] postgres[1795]: SELECT vm-test-run-timescaledb> server # [ 151.762476] postgres[1795]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 151.763282] postgres[1795]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 151.765170] postgres[1795]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 151.765774] postgres[1795]: WHERE ext.extname = 'pg_cron' vm-test-run-timescaledb> server # [ 151.766598] postgres[1795]: ) vm-test-run-timescaledb> server # [ 151.766924] postgres[1795]: THEN vm-test-run-timescaledb> server # [ 151.767481] postgres[1795]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 151.767849] postgres[1795]: vm-test-run-timescaledb> server # [ 151.769480] postgres[1795]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 151.770250] postgres[1795]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 151.771663] postgres[1795]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 151.772243] postgres[1795]: vm-test-run-timescaledb> server # [ 151.773214] postgres[1795]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 151.773755] postgres[1795]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 151.774445] postgres[1795]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 151.775135] postgres[1795]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 151.775787] postgres[1795]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 151.778172] postgres[1795]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 151.779066] postgres[1795]: vm-test-run-timescaledb> server # [ 151.779463] postgres[1795]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 151.779769] postgres[1795]: revoke all on table cron.job from postgres; vm-test-run-timescaledb> server # [ 151.780106] postgres[1795]: grant select on table cron.job to postgres with grant option; vm-test-run-timescaledb> server # [ 151.780516] postgres[1795]: END IF; vm-test-run-timescaledb> server # [ 151.782292] postgres[1795]: END; vm-test-run-timescaledb> server # [ 151.782623] postgres[1795]: $$; vm-test-run-timescaledb> server # [ 151.807975] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1794]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 151.814383] postgres[1795]: ::1 2026-10-20 20:56:17.206 UTC [1795] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-timescaledb> server # [ 151.820858] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1794]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 151.826925] postgres[1795]: ::1 2026-10-20 20:56:17.221 UTC [1795] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-timescaledb> server # [ 151.842275] postgres[1795]: ::1 2026-10-20 20:56:17.235 UTC [1795] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-timescaledb> server # [ 151.845005] postgres[1795]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-timescaledb> server # [ 151.846339] postgres[1795]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 151.849339] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1794]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 151.856860] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1794]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 151.886303] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-timescaledb> server # [ 152.143474] postgres[1797]: ::1 2026-10-20 20:56:17.535 UTC [1797] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-timescaledb> server # [ 152.155835] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1796]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.207347] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-timescaledb> server # [ 152.441036] postgres[1799]: ::1 2026-10-20 20:56:17.833 UTC [1799] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-timescaledb> server # [ 152.476124] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1798]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 152.478303] postgres[1799]: ::1 2026-10-20 20:56:17.871 UTC [1799] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-timescaledb> server # [ 152.493672] postgres[1799]: ::1 2026-10-20 20:56:17.877 UTC [1799] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-timescaledb> server # [ 152.503180] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1798]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 152.510474] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1798]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 152.530552] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 152.915027] postgres[1804]: ::1 2026-10-20 20:56:18.292 UTC [1804] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-timescaledb> server # [ 152.951557] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1800]: GRANT ROLE vm-test-run-timescaledb> server # [ 152.982975] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-timescaledb> server # [ 154.011553] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1809]: DO vm-test-run-timescaledb> server # [ 154.081354] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-timescaledb> server # [ 154.470076] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1826]: DO vm-test-run-timescaledb> server # [ 154.479832] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1826]: DO vm-test-run-timescaledb> server # [ 154.516357] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-timescaledb> server # [ 154.917861] postgres[1834]: ::1 2026-10-20 20:56:20.298 UTC [1834] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-timescaledb> server # [ 154.944377] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1830]: ALTER ROLE vm-test-run-timescaledb> server # [ 154.951359] postgres[1834]: ::1 2026-10-20 20:56:20.328 UTC [1834] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-timescaledb> server # [ 154.958210] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1830]: ALTER ROLE vm-test-run-timescaledb> server # [ 154.963408] postgres[1834]: ::1 2026-10-20 20:56:20.350 UTC [1834] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-timescaledb> server # [ 154.970863] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1830]: ALTER ROLE vm-test-run-timescaledb> server # [ 155.007137] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-timescaledb> server # [ 155.372021] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1836]: DO vm-test-run-timescaledb> server # [ 155.419695] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-timescaledb> server # [ 155.711547] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1838]: DO vm-test-run-timescaledb> server # [ 155.755039] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-timescaledb> server # [ 156.137579] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1840]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 156.168811] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1840]: DO vm-test-run-timescaledb> server # [ 156.239496] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-timescaledb> server # [ 156.749144] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1847]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 156.765237] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1847]: GRANT vm-test-run-timescaledb> server # [ 156.875559] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-timescaledb> server # [ 157.287616] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1860]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 157.363489] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1860]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 157.394501] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1860]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 157.458455] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 157.786187] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1870]: DO vm-test-run-timescaledb> server # [ 157.821639] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-timescaledb> server # [ 158.154369] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1872]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 158.155979] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1872]: GRANT vm-test-run-timescaledb> server # [ 158.205620] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-timescaledb> server # [ 158.539189] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1874]: REVOKE ROLE vm-test-run-timescaledb> server # [ 158.605098] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1874]: DO vm-test-run-timescaledb> server # [ 158.629345] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1874]: DO vm-test-run-timescaledb> server # [ 158.646838] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1874]: REVOKE ROLE vm-test-run-timescaledb> server # [ 158.662635] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1874]: REVOKE vm-test-run-timescaledb> server # [ 158.693306] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1874]: DO vm-test-run-timescaledb> server # [ 158.742827] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 159.205700] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1880]: DO vm-test-run-timescaledb> server # [ 159.235338] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 159.808818] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1883]: DO vm-test-run-timescaledb> server # [ 159.819327] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 160.331205] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1896]: DO vm-test-run-timescaledb> server # [ 160.376857] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-timescaledb> server # [ 160.812915] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1906]: ALTER ROLE vm-test-run-timescaledb> server # [ 160.814271] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-timescaledb> server # [ 161.166077] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1912]: GRANT ROLE vm-test-run-timescaledb> server # [ 161.177126] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1912]: DO vm-test-run-timescaledb> server # [ 161.203354] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-timescaledb> server # [ 161.517368] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1914]: GRANT vm-test-run-timescaledb> server # [ 161.524846] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-timescaledb> server # [ 161.826650] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1916]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 161.834170] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1916]: REVOKE vm-test-run-timescaledb> server # [ 161.851179] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1916]: REVOKE vm-test-run-timescaledb> server # [ 161.866095] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1916]: GRANT vm-test-run-timescaledb> server # [ 161.907929] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-timescaledb> server # [ 162.338389] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1918]: DO vm-test-run-timescaledb> server # [ 162.382627] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-timescaledb> server # [ 162.938414] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1927]: ALTER ROLE vm-test-run-timescaledb> server # [ 163.009243] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-timescaledb> server # [ 163.533517] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1938]: DROP EXTENSION vm-test-run-timescaledb> server # [ 163.569974] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-timescaledb> server # [ 163.966888] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1948]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 163.975347] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1948]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 163.985925] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1948]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 164.028737] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-timescaledb> server # [ 164.280736] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1950]: DO vm-test-run-timescaledb> server # [ 164.304990] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1950]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 164.340594] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-timescaledb> server # [ 164.768266] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1952]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 164.779946] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1952]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 164.837993] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql vm-test-run-timescaledb> server # [ 165.342033] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1958]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 165.353653] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1958]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 165.401039] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1958]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 165.432920] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1958]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 165.462629] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1958]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 165.493431] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1958]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 165.565784] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Running postgresql schema... vm-test-run-timescaledb> server # [ 165.971281] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER DATABASE vm-test-run-timescaledb> server # [ 165.982956] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER DATABASE vm-test-run-timescaledb> server # [ 166.133000] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.257634] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.365724] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.464867] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.546771] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.628508] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.719604] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.798669] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.898938] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.916950] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1967]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.968868] 8jlxg6v2nk5mi3rk27gasxnffvkpqj8f-supabase-db-init[1425]: Database initialization complete vm-test-run-timescaledb> server # [ 167.031218] systemd[1]: Finished Supabase Database Initialization. vm-test-run-timescaledb> server # [ 167.040099] systemd[1]: Reached target Multi-User System. vm-test-run-timescaledb> server # [ 167.047585] systemd[1]: Startup finished in 20.818s (kernel) + 2min 26.204s (userspace) = 2min 47.023s. vm-test-run-timescaledb> server: (finished: waiting for unit supabase-db-init.service, in 169.92 seconds) vm-test-run-timescaledb> subtest: Check upgrade path with postgresql 15 vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" vm-test-run-timescaledb> server # NOTICE: extension "timescaledb" does not exist, skipping vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" , in 0.53 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 # [ 175.935750] postgres[2018]: [local] 2026-10-20 20:56:41.317 UTC [2018] supabase_admin@postgres WARNING: 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 # [ 175.955225] postgres[2018]: WELCOME TO vm-test-run-timescaledb> server # [ 175.962528] postgres[2018]: _____ _ _ ____________ vm-test-run-timescaledb> server # [ 175.963396] postgres[2018]: |_ _(_) | | | _ \ ___ \ vm-test-run-timescaledb> server # [ 175.965196] postgres[2018]: | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ / vm-test-run-timescaledb> server # [ 175.966227] postgres[2018]: | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \ vm-test-run-timescaledb> server # [ 175.966656] postgres[2018]: | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ / vm-test-run-timescaledb> server # [ 175.967950] postgres[2018]: |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/ vm-test-run-timescaledb> server # [ 175.977258] postgres[2018]: Running version 2.9.1 vm-test-run-timescaledb> server # [ 175.978147] postgres[2018]: For more information on TimescaleDB, please visit the following links: vm-test-run-timescaledb> server # [ 175.978664] postgres[2018]: vm-test-run-timescaledb> server # [ 175.979961] postgres[2018]: 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started vm-test-run-timescaledb> server # [ 175.986362] postgres[2018]: 2. API reference documentation: https://docs.timescale.com/api/latest vm-test-run-timescaledb> server # [ 175.987412] postgres[2018]: 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts vm-test-run-timescaledb> server # [ 175.988453] postgres[2018]: vm-test-run-timescaledb> server # [ 176.002296] postgres[2018]: 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 # [ 176.003317] postgres[2018]: vm-test-run-timescaledb> server # [ 176.004202] postgres[2018]: [local] 2026-10-20 20:56:41.317 UTC [2018] 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.68 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.755676] postgres[2065]: 2026-10-20 20:56:42.144 UTC [2065] LOG: job 2 threw an error vm-test-run-timescaledb> server # [ 176.772977] postgres[2065]: 2026-10-20 20:56:42.169 UTC [2065] ERROR: functionality not supported under the current "apache" license vm-test-run-timescaledb> server # [ 176.784920] postgres[2065]: 2026-10-20 20:56:42.169 UTC [2065] HINT: Upgrade your license to 'timescale' to use this free community feature. vm-test-run-timescaledb> server # [ 176.849345] postgres[1366]: 2026-10-20 20:56:42.227 UTC [1366] LOG: background worker "Error Log Retention Policy [2]" (PID 2065) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.81 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "ALTER EXTENSION timescaledb UPDATE TO '2.16.1';" vm-test-run-timescaledb> server # [ 177.856620] postgres[2060]: 2026-10-20 20:56:43.226 UTC [2060] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 177.887625] postgres[1366]: 2026-10-20 20:56:43.262 UTC [1366] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2060) exited with exit code 1 vm-test-run-timescaledb> server # [ 178.313917] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 vm-test-run-timescaledb> server # [ 185.602323] systemd[1]: Starting Virtual Console Setup... vm-test-run-timescaledb> server # [ 185.734738] postgres[2071]: 2026-10-20 20:56:51.084 UTC [2071] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 185.786621] postgres[1366]: 2026-10-20 20:56:51.172 UTC [1366] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2071) exited with exit code 1 vm-test-run-timescaledb> server # [ 185.849908] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 185.882199] systemd[1]: Stopped Virtual Console Setup. vm-test-run-timescaledb> server # [ 185.921669] systemd[1]: Starting Virtual Console Setup... 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 9.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 # [ 187.046438] postgres[2143]: 2026-10-20 20:56:52.422 UTC [2143] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 187.069117] postgres[2143]: 2026-10-20 20:56:52.435 UTC [2143] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 187.071418] postgres[2143]: 2026-10-20 20:56:52.435 UTC [2143] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 187.103776] postgres[1366]: 2026-10-20 20:56:52.472 UTC [1366] LOG: background worker "Job History Log Retention Policy [3]" (PID 2143) 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 1.05 seconds) vm-test-run-timescaledb> (finished: subtest: Check upgrade path with postgresql 15, in 18.58 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 # [ 188.611480] postgres[2137]: 2026-10-20 20:56:53.996 UTC [2137] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 188.697095] postgres[1366]: 2026-10-20 20:56:54.079 UTC [1366] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2137) exited with exit code 1 vm-test-run-timescaledb> server # [ 189.350597] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" , in 3.35 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 # [ 190.954314] systemd[1]: Finished Virtual Console Setup. vm-test-run-timescaledb> server # [ 193.025866] systemd-logind[644]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" , in 4.82 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 # [ 195.934316] postgres[2201]: 2026-10-20 20:57:01.322 UTC [2201] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 195.941063] postgres[2201]: 2026-10-20 20:57:01.326 UTC [2201] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 195.943076] postgres[2201]: 2026-10-20 20:57:01.326 UTC [2201] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 195.979156] postgres[1366]: 2026-10-20 20:57:01.372 UTC [1366] LOG: background worker "Job History Log Retention Policy [3]" (PID 2201) 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.47 seconds) vm-test-run-timescaledb> (finished: subtest: Check the install of the last version of the extension, in 8.63 seconds) vm-test-run-timescaledb> (finished: run the VM test script, in 197.27 seconds) vm-test-run-timescaledb> test script finished in 197.59s 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> vde_switch: EOF on stdin, cleaning up and exiting vm-test-run-timescaledb> vde_switch: (finished: cleanup, in 0.00 seconds) vm-test-run-timescaledb> Caught signal 15, cleaning up and exiting