these 2 derivations will be built: /nix/store/npyhbs15x98pvz06v4pckaxl032gx7jh-nixos-test-driver-timescaledb.drv /nix/store/yy8rhphzjp1r9bh4zs48f9c1bs2q54a1-vm-test-run-timescaledb.drv building '/nix/store/npyhbs15x98pvz06v4pckaxl032gx7jh-nixos-test-driver-timescaledb.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/yy8rhphzjp1r9bh4zs48f9c1bs2q54a1-vm-test-run-timescaledb.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/yy8rhphzjp1r9bh4zs48f9c1bs2q54a1-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.Y5NbUsDLYu', 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: 210ad8c6-ce4a-43d3-97ee-453849695678 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.22 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/zv0g79iq1kdk3nk0kyixz4jn4b7pb0yd-nixos-system-server-test/init regInfo=/nix/store/9j75rsbilq001slz5vim344w0fl7lrv6-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-timescaledb> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/9j75rsbilq001slz5vim344w0fl7lrv6-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 @100af0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-timescaledb> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b00000 (flat, esz 8, psz 64K, shr 1) vm-test-run-timescaledb> server # [ 0.000000] GICv3: using LPI property table @0x0000000100b10000 vm-test-run-timescaledb> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b20000 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.000035] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-timescaledb> server # [ 0.004945] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-timescaledb> server # [ 0.014679] Console: colour dummy device 80x25 vm-test-run-timescaledb> server # [ 0.016031] printk: legacy console [tty0] enabled vm-test-run-timescaledb> server # [ 0.022022] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-timescaledb> server # [ 0.022450] pid_max: default: 32768 minimum: 301 vm-test-run-timescaledb> server # [ 0.024365] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-timescaledb> server # [ 0.026428] landlock: Up and running. vm-test-run-timescaledb> server # [ 0.026536] Yama: becoming mindful. vm-test-run-timescaledb> server # [ 0.030993] LSM support for eBPF active vm-test-run-timescaledb> server # [ 0.033936] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.034103] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.062711] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-timescaledb> server # [ 0.075213] rcu: Hierarchical SRCU implementation. vm-test-run-timescaledb> server # [ 0.075308] rcu: Max phase no-delay instances is 1000. vm-test-run-timescaledb> server # [ 0.076479] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-timescaledb> server # [ 0.083867] fsl-mc MSI: its@8080000 domain created vm-test-run-timescaledb> server # [ 0.086332] EFI services will not be available. vm-test-run-timescaledb> server # [ 0.088045] smp: Bringing up secondary CPUs ... vm-test-run-timescaledb> server # [ 0.092069] Detected PIPT I-cache on CPU1 vm-test-run-timescaledb> server # [ 0.093296] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-timescaledb> server # [ 0.093940] GICv3: CPU1: using allocated LPI pending table @0x0000000100b30000 vm-test-run-timescaledb> server # [ 0.095355] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-timescaledb> server # [ 0.098899] smp: Brought up 1 node, 2 CPUs vm-test-run-timescaledb> server # [ 0.099044] SMP: Total of 2 processors activated. vm-test-run-timescaledb> server # [ 0.099090] CPU: All CPU(s) started at EL1 vm-test-run-timescaledb> server # [ 0.099266] CPU features: detected: Branch Target Identification vm-test-run-timescaledb> server # [ 0.099311] CPU features: detected: 32-bit EL0 Support vm-test-run-timescaledb> server # [ 0.099337] CPU features: detected: 32-bit EL1 Support vm-test-run-timescaledb> server # [ 0.099555] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-timescaledb> server # [ 0.099732] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-timescaledb> server # [ 0.099772] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-timescaledb> server # [ 0.099836] CPU features: detected: Common not Private translations vm-test-run-timescaledb> server # [ 0.099866] CPU features: detected: CRC32 instructions vm-test-run-timescaledb> server # [ 0.099889] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-timescaledb> server # [ 0.099919] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-timescaledb> server # [ 0.099942] CPU features: detected: Data independent timing control (DIT) vm-test-run-timescaledb> server # [ 0.099967] CPU features: detected: E0PD vm-test-run-timescaledb> server # [ 0.099988] CPU features: detected: Enhanced Counter Virtualization vm-test-run-timescaledb> server # [ 0.100015] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-timescaledb> server # [ 0.100040] CPU features: detected: Enhanced Privileged Access Never vm-test-run-timescaledb> server # [ 0.100066] CPU features: detected: Enhanced Virtualization Traps vm-test-run-timescaledb> server # [ 0.100090] CPU features: detected: Fine Grained Traps vm-test-run-timescaledb> server # [ 0.100151] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.100238] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-timescaledb> server # [ 0.100287] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-timescaledb> server # [ 0.100315] CPU features: detected: LSE atomic instructions vm-test-run-timescaledb> server # [ 0.100336] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-timescaledb> server # [ 0.100358] CPU features: detected: Privileged Access Never vm-test-run-timescaledb> server # [ 0.100382] CPU features: detected: RAS Extension Support vm-test-run-timescaledb> server # [ 0.100406] CPU features: detected: Random Number Generator vm-test-run-timescaledb> server # [ 0.100428] CPU features: detected: Speculation barrier (SB) vm-test-run-timescaledb> server # [ 0.100448] CPU features: detected: Stage-2 Force Write-Back vm-test-run-timescaledb> server # [ 0.100468] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-timescaledb> server # [ 0.100495] CPU features: detected: TLB range maintenance instructions vm-test-run-timescaledb> server # [ 0.100520] CPU features: detected: WFx with timeout vm-test-run-timescaledb> server # [ 0.100779] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-timescaledb> server # [ 0.100901] CPU features: detected: Scalable Vector Extension vm-test-run-timescaledb> server # [ 0.109420] alternatives: applying system-wide alternatives vm-test-run-timescaledb> server # [ 0.124057] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-timescaledb> server # [ 0.124909] SVE: maximum available vector length 256 bytes per vector vm-test-run-timescaledb> server # [ 0.124989] SVE: default vector length 64 bytes per vector vm-test-run-timescaledb> server # [ 0.136988] Memory: 3922828K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-timescaledb> server # [ 0.159983] devtmpfs: initialized vm-test-run-timescaledb> server # [ 0.186732] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-timescaledb> server # [ 0.187212] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.190003] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-timescaledb> server # [ 0.190079] 0 pages in range for non-PLT usage vm-test-run-timescaledb> server # [ 0.190123] 509248 pages in range for PLT usage vm-test-run-timescaledb> server # [ 0.192460] pinctrl core: initialized pinctrl subsystem vm-test-run-timescaledb> server # [ 0.201854] DMI not present or invalid. vm-test-run-timescaledb> server # [ 0.222393] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-timescaledb> server # [ 0.234607] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-timescaledb> server # [ 0.235762] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-timescaledb> server # [ 0.237289] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-timescaledb> server # [ 0.237740] audit: initializing netlink subsys (disabled) vm-test-run-timescaledb> server # [ 0.239849] audit: type=2000 audit(0.176:1): state=initialized audit_enabled=0 res=1 vm-test-run-timescaledb> server # [ 0.246209] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-timescaledb> server # [ 0.246268] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-timescaledb> server # [ 0.246321] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-timescaledb> server # [ 0.246346] thermal_sys: Registered thermal governor 'user_space' vm-test-run-timescaledb> server # [ 0.246369] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-timescaledb> server # [ 0.247467] cpuidle: using governor ladder vm-test-run-timescaledb> server # [ 0.248095] cpuidle: using governor menu vm-test-run-timescaledb> server # [ 0.250316] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-timescaledb> server # [ 0.251574] ASID allocator initialised with 65536 entries vm-test-run-timescaledb> server # [ 0.258738] Serial: AMBA PL011 UART driver vm-test-run-timescaledb> server # [ 0.305700] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-timescaledb> server # [ 0.307048] printk: legacy console [ttyAMA0] enabled vm-test-run-timescaledb> server # [ 0.350373] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.350550] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-timescaledb> server # [ 0.350764] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.350867] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-timescaledb> server # [ 0.350958] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.351050] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-timescaledb> server # [ 0.351288] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.351390] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-timescaledb> server # [ 0.363612] fbcon: Taking over console vm-test-run-timescaledb> server # [ 0.364176] ACPI: Interpreter disabled. vm-test-run-timescaledb> server # [ 0.372218] iommu: Default domain type: Translated vm-test-run-timescaledb> server # [ 0.372675] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-timescaledb> server # [ 0.376395] SCSI subsystem initialized vm-test-run-timescaledb> server # [ 0.379502] usbcore: registered new interface driver usbfs vm-test-run-timescaledb> server # [ 0.380929] usbcore: registered new interface driver hub vm-test-run-timescaledb> server # [ 0.381193] usbcore: registered new device driver usb vm-test-run-timescaledb> server # [ 0.383506] pps_core: LinuxPPS API ver. 1 registered vm-test-run-timescaledb> server # [ 0.383766] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-timescaledb> server # [ 0.384766] PTP clock support registered vm-test-run-timescaledb> server # [ 0.385589] EDAC MC: Ver: 3.0.0 vm-test-run-timescaledb> server # [ 0.389155] scmi_core: SCMI protocol bus registered vm-test-run-timescaledb> server # [ 0.391844] FPGA manager framework vm-test-run-timescaledb> server # [ 0.393545] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-timescaledb> server # [ 0.401308] vgaarb: loaded vm-test-run-timescaledb> server # [ 0.406288] clocksource: Switched to clocksource arch_sys_counter vm-test-run-timescaledb> server # [ 0.442240] VFS: Disk quotas dquot_6.6.0 vm-test-run-timescaledb> server # [ 0.445182] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-timescaledb> server # [ 0.448177] netfs: FS-Cache loaded vm-test-run-timescaledb> server # [ 0.449556] pnp: PnP ACPI: disabled vm-test-run-timescaledb> server # [ 0.507807] NET: Registered PF_INET protocol family vm-test-run-timescaledb> server # [ 0.509211] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-timescaledb> server # [ 0.627039] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.627430] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.627726] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.628509] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-timescaledb> server # [ 0.629243] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-timescaledb> server # [ 0.631196] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-timescaledb> server # [ 0.631668] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.632161] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.633854] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-timescaledb> server # [ 0.634500] NET: Registered PF_XDP protocol family vm-test-run-timescaledb> server # [ 0.634708] PCI: CLS 0 bytes, default 64 vm-test-run-timescaledb> server # [ 0.638075] Trying to unpack rootfs image as initramfs... vm-test-run-timescaledb> server # [ 0.638974] kvm [1]: HYP mode not available vm-test-run-timescaledb> server # [ 0.747820] Initialise system trusted keyrings vm-test-run-timescaledb> server # [ 0.749546] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-timescaledb> server # [ 0.753658] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-timescaledb> server # [ 0.754863] 9p: Installing v9fs 9p2000 file system support vm-test-run-timescaledb> server # [ 0.818021] Key type asymmetric registered vm-test-run-timescaledb> server # [ 0.818893] Asymmetric key parser 'x509' registered vm-test-run-timescaledb> server # [ 0.819441] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-timescaledb> server # [ 0.821038] io scheduler mq-deadline registered vm-test-run-timescaledb> server # [ 0.821198] io scheduler kyber registered vm-test-run-timescaledb> server # [ 0.857299] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-timescaledb> server # [ 0.861538] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-timescaledb> server # [ 0.865208] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-timescaledb> server # [ 0.865866] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-timescaledb> server # [ 0.866340] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-timescaledb> server # [ 0.866514] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-timescaledb> server # [ 0.867516] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-timescaledb> server # [ 0.868054] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-timescaledb> server # [ 0.869545] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-timescaledb> server # [ 0.869926] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-timescaledb> server # [ 0.870162] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.870969] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.871163] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.872531] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.876233] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.876751] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.876917] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.877072] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.877302] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.878847] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.879636] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.879903] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.880432] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.881745] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.882803] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.883245] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.883774] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.884461] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.884799] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.884949] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.885668] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.886361] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.886512] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.886606] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.887575] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.888154] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.888477] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-timescaledb> server # [ 0.888661] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.888810] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.889371] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.889556] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.889663] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.889779] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.889927] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.890923] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.891099] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.891215] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.891692] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.892256] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.892373] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.892979] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.893131] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.893553] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.893940] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.894052] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.894562] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.895061] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.895232] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.895325] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.895437] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.897466] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.897719] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.897889] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.898104] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.898936] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.899224] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.899365] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.899497] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.899627] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.899773] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.899907] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.900030] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.900418] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.900618] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-timescaledb> server # [ 0.900739] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-timescaledb> server # [ 0.900840] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-timescaledb> server # [ 0.900989] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-timescaledb> server # [ 0.901101] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-timescaledb> server # [ 0.901283] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-timescaledb> server # [ 0.901386] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-timescaledb> server # [ 0.901486] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-timescaledb> server # [ 0.901596] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-timescaledb> server # [ 0.901702] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-timescaledb> server # [ 0.901818] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-timescaledb> server # [ 0.901920] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-timescaledb> server # [ 0.902029] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-timescaledb> server # [ 0.902143] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-timescaledb> server # [ 0.902238] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-timescaledb> server # [ 0.902335] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-timescaledb> server # [ 0.903463] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-timescaledb> server # [ 0.903865] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-timescaledb> server # [ 0.903982] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-timescaledb> server # [ 0.904088] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-timescaledb> server # [ 0.904188] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-timescaledb> server # [ 0.904508] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.904699] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.904816] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.905697] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.965126] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.969473] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.972101] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.975201] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.977254] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.979976] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.982059] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.985215] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.988039] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.990100] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.992294] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 1.008343] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-timescaledb> server # [ 1.019908] msm_serial: driver initialized vm-test-run-timescaledb> server # [ 1.021053] SuperH (H)SCI(F) driver initialized vm-test-run-timescaledb> server # [ 1.021487] STM32 USART driver initialized vm-test-run-timescaledb> server # [ 1.075113] loop: module loaded vm-test-run-timescaledb> server # [ 1.075909] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-timescaledb> server # [ 1.080135] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-timescaledb> server # [ 1.092688] megasas: 07.727.03.00-rc1 vm-test-run-timescaledb> server # [ 1.097742] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-timescaledb> server # [ 1.101373] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 1.102149] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 1.104041] Using buffer write method vm-test-run-timescaledb> server # [ 1.104962] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-timescaledb> server # [ 1.106237] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 1.106958] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 1.108787] Using buffer write method vm-test-run-timescaledb> server # [ 1.109388] Concatenating MTD devices: vm-test-run-timescaledb> server # [ 1.109616] (0): "0.flash" vm-test-run-timescaledb> server # [ 1.109690] (1): "0.flash" vm-test-run-timescaledb> server # [ 1.109750] into device "0.flash" vm-test-run-timescaledb> server # [ 1.129678] Freeing initrd memory: 10684K vm-test-run-timescaledb> server # [ 1.151667] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-timescaledb> server # [ 1.165244] thunder_xcv, ver 1.0 vm-test-run-timescaledb> server # [ 1.165548] thunder_bgx, ver 1.0 vm-test-run-timescaledb> server # [ 1.165911] nicpf, ver 1.0 vm-test-run-timescaledb> server # [ 1.169223] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-timescaledb> server # [ 1.169377] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-timescaledb> server # [ 1.169734] hclge is initializing vm-test-run-timescaledb> server # [ 1.170449] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.171342] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-timescaledb> server # [ 1.171803] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.171943] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-timescaledb> server # [ 1.172167] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-timescaledb> server # [ 1.172418] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-timescaledb> server # [ 1.173165] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-timescaledb> server # [ 1.174266] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-timescaledb> server # [ 1.175405] sky2: driver version 1.30 vm-test-run-timescaledb> server # [ 1.183607] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-timescaledb> server # [ 1.184171] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-timescaledb> server # [ 1.185644] usbcore: registered new interface driver usb-storage vm-test-run-timescaledb> server # [ 1.187014] usbcore: registered new interface driver usbserial_generic vm-test-run-timescaledb> server # [ 1.187693] usbserial: USB Serial support registered for generic vm-test-run-timescaledb> server # [ 1.187904] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-timescaledb> server # [ 1.197487] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-timescaledb> server # [ 1.199303] rtc-pl031 9010000.pl031: setting system clock to 2026-10-08T00:50:24 UTC (1791420624) vm-test-run-timescaledb> server # [ 1.201263] i2c_dev: i2c /dev entries driver vm-test-run-timescaledb> server # [ 1.202840] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-timescaledb> server # [ 1.210085] hub 1-0:1.0: USB hub found vm-test-run-timescaledb> server # [ 1.211354] hub 1-0:1.0: 6 ports detected vm-test-run-timescaledb> server # [ 1.216271] sdhci: Secure Digital Host Controller Interface driver vm-test-run-timescaledb> server # [ 1.216424] sdhci: Copyright(c) Pierre Ossman vm-test-run-timescaledb> server # [ 1.217852] Synopsys Designware Multimedia Card Interface Driver vm-test-run-timescaledb> server # [ 1.219947] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-timescaledb> server # [ 1.226237] hid: raw HID events driver (C) Jiri Kosina vm-test-run-timescaledb> server # [ 1.229137] usbcore: registered new interface driver usbhid vm-test-run-timescaledb> server # [ 1.229518] usbhid: USB HID core driver vm-test-run-timescaledb> server # [ 1.238540] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-timescaledb> server # [ 1.252186] drop_monitor: Initializing network drop monitor service vm-test-run-timescaledb> server # [ 1.253816] NET: Registered PF_INET6 protocol family vm-test-run-timescaledb> server # [ 1.275511] Segment Routing with IPv6 vm-test-run-timescaledb> server # [ 1.275914] In-situ OAM (IOAM) with IPv6 vm-test-run-timescaledb> server # [ 1.277473] NET: Registered PF_PACKET protocol family vm-test-run-timescaledb> server # [ 1.280854] 9pnet: Installing 9P2000 support vm-test-run-timescaledb> server # [ 1.286451] Key type dns_resolver registered vm-test-run-timescaledb> server # [ 1.330347] registered taskstats version 1 vm-test-run-timescaledb> server # [ 1.333601] Loading compiled-in X.509 certificates vm-test-run-timescaledb> server # [ 1.395492] Demotion targets for Node 0: null vm-test-run-timescaledb> server # [ 1.399328] Key type .fscrypt registered vm-test-run-timescaledb> server # [ 1.399589] Key type fscrypt-provisioning registered vm-test-run-timescaledb> server # [ 1.409986] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-timescaledb> server # [ 1.456445] clk: Disabling unused clocks vm-test-run-timescaledb> server # [ 1.456777] PM: genpd: Disabling unused power domains vm-test-run-timescaledb> server # [ 1.457106] ALSA device list: vm-test-run-timescaledb> server # [ 1.457225] No soundcards found. vm-test-run-timescaledb> server # [ 1.458767] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-timescaledb> server # [ 1.544428] Freeing unused kernel memory: 4416K vm-test-run-timescaledb> server # [ 1.545904] Run /init as init process vm-test-run-timescaledb> server # [ 1.667914] 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.813262] 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.942765] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-timescaledb> server # [ 2.132122] 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.133881] 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.185784] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-timescaledb> server # [ 2.329007] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-timescaledb> server # [ 2.329845] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-timescaledb> server # [ 2.329868] [drm] features: -context_init vm-test-run-timescaledb> server # [ 2.333160] [drm] number of scanouts: 1 vm-test-run-timescaledb> server # [ 2.333300] [drm] number of cap sets: 0 vm-test-run-timescaledb> server # [ 2.345127] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-timescaledb> server # [ 2.378114] Console: switching to colour frame buffer device 160x50 vm-test-run-timescaledb> server # [ 2.390985] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-timescaledb> server # [ 5.433158] EXT4-fs (vda): mounted filesystem 210ad8c6-ce4a-43d3-97ee-453849695678 r/w with ordered data mode. Quota mode: none. vm-test-run-timescaledb> server # [ 8.216226] EXT4-fs (vda): re-mounted 210ad8c6-ce4a-43d3-97ee-453849695678. vm-test-run-timescaledb> server # [ 8.238652] booting system configuration /nix/store/zv0g79iq1kdk3nk0kyixz4jn4b7pb0yd-nixos-system-server-test vm-test-run-timescaledb> server # [ 21.398683] 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.408606] systemd[1]: Detected virtualization qemu. vm-test-run-timescaledb> server # [ 21.413227] systemd[1]: Detected architecture arm64. vm-test-run-timescaledb> server # [ 21.417958] systemd[1]: Detected first boot. vm-test-run-timescaledb> server # [ 21.446871] systemd[1]: Initializing machine ID from random generator. vm-test-run-timescaledb> server # [ 21.481346] systemd[1]: Hostname set to . vm-test-run-timescaledb> server # [ 22.683450] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-timescaledb> server # [ 24.149858] systemd[1]: Applying preset policy. vm-test-run-timescaledb> server # [ 27.918838] 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 # [ 31.594505] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-timescaledb> server # [ 31.826954] systemd[1]: Created slice Slice /system/getty. vm-test-run-timescaledb> server # [ 31.841969] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-timescaledb> server # [ 31.857838] systemd[1]: Created slice User and Session Slice. vm-test-run-timescaledb> server # [ 31.868801] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-timescaledb> server # [ 31.875167] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-timescaledb> server # [ 31.881029] systemd[1]: Expecting device /dev/hvc0... vm-test-run-timescaledb> server # [ 31.885739] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-timescaledb> server # [ 31.890095] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-timescaledb> server # [ 31.894470] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-timescaledb> server # [ 31.899722] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-timescaledb> server # [ 31.904867] systemd[1]: Reached target Path Units. vm-test-run-timescaledb> server # [ 31.910206] systemd[1]: Reached target Remote File Systems. vm-test-run-timescaledb> server # [ 31.915188] systemd[1]: Reached target Slice Units. vm-test-run-timescaledb> server # [ 31.919404] systemd[1]: Reached target Swaps. vm-test-run-timescaledb> server # [ 31.955474] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-timescaledb> server # [ 31.978254] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-timescaledb> server # [ 31.989127] systemd[1]: Listening on Journal Audit Socket. vm-test-run-timescaledb> server # [ 31.996442] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-timescaledb> server # [ 32.002869] systemd[1]: Listening on Journal Sockets. vm-test-run-timescaledb> server # [ 32.011490] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-timescaledb> server # [ 32.016940] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 32.024264] systemd[1]: Listening on udev Control Socket. vm-test-run-timescaledb> server # [ 32.029845] systemd[1]: Listening on udev Kernel Socket. vm-test-run-timescaledb> server # [ 32.079119] systemd[1]: Mounting Huge Pages File System... vm-test-run-timescaledb> server # [ 32.119750] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-timescaledb> server # [ 32.165253] systemd[1]: Mounting Kernel Debug File System... vm-test-run-timescaledb> server # [ 32.212156] systemd[1]: Mounting Kernel Trace File System... vm-test-run-timescaledb> server # [ 32.341938] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-timescaledb> server # [ 32.453525] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-timescaledb> server # [ 32.476348] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-timescaledb> server # [ 32.609127] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-timescaledb> server # [ 32.626689] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-timescaledb> server # [ 32.643043] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-timescaledb> server # [ 32.769347] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-timescaledb> server # [ 32.777791] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-timescaledb> server # [ 32.791471] 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 # [ 32.880124] systemd[1]: Starting Journal Service... vm-test-run-timescaledb> server # [ 32.960336] systemd[1]: Starting Load Kernel Modules... vm-test-run-timescaledb> server # [ 33.045943] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-timescaledb> server # [ 33.124829] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-timescaledb> server # [ 33.134828] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 33.187472] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-timescaledb> server # [ 33.258187] systemd[1]: Mounted Huge Pages File System. vm-test-run-timescaledb> server # [ 33.271282] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-timescaledb> server # [ 33.280946] systemd[1]: Mounted Kernel Debug File System. vm-test-run-timescaledb> server # [ 33.292370] systemd[1]: Mounted Kernel Trace File System. vm-test-run-timescaledb> server # [ 33.309490] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-timescaledb> server # [ 33.331183] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-timescaledb> server # [ 33.389570] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-timescaledb> server # [ 33.909190] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 33.940245] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-timescaledb> server # [ 34.295622] EXT4-fs (vda): re-mounted 210ad8c6-ce4a-43d3-97ee-453849695678. vm-test-run-timescaledb> server # [ 34.352197] systemd[1]: Finished Load Kernel Modules. vm-test-run-timescaledb> server # [ 34.443914] systemd[1]: Starting Firewall... vm-test-run-timescaledb> server # [ 34.511843] fuse: init (API version 7.41) vm-test-run-timescaledb> server # [ 34.520838] systemd[1]: Starting Apply Kernel Variables... vm-test-run-timescaledb> server # [ 34.539030] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-timescaledb> server # [ 34.552940] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-timescaledb> server # [ 34.625168] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-timescaledb> server # [ 34.633905] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 34.648356] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 34.669793] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-timescaledb> server # [ 34.711712] systemd-journald[399]: Collecting audit messages is enabled. vm-test-run-timescaledb> server # [ 34.728144] systemd[1]: Mounting FUSE Control File System... vm-test-run-timescaledb> server # [ 34.979420] systemd[1]: Mounted FUSE Control File System. vm-test-run-timescaledb> server # [ 35.587849] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-timescaledb> server # [ 35.653672] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-timescaledb> server # [ 35.792424] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-timescaledb> server # [ 35.805080] systemd[1]: Reached target First Boot Complete. vm-test-run-timescaledb> server # [ 36.188527] systemd[1]: Finished Apply Kernel Variables. vm-test-run-timescaledb> server # [ 36.349225] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-timescaledb> server # [ 36.947783] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-timescaledb> server # [ 36.975046] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-timescaledb> server # [ 37.017947] systemd[1]: Mounting /run/wrappers... vm-test-run-timescaledb> server # [ 37.076748] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-timescaledb> server # [ 37.485682] systemd[1]: Mounted /run/wrappers. vm-test-run-timescaledb> server # [ 37.496267] systemd[1]: Reached target Local File Systems. vm-test-run-timescaledb> server # [ 37.530978] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-timescaledb> server # [ 37.581779] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-timescaledb> server # [ 37.593379] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-timescaledb> server # [ 37.650941] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-timescaledb> server # [ 37.801548] systemd[1]: Started Journal Service. vm-test-run-timescaledb> server # [ 37.736351] systemd-modules-load[400]: Module 'atkbd' is built in vm-test-run-timescaledb> server # [ 37.759941] systemd-modules-load[400]: Module 'loop' is built in vm-test-run-timescaledb> server # [ 37.804230] systemd-oomd[401]: No swap; memory pressure usage will be degraded vm-test-run-timescaledb> server # [ 37.867517] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-timescaledb> server # [ 38.577034] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-timescaledb> server # [ 38.625449] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-timescaledb> server # [ 38.794522] systemd-udevd[426]: Using default interface naming scheme 'v258'. vm-test-run-timescaledb> server # [ 38.984997] systemd-journald[399]: Received client request to flush runtime journal. vm-test-run-timescaledb> server # [ 39.470056] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-timescaledb> server # [ 39.519447] systemd[1]: Starting Create System Files and Directories... vm-test-run-timescaledb> server # [ 41.158909] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-timescaledb> server # [ 41.328779] systemd[1]: Finished Create System Files and Directories. vm-test-run-timescaledb> server # [ 41.422203] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-timescaledb> server # [ 41.458023] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-timescaledb> server # [ 42.561782] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-timescaledb> server # [ 43.629064] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-timescaledb> server # [ 43.647059] systemd[1]: Starting Update is Completed... vm-test-run-timescaledb> server # [ 44.273825] systemd[1]: Finished Update is Completed. vm-test-run-timescaledb> server # [ 47.707695] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 47.731412] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-timescaledb> server # [ 47.734310] systemd[1]: suid-sgid-wrappers.service: Consumed 2.741s CPU time, 5.7M memory peak. vm-test-run-timescaledb> server # [ 50.023351] systemd[1]: Finished Firewall. vm-test-run-timescaledb> server # [ 51.659519] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-timescaledb> server # [ 51.669311] systemd[1]: Reached target System Initialization. vm-test-run-timescaledb> server # [ 51.674168] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-timescaledb> server # [ 51.682481] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-timescaledb> server # [ 51.691432] systemd[1]: Reached target Timer Units. vm-test-run-timescaledb> server # [ 51.701335] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-timescaledb> server # [ 51.706161] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-timescaledb> server # [ 51.713438] systemd[1]: Listening on Hostname Service Socket. vm-test-run-timescaledb> server # [ 51.717476] systemd[1]: Reached target Socket Units. vm-test-run-timescaledb> server # [ 51.723062] systemd[1]: Reached target Basic System. vm-test-run-timescaledb> server # [ 51.745406] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-timescaledb> server # [ 51.805976] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 51.855906] systemd[1]: Started Reset console on configuration changes. vm-test-run-timescaledb> server # [ 51.894895] systemd[1]: Starting resolvconf update... vm-test-run-timescaledb> server # [ 51.965544] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-timescaledb> server # [ 52.939189] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-timescaledb> server # [ 53.099148] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 53.121639] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 53.174610] nsncd[633]: Oct 08 00:51:16.448 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 53.183658] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 53.201650] dbus-daemon[636]: dbus[636]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-timescaledb> server # [ 53.213105] systemd[1]: Starting User Login Management... vm-test-run-timescaledb> server # [ 53.679352] systemd[1]: Started D-Bus System Message Bus. vm-test-run-timescaledb> server # [ 54.423872] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 54.437346] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-timescaledb> server # [ 54.443647] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 54.449678] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-timescaledb> server # [ 54.451435] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 54.489005] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 54.509387] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 54.623496] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 54.712914] systemd-logind[655]: New seat seat0. vm-test-run-timescaledb> server # [ 54.770150] systemd[1]: Started User Login Management. vm-test-run-timescaledb> server # [ 54.822946] systemd[1]: Starting linger-users.service... vm-test-run-timescaledb> server # [ 55.272068] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 55.300229] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 55.333619] systemd[1]: Finished linger-users.service. vm-test-run-timescaledb> server # [ 55.362141] nsncd[693]: Oct 08 00:51:18.688 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 55.368180] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 55.380169] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 55.740818] systemd[1]: Finished resolvconf update. vm-test-run-timescaledb> server # [ 55.759829] systemd[1]: Reached target Preparation for Network. vm-test-run-timescaledb> server # [ 55.807543] systemd[1]: Starting DHCP Client... vm-test-run-timescaledb> server # [ 57.042160] dhcpcd[744]: dhcpcd-10.2.4 starting vm-test-run-timescaledb> server # [ 57.147537] dhcpcd[748]: dev: loaded udev vm-test-run-timescaledb> server # [ 57.579428] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-timescaledb> server # [ 58.114609] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-timescaledb> server # [ 58.393934] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-timescaledb> server # [ 58.405484] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-timescaledb> server # [ 58.429497] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-timescaledb> server # [ 58.433468] cfg80211: failed to load regulatory.db vm-test-run-timescaledb> server # [ 58.809028] systemd[1]: Found device /dev/hvc0. vm-test-run-timescaledb> server: Guest root shell did not produce any data yet... vm-test-run-timescaledb> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-timescaledb> server # [ 59.191033] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-timescaledb> server # [ 59.109804] dhcpcd[748]: eth0: waiting for carrier vm-test-run-timescaledb> server # [ 59.113852] dhcpcd[748]: eth0: carrier acquired vm-test-run-timescaledb> server # [ 59.234654] dhcpcd[748]: DUID 00:01:00:01:32:59:a5:8a:52:54:00:12:34:56 vm-test-run-timescaledb> server # [ 59.239766] dhcpcd[748]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 59.243956] dhcpcd[748]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-timescaledb> server # [ 59.413992] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-timescaledb> server # [ 59.449101] systemd[1]: Started backdoor.service. vm-test-run-timescaledb> server # connecting to host... vm-test-run-timescaledb> server # [ 60.055962] dhcpcd[748]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 60.090585] dhcpcd[748]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 60.116784] dhcpcd[748]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-timescaledb> server: connected to guest root shell vm-test-run-timescaledb> server: (connecting took 61.25 seconds) vm-test-run-timescaledb> server: (finished: waiting for the VM to finish booting, in 61.25 seconds) vm-test-run-timescaledb> server # [ 60.530447] dhcpcd[748]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 60.561735] dhcpcd[748]: eth0: Router Advertisement from fe80::2 vm-test-run-timescaledb> server # [ 60.565599] dhcpcd[748]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-timescaledb> server # [ 60.577253] dhcpcd[748]: eth0: adding route to fec0::/64 vm-test-run-timescaledb> server # [ 60.588745] dhcpcd[748]: eth0: adding default route via fe80::2 vm-test-run-timescaledb> server # [ 62.101774] (udev-worker)[804]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-timescaledb> server # [ 62.103863] (udev-worker)[804]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 62.111570] (udev-worker)[805]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 62.977478] systemd-logind[655]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-timescaledb> server # [ 63.274029] systemd[1]: Found device Virtio network device. vm-test-run-timescaledb> server # [ 63.302322] dhcpcd[748]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 63.346457] systemd[1]: Starting Address configuration of eth1... vm-test-run-timescaledb> server # [ 63.896616] dhcpcd[748]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 63.897947] dhcpcd[748]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 63.902306] dhcpcd[748]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 64.088782] dhcpcd[748]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 64.213051] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-timescaledb> server # [ 64.358468] network-addresses-eth1-start[830]: adding address 192.168.1.1/24... done vm-test-run-timescaledb> server # [ 64.569619] network-addresses-eth1-start[830]: adding address 2001:db8:1::1/64... done vm-test-run-timescaledb> server # [ 64.841506] systemd[1]: Finished Address configuration of eth1. vm-test-run-timescaledb> server # [ 64.910954] systemd[1]: Starting Networking Setup... vm-test-run-timescaledb> server # [ 65.511386] dhcpcd[748]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-timescaledb> server # [ 65.517478] dhcpcd[748]: eth0: adding route to 10.0.2.0/24 vm-test-run-timescaledb> server # [ 65.518580] dhcpcd[748]: eth0: adding default route via 10.0.2.2 vm-test-run-timescaledb> server # [ 66.063453] dhcpcd[881]: /nix/store/hsj50yr7hr62ql9xaynbihkhfhbgprcn-openresolv-3.17.0/sbin/.resolvconf-wrapped: line 1221: kill: (875) - Operation not permitted vm-test-run-timescaledb> server # [ 66.075535] dhcpcd[881]: clearing stale lock pid 875 vm-test-run-timescaledb> server # [ 67.656551] systemd[1]: Finished Networking Setup. vm-test-run-timescaledb> server # [ 67.677869] systemd[1]: Reached target Network. vm-test-run-timescaledb> server # [ 67.717161] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-timescaledb> server # [ 67.811180] systemd[1]: Starting Permit User Sessions... vm-test-run-timescaledb> server # [ 68.541313] systemd[1]: Finished Permit User Sessions. vm-test-run-timescaledb> server # [ 68.617271] systemd[1]: Started Getty on tty1. vm-test-run-timescaledb> server # [ 68.619141] systemd[1]: Reached target Login Prompts. vm-test-run-timescaledb> server # [ 68.755487] systemd[1]: Started DHCP Client. vm-test-run-timescaledb> server # [ 69.562651] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[990]: Initializing database at /var/lib/postgresql/data vm-test-run-timescaledb> server # [ 70.790187] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: The files belonging to this database system will be owned by user "postgres". vm-test-run-timescaledb> server # [ 70.795365] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: This user must also own the server process. vm-test-run-timescaledb> server # [ 70.865511] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-timescaledb> server # [ 70.866540] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: The default database encoding has accordingly been set to "UTF8". vm-test-run-timescaledb> server # [ 70.867519] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: The default text search configuration will be set to "english". vm-test-run-timescaledb> server # [ 70.877122] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: Data page checksums are enabled. vm-test-run-timescaledb> server # [ 70.885676] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-timescaledb> server # [ 70.918275] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: creating subdirectories ... ok vm-test-run-timescaledb> server # [ 70.930877] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: selecting dynamic shared memory implementation ... posix vm-test-run-timescaledb> server # [ 72.071483] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: selecting default max_connections ... 100 vm-test-run-timescaledb> server # [ 72.686396] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: selecting default shared_buffers ... 128MB vm-test-run-timescaledb> server # [ 73.027889] mousedev: PS/2 mouse device common for all mice vm-test-run-timescaledb> server # [ 76.352090] systemd-logind[655]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-timescaledb> server # [ 82.386843] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: selecting default time zone ... UTC vm-test-run-timescaledb> server # [ 82.439312] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: creating configuration files ... ok vm-test-run-timescaledb> server # [ 86.048057] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: running bootstrap script ... ok vm-test-run-timescaledb> server # [ 96.916347] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: performing post-bootstrap initialization ... ok vm-test-run-timescaledb> server # [ 99.138571] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: syncing data to disk ... ok vm-test-run-timescaledb> server # [ 99.140155] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-timescaledb> server # [ 99.142370] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: 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 # [ 99.144391] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: Success. You can now start the database server using: vm-test-run-timescaledb> server # [ 99.147367] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1004]: /nix/store/2bhdbvpk81xy3mkfgqrpc719ip588cba-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-timescaledb> server # [ 100.456061] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[990]: Validating PostgreSQL configuration... vm-test-run-timescaledb> server # [ 100.935123] 4k2a8973il3lkplya4q61k8dhx9zl7xk-postgresql-init[1340]: 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 # [ 101.679308] postgres[1347]: 2026-10-08 00:52:05.075 UTC [1347] LOG: pgaudit extension initialized vm-test-run-timescaledb> server # [ 102.747110] postgres[1347]: 2026-10-08 00:52:06.123 UTC [1347] LOG: pgsodium primary server secret key loaded vm-test-run-timescaledb> server # [ 103.334237] postgres[1347]: 2026-10-08 00:52:06.732 UTC [1347] LOG: vault primary server secret key loaded vm-test-run-timescaledb> server # [ 103.910314] postgres[1347]: 2026-10-08 00:52:07.305 UTC [1347] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-timescaledb> server # [ 103.921597] postgres[1347]: 2026-10-08 00:52:07.318 UTC [1347] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-timescaledb> server # [ 103.924302] postgres[1347]: 2026-10-08 00:52:07.319 UTC [1347] LOG: listening on IPv6 address "::", port 5432 vm-test-run-timescaledb> server # [ 103.935596] postgres[1347]: 2026-10-08 00:52:07.334 UTC [1347] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-timescaledb> server # [ 104.039330] postgres[1381]: 2026-10-08 00:52:07.429 UTC [1381] LOG: database system was shut down at 2026-10-08 00:52:00 UTC vm-test-run-timescaledb> server # [ 104.233267] postgres[1347]: 2026-10-08 00:52:07.631 UTC [1347] LOG: database system is ready to accept connections vm-test-run-timescaledb> server # [ 104.259296] postgres[1385]: 2026-10-08 00:52:07.645 UTC [1385] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 104.278634] postgres[1384]: 2026-10-08 00:52:07.652 UTC [1384] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-timescaledb> server # [ 104.297705] systemd[1]: Started PostgreSQL Database Server. vm-test-run-timescaledb> server # [ 104.335608] systemd[1]: Starting Supabase Database Initialization... vm-test-run-timescaledb> server # [ 104.437024] postgres[1347]: 2026-10-08 00:52:07.832 UTC [1347] LOG: background worker "pg_net 0.20.4 worker" (PID 1385) exited with exit code 1 vm-test-run-timescaledb> server # [ 104.529949] postgres[1386]: 2026-10-08 00:52:07.922 UTC [1386] LOG: pg_cron scheduler started vm-test-run-timescaledb> server # [ 104.685655] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Waiting for PostgreSQL to be ready... vm-test-run-timescaledb> server # [ 105.407337] postgres[1396]: ::1 2026-10-08 00:52:08.786 UTC [1396] root@root FATAL: role "root" does not exist vm-test-run-timescaledb> server # [ 105.451886] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: PostgreSQL is ready vm-test-run-timescaledb> server # [ 105.461817] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Creating postgres role... vm-test-run-timescaledb> server # [ 105.632017] postgres[1402]: 2026-10-08 00:52:09.020 UTC [1402] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 105.802171] postgres[1347]: 2026-10-08 00:52:09.190 UTC [1347] LOG: background worker "pg_net 0.20.4 worker" (PID 1402) exited with exit code 1 vm-test-run-timescaledb> server # [ 106.039048] postgres[1406]: ::1 2026-10-08 00:52:09.415 UTC [1406] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-timescaledb> server # [ 106.094832] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1401]: CREATE ROLE vm-test-run-timescaledb> server # [ 106.422584] postgres[1418]: ::1 2026-10-08 00:52:09.816 UTC [1418] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-timescaledb> server # [ 106.437861] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1413]: ALTER DATABASE vm-test-run-timescaledb> server # [ 106.495611] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-timescaledb> server # [ 106.770658] postgres[1423]: ::1 2026-10-08 00:52:10.163 UTC [1423] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-timescaledb> server # [ 106.779440] postgres[1423]: ::1 2026-10-08 00:52:10.177 UTC [1423] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-timescaledb> server # [ 106.811404] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: CREATE PUBLICATION vm-test-run-timescaledb> server # [ 106.818222] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: ALTER ROLE vm-test-run-timescaledb> server # [ 106.825813] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 106.826898] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 106.827411] postgres[1423]: ::1 2026-10-08 00:52:10.187 UTC [1423] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-timescaledb> server # [ 106.833622] postgres[1423]: ::1 2026-10-08 00:52:10.205 UTC [1423] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-timescaledb> server # [ 106.837528] postgres[1423]: ::1 2026-10-08 00:52:10.218 UTC [1423] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-timescaledb> server # [ 106.838452] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 106.846049] postgres[1423]: ::1 2026-10-08 00:52:10.239 UTC [1423] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-timescaledb> server # [ 106.862452] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: GRANT vm-test-run-timescaledb> server # [ 106.864391] postgres[1423]: ::1 2026-10-08 00:52:10.257 UTC [1423] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-timescaledb> server # [ 106.881249] postgres[1423]: ::1 2026-10-08 00:52:10.275 UTC [1423] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-timescaledb> server # [ 106.883872] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 106.893043] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 106.896705] postgres[1423]: ::1 2026-10-08 00:52:10.293 UTC [1423] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-timescaledb> server # [ 106.909550] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 106.920187] postgres[1423]: ::1 2026-10-08 00:52:10.319 UTC [1423] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-timescaledb> server # [ 109.063013] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 109.095382] postgres[1423]: ::1 2026-10-08 00:52:12.452 UTC [1423] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-timescaledb> server # [ 110.008220] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 110.013426] postgres[1423]: ::1 2026-10-08 00:52:13.409 UTC [1423] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-timescaledb> server # [ 110.018106] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 110.021931] postgres[1423]: ::1 2026-10-08 00:52:13.419 UTC [1423] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-timescaledb> server # [ 110.027773] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 110.031820] postgres[1423]: ::1 2026-10-08 00:52:13.429 UTC [1423] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-timescaledb> server # [ 110.036917] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 110.038111] postgres[1423]: ::1 2026-10-08 00:52:13.435 UTC [1423] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-timescaledb> server # [ 110.042283] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 110.044608] postgres[1423]: ::1 2026-10-08 00:52:13.444 UTC [1423] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-timescaledb> server # [ 110.063344] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 110.066594] postgres[1423]: ::1 2026-10-08 00:52:13.460 UTC [1423] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-timescaledb> server # [ 110.070491] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 110.071568] postgres[1423]: ::1 2026-10-08 00:52:13.470 UTC [1423] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-timescaledb> server # [ 110.082024] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 110.087632] postgres[1423]: ::1 2026-10-08 00:52:13.482 UTC [1423] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-timescaledb> server # [ 110.099264] postgres[1423]: ::1 2026-10-08 00:52:13.493 UTC [1423] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 110.101736] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: GRANT ROLE vm-test-run-timescaledb> server # [ 110.102312] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: GRANT vm-test-run-timescaledb> server # [ 110.103179] postgres[1423]: ::1 2026-10-08 00:52:13.499 UTC [1423] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 110.119572] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 110.126054] postgres[1423]: ::1 2026-10-08 00:52:13.524 UTC [1423] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 110.133076] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 110.141727] postgres[1423]: ::1 2026-10-08 00:52:13.535 UTC [1423] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 110.146384] postgres[1423]: ::1 2026-10-08 00:52:13.545 UTC [1423] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 110.148041] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 110.154125] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: GRANT vm-test-run-timescaledb> server # [ 110.154895] postgres[1423]: ::1 2026-10-08 00:52:13.551 UTC [1423] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-timescaledb> server # [ 110.161661] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: ALTER ROLE vm-test-run-timescaledb> server # [ 110.164710] postgres[1423]: ::1 2026-10-08 00:52:13.563 UTC [1423] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 110.167960] postgres[1423]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 110.175785] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 110.177928] postgres[1423]: ::1 2026-10-08 00:52:13.573 UTC [1423] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 110.179811] postgres[1423]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 110.181960] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 110.183076] postgres[1423]: ::1 2026-10-08 00:52:13.582 UTC [1423] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 110.184183] postgres[1423]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 110.190394] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 110.193922] postgres[1423]: ::1 2026-10-08 00:52:13.591 UTC [1423] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-timescaledb> server # [ 110.198259] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: ALTER ROLE vm-test-run-timescaledb> server # [ 110.202289] postgres[1423]: ::1 2026-10-08 00:52:13.599 UTC [1423] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 110.210115] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1422]: ALTER ROLE vm-test-run-timescaledb> server # [ 110.254538] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-timescaledb> server # [ 110.447804] postgres[1454]: ::1 2026-10-08 00:52:13.842 UTC [1454] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 110.465293] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 110.466161] postgres[1454]: ::1 2026-10-08 00:52:13.859 UTC [1454] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-timescaledb> server # [ 110.467106] postgres[1454]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 110.467419] postgres[1454]: id uuid NOT NULL UNIQUE, vm-test-run-timescaledb> server # [ 110.467684] postgres[1454]: aud varchar(255) NULL, vm-test-run-timescaledb> server # [ 110.467957] postgres[1454]: "role" varchar(255) NULL, vm-test-run-timescaledb> server # [ 110.470648] postgres[1454]: email varchar(255) NULL UNIQUE, vm-test-run-timescaledb> server # [ 110.471771] postgres[1454]: encrypted_password varchar(255) NULL, vm-test-run-timescaledb> server # [ 110.473728] postgres[1454]: confirmed_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.478645] postgres[1454]: invited_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.479815] postgres[1454]: confirmation_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 110.484969] postgres[1454]: confirmation_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.485760] postgres[1454]: recovery_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 110.486223] postgres[1454]: recovery_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.487538] postgres[1454]: email_change_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 110.488091] postgres[1454]: email_change varchar(255) NULL, vm-test-run-timescaledb> server # [ 110.493024] postgres[1454]: email_change_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.495361] postgres[1454]: last_sign_in_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.496636] postgres[1454]: raw_app_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 110.499282] postgres[1454]: raw_user_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 110.499986] postgres[1454]: is_super_admin bool NULL, vm-test-run-timescaledb> server # [ 110.501066] postgres[1454]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.502044] postgres[1454]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.503032] postgres[1454]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 110.503761] postgres[1454]: ); vm-test-run-timescaledb> server # [ 110.581359] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE TABLE vm-test-run-timescaledb> server # [ 110.585219] postgres[1454]: ::1 2026-10-08 00:52:13.983 UTC [1454] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-timescaledb> server # [ 110.610192] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE INDEX vm-test-run-timescaledb> server # [ 110.615355] postgres[1454]: ::1 2026-10-08 00:52:14.012 UTC [1454] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-timescaledb> server # [ 110.637444] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE INDEX vm-test-run-timescaledb> server # [ 110.639316] postgres[1454]: ::1 2026-10-08 00:52:14.038 UTC [1454] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-timescaledb> server # [ 110.652675] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: COMMENT vm-test-run-timescaledb> server # [ 110.653864] postgres[1454]: ::1 2026-10-08 00:52:14.052 UTC [1454] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-timescaledb> server # [ 110.654558] postgres[1454]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 110.661353] postgres[1454]: id bigserial NOT NULL, vm-test-run-timescaledb> server # [ 110.662071] postgres[1454]: "token" varchar(255) NULL, vm-test-run-timescaledb> server # [ 110.663023] postgres[1454]: user_id varchar(255) NULL, vm-test-run-timescaledb> server # [ 110.664333] postgres[1454]: revoked bool NULL, vm-test-run-timescaledb> server # [ 110.667960] postgres[1454]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.668648] postgres[1454]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.669147] postgres[1454]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 110.669462] postgres[1454]: ); vm-test-run-timescaledb> server # [ 110.746037] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE TABLE vm-test-run-timescaledb> server # [ 110.747000] postgres[1454]: ::1 2026-10-08 00:52:14.145 UTC [1454] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-timescaledb> server # [ 110.781523] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE INDEX vm-test-run-timescaledb> server # [ 110.785382] postgres[1454]: ::1 2026-10-08 00:52:14.183 UTC [1454] 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 # [ 110.824694] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE INDEX vm-test-run-timescaledb> server # [ 110.828140] postgres[1454]: ::1 2026-10-08 00:52:14.226 UTC [1454] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-timescaledb> server # [ 110.872421] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE INDEX vm-test-run-timescaledb> server # [ 110.881689] postgres[1454]: ::1 2026-10-08 00:52:14.277 UTC [1454] 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 # [ 110.891404] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: COMMENT vm-test-run-timescaledb> server # [ 110.896997] postgres[1454]: ::1 2026-10-08 00:52:14.291 UTC [1454] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-timescaledb> server # [ 110.899083] postgres[1454]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 110.899702] postgres[1454]: uuid uuid NULL, vm-test-run-timescaledb> server # [ 110.900219] postgres[1454]: raw_base_config text NULL, vm-test-run-timescaledb> server # [ 110.902350] postgres[1454]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.902829] postgres[1454]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 110.903126] postgres[1454]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 110.903396] postgres[1454]: ); vm-test-run-timescaledb> server # [ 110.978455] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE TABLE vm-test-run-timescaledb> server # [ 110.985377] postgres[1454]: ::1 2026-10-08 00:52:14.381 UTC [1454] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-timescaledb> server # [ 110.992502] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: COMMENT vm-test-run-timescaledb> server # [ 110.998670] postgres[1454]: ::1 2026-10-08 00:52:14.394 UTC [1454] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-timescaledb> server # [ 111.000688] postgres[1454]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 111.002431] postgres[1454]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 111.003123] postgres[1454]: payload json NULL, vm-test-run-timescaledb> server # [ 111.003467] postgres[1454]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 111.003872] postgres[1454]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 111.005038] postgres[1454]: ); vm-test-run-timescaledb> server # [ 111.057692] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE TABLE vm-test-run-timescaledb> server # [ 111.058579] postgres[1454]: ::1 2026-10-08 00:52:14.457 UTC [1454] 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 # [ 111.088921] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE INDEX vm-test-run-timescaledb> server # [ 111.093235] postgres[1454]: ::1 2026-10-08 00:52:14.491 UTC [1454] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-timescaledb> server # [ 111.105107] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: COMMENT vm-test-run-timescaledb> server # [ 111.110857] postgres[1454]: ::1 2026-10-08 00:52:14.508 UTC [1454] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-timescaledb> server # [ 111.114953] postgres[1454]: "version" varchar(255) NOT NULL, vm-test-run-timescaledb> server # [ 111.115549] postgres[1454]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-timescaledb> server # [ 111.115870] postgres[1454]: ); vm-test-run-timescaledb> server # [ 111.162818] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE TABLE vm-test-run-timescaledb> server # [ 111.174796] postgres[1454]: ::1 2026-10-08 00:52:14.566 UTC [1454] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-timescaledb> server # [ 111.182253] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: COMMENT vm-test-run-timescaledb> server # [ 111.220776] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: INSERT 0 7 vm-test-run-timescaledb> server # [ 111.223756] postgres[1454]: ::1 2026-10-08 00:52:14.623 UTC [1454] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-timescaledb> server # [ 111.225856] postgres[1454]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-timescaledb> server # [ 111.227017] postgres[1454]: $$ language sql stable; vm-test-run-timescaledb> server # [ 111.241321] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 111.253230] postgres[1454]: ::1 2026-10-08 00:52:14.650 UTC [1454] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-timescaledb> server # [ 111.255223] postgres[1454]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-timescaledb> server # [ 111.261794] postgres[1454]: $$ language sql stable; vm-test-run-timescaledb> server # [ 111.271546] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 111.276949] postgres[1454]: ::1 2026-10-08 00:52:14.667 UTC [1454] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-timescaledb> server # [ 111.278106] postgres[1454]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-timescaledb> server # [ 111.278997] postgres[1454]: $$ language sql stable; vm-test-run-timescaledb> server # [ 111.285872] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 111.293041] postgres[1454]: ::1 2026-10-08 00:52:14.687 UTC [1454] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 111.304733] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: GRANT vm-test-run-timescaledb> server # [ 111.306015] postgres[1454]: ::1 2026-10-08 00:52:14.702 UTC [1454] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 111.314708] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: CREATE ROLE vm-test-run-timescaledb> server # [ 111.320665] postgres[1454]: ::1 2026-10-08 00:52:14.715 UTC [1454] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 111.336897] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: GRANT vm-test-run-timescaledb> server # [ 111.337793] postgres[1454]: ::1 2026-10-08 00:52:14.729 UTC [1454] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 111.339324] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: GRANT vm-test-run-timescaledb> server # [ 111.339941] postgres[1454]: ::1 2026-10-08 00:52:14.737 UTC [1454] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 111.351341] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: GRANT vm-test-run-timescaledb> server # [ 111.373862] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: ALTER ROLE vm-test-run-timescaledb> server # [ 111.374667] postgres[1454]: ::1 2026-10-08 00:52:14.751 UTC [1454] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-timescaledb> server # [ 111.375332] postgres[1454]: ::1 2026-10-08 00:52:14.765 UTC [1454] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 111.401000] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: ALTER TABLE vm-test-run-timescaledb> server # [ 111.402339] postgres[1454]: ::1 2026-10-08 00:52:14.796 UTC [1454] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 111.426926] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: ALTER TABLE vm-test-run-timescaledb> server # [ 111.433399] postgres[1454]: ::1 2026-10-08 00:52:14.830 UTC [1454] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 111.466316] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: ALTER TABLE vm-test-run-timescaledb> server # [ 111.484751] postgres[1454]: ::1 2026-10-08 00:52:14.851 UTC [1454] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 111.487195] postgres[1454]: ::1 2026-10-08 00:52:14.881 UTC [1454] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 111.496981] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: ALTER TABLE vm-test-run-timescaledb> server # [ 111.513936] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1453]: ALTER TABLE vm-test-run-timescaledb> server # [ 111.579466] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-timescaledb> server # [ 111.844764] postgres[1471]: ::1 2026-10-08 00:52:15.234 UTC [1471] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 111.863169] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1468]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 111.865941] postgres[1471]: ::1 2026-10-08 00:52:15.255 UTC [1471] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 111.867110] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1468]: CREATE ROLE vm-test-run-timescaledb> server # [ 111.867598] postgres[1471]: ::1 2026-10-08 00:52:15.267 UTC [1471] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-timescaledb> server # [ 111.877562] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1468]: ALTER ROLE vm-test-run-timescaledb> server # [ 111.878889] postgres[1471]: ::1 2026-10-08 00:52:15.278 UTC [1471] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-timescaledb> server # [ 111.897079] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1468]: GRANT vm-test-run-timescaledb> server # [ 111.954867] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1468]: DO vm-test-run-timescaledb> server # [ 111.992072] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-timescaledb> server # [ 112.254127] postgres[1482]: ::1 2026-10-08 00:52:15.648 UTC [1482] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-timescaledb> server # [ 112.274565] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: ALTER ROLE vm-test-run-timescaledb> server # [ 112.277397] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: ALTER ROLE vm-test-run-timescaledb> server # [ 112.280906] postgres[1482]: ::1 2026-10-08 00:52:15.672 UTC [1482] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-timescaledb> server # [ 112.282292] postgres[1482]: ::1 2026-10-08 00:52:15.679 UTC [1482] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-timescaledb> server # [ 112.283633] postgres[1482]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 112.284108] postgres[1482]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 112.290905] postgres[1482]: AS $$ vm-test-run-timescaledb> server # [ 112.291435] postgres[1482]: DECLARE vm-test-run-timescaledb> server # [ 112.300805] postgres[1482]: schema_is_cron bool; vm-test-run-timescaledb> server # [ 112.301647] postgres[1482]: BEGIN vm-test-run-timescaledb> server # [ 112.302926] postgres[1482]: schema_is_cron = ( vm-test-run-timescaledb> server # [ 112.303404] postgres[1482]: SELECT n.nspname = 'cron' vm-test-run-timescaledb> server # [ 112.304273] postgres[1482]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 112.309227] postgres[1482]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-timescaledb> server # [ 112.310013] postgres[1482]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 112.311698] postgres[1482]: ); vm-test-run-timescaledb> server # [ 112.319580] postgres[1482]: vm-test-run-timescaledb> server # [ 112.320749] postgres[1482]: IF schema_is_cron vm-test-run-timescaledb> server # [ 112.321115] postgres[1482]: THEN vm-test-run-timescaledb> server # [ 112.321600] postgres[1482]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 112.322043] postgres[1482]: vm-test-run-timescaledb> server # [ 112.322438] postgres[1482]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 112.323379] postgres[1482]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 112.324032] postgres[1482]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 112.325725] postgres[1482]: vm-test-run-timescaledb> server # [ 112.326119] postgres[1482]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 112.328654] postgres[1482]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 112.329503] postgres[1482]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 112.329901] postgres[1482]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 112.330381] postgres[1482]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 112.331016] postgres[1482]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 112.331450] postgres[1482]: vm-test-run-timescaledb> server # [ 112.331702] postgres[1482]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 112.332736] postgres[1482]: vm-test-run-timescaledb> server # [ 112.333373] postgres[1482]: END IF; vm-test-run-timescaledb> server # [ 112.333695] postgres[1482]: vm-test-run-timescaledb> server # [ 112.334111] postgres[1482]: END; vm-test-run-timescaledb> server # [ 112.334590] postgres[1482]: $$; vm-test-run-timescaledb> server # [ 112.335422] postgres[1482]: ::1 2026-10-08 00:52:15.713 UTC [1482] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA') vm-test-run-timescaledb> server # [ 112.336056] postgres[1482]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 112.338211] postgres[1482]: ::1 2026-10-08 00:52:15.730 UTC [1482] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-timescaledb> server # [ 112.339132] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 112.339797] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 112.351467] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: COMMENT vm-test-run-timescaledb> server # [ 112.353136] postgres[1482]: ::1 2026-10-08 00:52:15.749 UTC [1482] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-timescaledb> server # [ 112.353789] postgres[1482]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 112.354137] postgres[1482]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 112.354524] postgres[1482]: AS $$ vm-test-run-timescaledb> server # [ 112.355067] postgres[1482]: BEGIN vm-test-run-timescaledb> server # [ 112.355433] postgres[1482]: IF EXISTS ( vm-test-run-timescaledb> server # [ 112.355903] postgres[1482]: SELECT 1 vm-test-run-timescaledb> server # [ 112.357266] postgres[1482]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 112.357597] postgres[1482]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 112.358072] postgres[1482]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 112.358428] postgres[1482]: WHERE ext.extname = 'pg_net' vm-test-run-timescaledb> server # [ 112.359104] postgres[1482]: ) vm-test-run-timescaledb> server # [ 112.359566] postgres[1482]: THEN vm-test-run-timescaledb> server # [ 112.359878] postgres[1482]: IF NOT EXISTS ( vm-test-run-timescaledb> server # [ 112.362909] postgres[1482]: SELECT 1 vm-test-run-timescaledb> server # [ 112.364180] postgres[1482]: FROM pg_roles vm-test-run-timescaledb> server # [ 112.366406] postgres[1482]: WHERE rolname = 'supabase_functions_admin' vm-test-run-timescaledb> server # [ 112.367047] postgres[1482]: ) vm-test-run-timescaledb> server # [ 112.367694] postgres[1482]: THEN vm-test-run-timescaledb> server # [ 112.367985] postgres[1482]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 112.369164] postgres[1482]: END IF; vm-test-run-timescaledb> server # [ 112.369645] postgres[1482]: vm-test-run-timescaledb> server # [ 112.370158] postgres[1482]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.371539] postgres[1482]: vm-test-run-timescaledb> server # [ 112.372171] postgres[1482]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 112.375816] postgres[1482]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 112.377992] postgres[1482]: vm-test-run-timescaledb> server # [ 112.378969] postgres[1482]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-timescaledb> server # [ 112.382230] postgres[1482]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-timescaledb> server # [ 112.382846] postgres[1482]: vm-test-run-timescaledb> server # [ 112.383578] postgres[1482]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-timescaledb> server # [ 112.385834] postgres[1482]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-timescaledb> server # [ 112.387021] postgres[1482]: vm-test-run-timescaledb> server # [ 112.387646] postgres[1482]: GRANT EXECUTE ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.393808] postgres[1482]: GRANT EXECUTE ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.394407] postgres[1482]: END IF; vm-test-run-timescaledb> server # [ 112.394997] postgres[1482]: END; vm-test-run-timescaledb> server # [ 112.395481] postgres[1482]: $$; vm-test-run-timescaledb> server # [ 112.395926] postgres[1482]: ::1 2026-10-08 00:52:15.767 UTC [1482] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-timescaledb> server # [ 112.396368] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 112.397739] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: COMMENT vm-test-run-timescaledb> server # [ 112.403806] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: DO vm-test-run-timescaledb> server # [ 112.406998] postgres[1482]: ::1 2026-10-08 00:52:15.806 UTC [1482] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-timescaledb> server # [ 112.418502] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: CREATE ROLE vm-test-run-timescaledb> server # [ 112.419750] postgres[1482]: ::1 2026-10-08 00:52:15.816 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-timescaledb> server # [ 112.432009] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: GRANT vm-test-run-timescaledb> server # [ 112.432778] postgres[1482]: ::1 2026-10-08 00:52:15.831 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 112.439983] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: GRANT vm-test-run-timescaledb> server # [ 112.440967] postgres[1482]: ::1 2026-10-08 00:52:15.840 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 112.451282] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: GRANT vm-test-run-timescaledb> server # [ 112.454932] postgres[1482]: ::1 2026-10-08 00:52:15.851 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 112.463544] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: GRANT vm-test-run-timescaledb> server # [ 112.470340] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: GRANT vm-test-run-timescaledb> server # [ 112.472210] postgres[1482]: ::1 2026-10-08 00:52:15.864 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 112.484754] postgres[1482]: ::1 2026-10-08 00:52:15.870 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 112.493619] postgres[1482]: ::1 2026-10-08 00:52:15.890 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 112.503338] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: GRANT vm-test-run-timescaledb> server # [ 112.504120] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: GRANT vm-test-run-timescaledb> server # [ 112.511866] postgres[1482]: ::1 2026-10-08 00:52:15.897 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 112.528714] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: GRANT vm-test-run-timescaledb> server # [ 112.534244] postgres[1482]: ::1 2026-10-08 00:52:15.929 UTC [1482] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 112.581974] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: GRANT vm-test-run-timescaledb> server # [ 112.607865] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1479]: DO vm-test-run-timescaledb> server # [ 112.659434] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running pgbouncer auth schema... vm-test-run-timescaledb> server # [ 112.918155] postgres[1488]: ::1 2026-10-08 00:52:16.290 UTC [1488] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-timescaledb> server # [ 112.920064] postgres[1488]: ::1 2026-10-08 00:52:16.302 UTC [1488] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-timescaledb> server # [ 112.929340] postgres[1488]: ::1 2026-10-08 00:52:16.310 UTC [1488] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-timescaledb> server # [ 112.941761] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1486]: CREATE ROLE vm-test-run-timescaledb> server # [ 112.942627] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1486]: REVOKE vm-test-run-timescaledb> server # [ 112.972815] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1486]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 112.973769] postgres[1488]: ::1 2026-10-08 00:52:16.370 UTC [1488] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-timescaledb> server # [ 112.974900] postgres[1488]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-timescaledb> server # [ 112.976268] postgres[1488]: $$ vm-test-run-timescaledb> server # [ 112.986120] postgres[1488]: BEGIN vm-test-run-timescaledb> server # [ 112.987040] postgres[1488]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-timescaledb> server # [ 112.996974] postgres[1488]: vm-test-run-timescaledb> server # [ 112.997653] postgres[1488]: RETURN QUERY vm-test-run-timescaledb> server # [ 113.002120] postgres[1488]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-timescaledb> server # [ 113.002856] postgres[1488]: WHERE usename = p_usename; vm-test-run-timescaledb> server # [ 113.004392] postgres[1488]: END; vm-test-run-timescaledb> server # [ 113.018616] postgres[1488]: $$ LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 113.028906] postgres[1488]: SET search_path = '' vm-test-run-timescaledb> server # [ 113.030331] postgres[1488]: SECURITY DEFINER; vm-test-run-timescaledb> server # [ 113.032110] postgres[1488]: ::1 2026-10-08 00:52:16.389 UTC [1488] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-timescaledb> server # [ 113.039939] postgres[1488]: ::1 2026-10-08 00:52:16.396 UTC [1488] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-timescaledb> server # [ 113.049953] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1486]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 113.050816] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1486]: REVOKE vm-test-run-timescaledb> server # [ 113.051180] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1486]: GRANT vm-test-run-timescaledb> server # [ 113.051563] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running stat extension... vm-test-run-timescaledb> server # [ 113.353051] postgres[1490]: ::1 2026-10-08 00:52:16.746 UTC [1490] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-timescaledb> server # [ 113.377347] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1489]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-timescaledb> server # [ 113.388948] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1489]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 113.391382] postgres[1490]: ::1 2026-10-08 00:52:16.787 UTC [1490] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-timescaledb> server # [ 114.472125] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1489]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 114.537346] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-timescaledb> server # [ 114.859686] postgres[1501]: ::1 2026-10-08 00:52:18.247 UTC [1501] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-timescaledb> server # [ 114.860906] postgres[1501]: ::1 2026-10-08 00:52:18.259 UTC [1501] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 114.894162] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 114.895208] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 114.905819] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 114.910808] postgres[1501]: ::1 2026-10-08 00:52:18.267 UTC [1501] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 114.936396] postgres[1501]: ::1 2026-10-08 00:52:18.278 UTC [1501] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 114.938463] postgres[1501]: ::1 2026-10-08 00:52:18.292 UTC [1501] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 114.940025] postgres[1501]: ::1 2026-10-08 00:52:18.302 UTC [1501] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 114.950664] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 114.951392] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 114.965711] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 114.966519] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 114.967166] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 114.967637] postgres[1501]: ::1 2026-10-08 00:52:18.314 UTC [1501] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 114.973384] postgres[1501]: ::1 2026-10-08 00:52:18.318 UTC [1501] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 114.979629] postgres[1501]: ::1 2026-10-08 00:52:18.331 UTC [1501] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 114.987938] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 115.058093] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1498]: DO vm-test-run-timescaledb> server # [ 115.059569] postgres[1501]: ::1 2026-10-08 00:52:18.458 UTC [1501] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-timescaledb> server # [ 115.066292] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1498]: ALTER ROLE vm-test-run-timescaledb> server # [ 115.100626] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-timescaledb> server # [ 115.459957] postgres[1512]: ::1 2026-10-08 00:52:18.853 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 115.476234] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: GRANT vm-test-run-timescaledb> server # [ 115.486005] postgres[1512]: ::1 2026-10-08 00:52:18.871 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 115.490319] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: GRANT vm-test-run-timescaledb> server # [ 115.491186] postgres[1512]: ::1 2026-10-08 00:52:18.890 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 115.501887] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: GRANT vm-test-run-timescaledb> server # [ 115.510655] postgres[1512]: ::1 2026-10-08 00:52:18.909 UTC [1512] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 115.529239] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: ALTER TABLE vm-test-run-timescaledb> server # [ 115.536681] postgres[1512]: ::1 2026-10-08 00:52:18.933 UTC [1512] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 115.552987] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: ALTER TABLE vm-test-run-timescaledb> server # [ 115.555024] postgres[1512]: ::1 2026-10-08 00:52:18.951 UTC [1512] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 115.569313] postgres[1512]: ::1 2026-10-08 00:52:18.965 UTC [1512] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 115.573075] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: ALTER TABLE vm-test-run-timescaledb> server # [ 115.578487] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: ALTER TABLE vm-test-run-timescaledb> server # [ 115.579413] postgres[1512]: ::1 2026-10-08 00:52:18.975 UTC [1512] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 115.592882] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: ALTER TABLE vm-test-run-timescaledb> server # [ 115.595510] postgres[1512]: ::1 2026-10-08 00:52:18.990 UTC [1512] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 115.604897] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: GRANT vm-test-run-timescaledb> server # [ 115.606105] postgres[1512]: ::1 2026-10-08 00:52:18.999 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 115.613484] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: GRANT vm-test-run-timescaledb> server # [ 115.618387] postgres[1512]: ::1 2026-10-08 00:52:19.015 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 115.633922] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: GRANT vm-test-run-timescaledb> server # [ 115.653057] postgres[1512]: ::1 2026-10-08 00:52:19.030 UTC [1512] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 115.661342] postgres[1512]: ::1 2026-10-08 00:52:19.044 UTC [1512] 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 # [ 115.677495] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: GRANT vm-test-run-timescaledb> server # [ 115.678300] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 115.679730] postgres[1512]: ::1 2026-10-08 00:52:19.073 UTC [1512] 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 # [ 115.685386] postgres[1512]: ::1 2026-10-08 00:52:19.085 UTC [1512] 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 # [ 115.686442] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 115.694404] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1507]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 115.744682] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-timescaledb> server # [ 115.959732] postgres[1520]: ::1 2026-10-08 00:52:19.356 UTC [1520] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-timescaledb> server # [ 115.987950] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1519]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 116.019776] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 116.339311] postgres[1526]: ::1 2026-10-08 00:52:19.721 UTC [1526] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-timescaledb> server # [ 116.358671] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1521]: GRANT vm-test-run-timescaledb> server # [ 116.369257] postgres[1526]: ::1 2026-10-08 00:52:19.756 UTC [1526] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 116.371710] postgres[1526]: ::1 2026-10-08 00:52:19.762 UTC [1526] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 116.382460] postgres[1526]: ::1 2026-10-08 00:52:19.774 UTC [1526] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 116.389433] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1521]: GRANT vm-test-run-timescaledb> server # [ 116.390417] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1521]: GRANT vm-test-run-timescaledb> server # [ 116.391533] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1521]: GRANT vm-test-run-timescaledb> server # [ 116.431319] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-timescaledb> server # [ 116.751102] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: DO vm-test-run-timescaledb> server # [ 116.757561] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: DO vm-test-run-timescaledb> server # [ 116.767532] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: DO vm-test-run-timescaledb> server # [ 116.819353] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 117.004584] postgres[1530]: ::1 2026-10-08 00:52:20.399 UTC [1530] 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 # [ 117.024033] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1529]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 117.030376] postgres[1530]: ::1 2026-10-08 00:52:20.418 UTC [1530] 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 # [ 117.032078] postgres[1530]: ::1 2026-10-08 00:52:20.428 UTC [1530] 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 # [ 117.034446] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1529]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 117.042319] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1529]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 117.071732] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-timescaledb> server # [ 117.293300] postgres[1532]: ::1 2026-10-08 00:52:20.680 UTC [1532] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-timescaledb> server # [ 117.310885] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1531]: ALTER ROLE vm-test-run-timescaledb> server # [ 117.332934] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-timescaledb> server # [ 117.634289] postgres[1537]: ::1 2026-10-08 00:52:21.013 UTC [1537] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 117.640683] postgres[1537]: ::1 2026-10-08 00:52:21.029 UTC [1537] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 117.669542] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-timescaledb> server # [ 117.670521] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 117.671273] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-timescaledb> server # [ 117.686080] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: DROP FUNCTION vm-test-run-timescaledb> server # [ 117.688765] postgres[1537]: ::1 2026-10-08 00:52:21.047 UTC [1537] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 117.691937] postgres[1537]: DECLARE vm-test-run-timescaledb> server # [ 117.697999] postgres[1537]: cmd record; vm-test-run-timescaledb> server # [ 117.700200] postgres[1537]: BEGIN vm-test-run-timescaledb> server # [ 117.702231] postgres[1537]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 117.724595] postgres[1537]: LOOP vm-test-run-timescaledb> server # [ 117.725767] postgres[1537]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 117.727357] postgres[1537]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 117.734288] postgres[1537]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 117.736477] postgres[1537]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 117.743832] postgres[1537]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 117.753841] postgres[1537]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 117.754561] postgres[1537]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 117.755230] postgres[1537]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 117.756144] postgres[1537]: , 'CREATE TYPE' vm-test-run-timescaledb> server # [ 117.768560] postgres[1537]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 117.771380] postgres[1537]: , 'COMMENT' vm-test-run-timescaledb> server # [ 117.778550] postgres[1537]: ) vm-test-run-timescaledb> server # [ 117.783543] postgres[1537]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 117.790920] postgres[1537]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 117.797318] postgres[1537]: THEN vm-test-run-timescaledb> server # [ 117.797859] postgres[1537]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 117.798617] postgres[1537]: END IF; vm-test-run-timescaledb> server # [ 117.799710] postgres[1537]: END LOOP; vm-test-run-timescaledb> server # [ 117.811654] postgres[1537]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 117.817367] postgres[1537]: ::1 2026-10-08 00:52:21.122 UTC [1537] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 117.820014] postgres[1537]: DECLARE vm-test-run-timescaledb> server # [ 117.830410] postgres[1537]: obj record; vm-test-run-timescaledb> server # [ 117.832055] postgres[1537]: BEGIN vm-test-run-timescaledb> server # [ 117.848022] postgres[1537]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 117.863460] postgres[1537]: LOOP vm-test-run-timescaledb> server # [ 117.874630] postgres[1537]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 117.875878] postgres[1537]: 'schema' vm-test-run-timescaledb> server # [ 117.882863] postgres[1537]: , 'table' vm-test-run-timescaledb> server # [ 117.888021] postgres[1537]: , 'foreign table' vm-test-run-timescaledb> server # [ 117.897036] postgres[1537]: , 'view' vm-test-run-timescaledb> server # [ 117.905042] postgres[1537]: , 'materialized view' vm-test-run-timescaledb> server # [ 117.907297] postgres[1537]: , 'function' vm-test-run-timescaledb> server # [ 117.915164] postgres[1537]: , 'trigger' vm-test-run-timescaledb> server # [ 117.926123] postgres[1537]: , 'type' vm-test-run-timescaledb> server # [ 117.927094] postgres[1537]: , 'rule' vm-test-run-timescaledb> server # [ 117.927469] postgres[1537]: ) vm-test-run-timescaledb> server # [ 117.939659] postgres[1537]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 117.953797] postgres[1537]: THEN vm-test-run-timescaledb> server # [ 117.956557] postgres[1537]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 117.971181] postgres[1537]: END IF; vm-test-run-timescaledb> server # [ 117.978348] postgres[1537]: END LOOP; vm-test-run-timescaledb> server # [ 117.979154] postgres[1537]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 117.979958] postgres[1537]: ::1 2026-10-08 00:52:21.152 UTC [1537] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 117.989628] postgres[1537]: ::1 2026-10-08 00:52:21.173 UTC [1537] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 117.990638] postgres[1537]: ON ddl_command_end vm-test-run-timescaledb> server # [ 117.991677] postgres[1537]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 118.002401] postgres[1537]: ::1 2026-10-08 00:52:21.195 UTC [1537] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 118.009430] postgres[1537]: ::1 2026-10-08 00:52:21.200 UTC [1537] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 118.014119] postgres[1537]: ON sql_drop vm-test-run-timescaledb> server # [ 118.015084] postgres[1537]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 118.025990] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 118.038651] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 118.039822] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 118.041668] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 118.049915] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 118.051442] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 118.058357] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 118.065803] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1533]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 118.079804] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-timescaledb> server # [ 118.953431] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1547]: DO vm-test-run-timescaledb> server # [ 118.971816] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-timescaledb> server # [ 119.193379] postgres[1562]: ::1 2026-10-08 00:52:22.587 UTC [1562] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-timescaledb> server # [ 119.230731] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 119.237512] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping vm-test-run-timescaledb> server # [ 119.240275] postgres[1562]: ::1 2026-10-08 00:52:22.633 UTC [1562] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-timescaledb> server # [ 119.251651] postgres[1562]: ::1 2026-10-08 00:52:22.646 UTC [1562] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 119.253970] postgres[1562]: "operationName" text default null, vm-test-run-timescaledb> server # [ 119.254837] postgres[1562]: query text default null, vm-test-run-timescaledb> server # [ 119.257474] postgres[1562]: variables jsonb default null, vm-test-run-timescaledb> server # [ 119.258500] postgres[1562]: extensions jsonb default null vm-test-run-timescaledb> server # [ 119.259036] postgres[1562]: ) vm-test-run-timescaledb> server # [ 119.259623] postgres[1562]: returns jsonb vm-test-run-timescaledb> server # [ 119.260431] postgres[1562]: language plpgsql vm-test-run-timescaledb> server # [ 119.262499] postgres[1562]: as $$ vm-test-run-timescaledb> server # [ 119.263293] postgres[1562]: DECLARE vm-test-run-timescaledb> server # [ 119.263848] postgres[1562]: server_version float; vm-test-run-timescaledb> server # [ 119.265318] postgres[1562]: BEGIN vm-test-run-timescaledb> server # [ 119.265687] postgres[1562]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 119.266548] postgres[1562]: vm-test-run-timescaledb> server # [ 119.267251] postgres[1562]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 119.267907] postgres[1562]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 119.269288] postgres[1562]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 119.269954] postgres[1562]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 119.270658] postgres[1562]: ); vm-test-run-timescaledb> server # [ 119.271255] postgres[1562]: ELSE vm-test-run-timescaledb> server # [ 119.271822] postgres[1562]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 119.272970] postgres[1562]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 119.274383] postgres[1562]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 119.275386] postgres[1562]: ); vm-test-run-timescaledb> server # [ 119.275787] postgres[1562]: END IF; vm-test-run-timescaledb> server # [ 119.277615] postgres[1562]: END; vm-test-run-timescaledb> server # [ 119.278010] postgres[1562]: $$; vm-test-run-timescaledb> server # [ 119.280055] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: DROP FUNCTION vm-test-run-timescaledb> server # [ 119.283346] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 119.289352] postgres[1562]: ::1 2026-10-08 00:52:22.685 UTC [1562] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.295724] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: GRANT vm-test-run-timescaledb> server # [ 119.300937] postgres[1562]: ::1 2026-10-08 00:52:22.698 UTC [1562] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.310483] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 119.312821] postgres[1562]: ::1 2026-10-08 00:52:22.712 UTC [1562] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.325018] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 119.328702] postgres[1562]: ::1 2026-10-08 00:52:22.726 UTC [1562] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.338182] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 119.339199] postgres[1562]: ::1 2026-10-08 00:52:22.738 UTC [1562] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 119.339680] postgres[1562]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.346054] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 119.351395] postgres[1562]: ::1 2026-10-08 00:52:22.749 UTC [1562] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 119.354737] postgres[1562]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.364846] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 119.366902] postgres[1562]: ::1 2026-10-08 00:52:22.762 UTC [1562] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 119.369154] postgres[1562]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.373500] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 119.380973] postgres[1562]: ::1 2026-10-08 00:52:22.776 UTC [1562] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 119.382643] postgres[1562]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 119.383285] postgres[1562]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 119.383566] postgres[1562]: AS $func$ vm-test-run-timescaledb> server # [ 119.383834] postgres[1562]: DECLARE vm-test-run-timescaledb> server # [ 119.384061] postgres[1562]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 119.387854] postgres[1562]: BEGIN vm-test-run-timescaledb> server # [ 119.388859] postgres[1562]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 119.389554] postgres[1562]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 119.390257] postgres[1562]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 119.391022] postgres[1562]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 119.391876] postgres[1562]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 119.393924] postgres[1562]: ); vm-test-run-timescaledb> server # [ 119.402476] postgres[1562]: vm-test-run-timescaledb> server # [ 119.403029] postgres[1562]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 119.403367] postgres[1562]: THEN vm-test-run-timescaledb> server # [ 119.403756] postgres[1562]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.406165] postgres[1562]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.407201] postgres[1562]: vm-test-run-timescaledb> server # [ 119.407766] postgres[1562]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.409555] postgres[1562]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.410587] postgres[1562]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.413045] postgres[1562]: vm-test-run-timescaledb> server # [ 119.413714] postgres[1562]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 119.414068] postgres[1562]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 119.414451] postgres[1562]: "operationName" text default null, vm-test-run-timescaledb> server # [ 119.414776] postgres[1562]: query text default null, vm-test-run-timescaledb> server # [ 119.415189] postgres[1562]: variables jsonb default null, vm-test-run-timescaledb> server # [ 119.415499] postgres[1562]: extensions jsonb default null vm-test-run-timescaledb> server # [ 119.417146] postgres[1562]: ) vm-test-run-timescaledb> server # [ 119.417528] postgres[1562]: returns jsonb vm-test-run-timescaledb> server # [ 119.419790] postgres[1562]: language sql vm-test-run-timescaledb> server # [ 119.421681] postgres[1562]: as $$ vm-test-run-timescaledb> server # [ 119.422341] postgres[1562]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-timescaledb> server # [ 119.422639] postgres[1562]: $$; vm-test-run-timescaledb> server # [ 119.423367] postgres[1562]: vm-test-run-timescaledb> server # [ 119.423673] postgres[1562]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 119.423984] postgres[1562]: END IF; vm-test-run-timescaledb> server # [ 119.424778] postgres[1562]: vm-test-run-timescaledb> server # [ 119.425389] postgres[1562]: END; vm-test-run-timescaledb> server # [ 119.426137] postgres[1562]: $func$; vm-test-run-timescaledb> server # [ 119.427584] postgres[1562]: ::1 2026-10-08 00:52:22.797 UTC [1562] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-timescaledb> server # [ 119.429545] postgres[1562]: ::1 2026-10-08 00:52:22.799 UTC [1562] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION') vm-test-run-timescaledb> server # [ 119.430203] postgres[1562]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-timescaledb> server # [ 119.430810] postgres[1562]: ::1 2026-10-08 00:52:22.813 UTC [1562] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-timescaledb> server # [ 119.432334] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 119.433327] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping vm-test-run-timescaledb> server # [ 119.434861] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 119.435962] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 119.436946] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: COMMENT vm-test-run-timescaledb> server # [ 119.437628] postgres[1562]: ::1 2026-10-08 00:52:22.834 UTC [1562] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 119.438430] postgres[1562]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 119.439996] postgres[1562]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 119.441047] postgres[1562]: AS $func$ vm-test-run-timescaledb> server # [ 119.441960] postgres[1562]: DECLARE vm-test-run-timescaledb> server # [ 119.442430] postgres[1562]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 119.443060] postgres[1562]: BEGIN vm-test-run-timescaledb> server # [ 119.443517] postgres[1562]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 119.443922] postgres[1562]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 119.444189] postgres[1562]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 119.445716] postgres[1562]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 119.451906] postgres[1562]: ); vm-test-run-timescaledb> server # [ 119.456909] postgres[1562]: vm-test-run-timescaledb> server # [ 119.458173] postgres[1562]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 119.458959] postgres[1562]: THEN vm-test-run-timescaledb> server # [ 119.459394] postgres[1562]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 119.459705] postgres[1562]: "operationName" text default null, vm-test-run-timescaledb> server # [ 119.459967] postgres[1562]: query text default null, vm-test-run-timescaledb> server # [ 119.460202] postgres[1562]: variables jsonb default null, vm-test-run-timescaledb> server # [ 119.460457] postgres[1562]: extensions jsonb default null vm-test-run-timescaledb> server # [ 119.465938] postgres[1562]: ) vm-test-run-timescaledb> server # [ 119.467038] postgres[1562]: returns jsonb vm-test-run-timescaledb> server # [ 119.469151] postgres[1562]: language plpgsql vm-test-run-timescaledb> server # [ 119.469710] postgres[1562]: as $$ vm-test-run-timescaledb> server # [ 119.471211] postgres[1562]: DECLARE vm-test-run-timescaledb> server # [ 119.471754] postgres[1562]: server_version float; vm-test-run-timescaledb> server # [ 119.472331] postgres[1562]: BEGIN vm-test-run-timescaledb> server # [ 119.473764] postgres[1562]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 119.474881] postgres[1562]: vm-test-run-timescaledb> server # [ 119.475160] postgres[1562]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 119.475398] postgres[1562]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 119.475870] postgres[1562]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 119.477753] postgres[1562]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 119.478830] postgres[1562]: ); vm-test-run-timescaledb> server # [ 119.479209] postgres[1562]: ELSE vm-test-run-timescaledb> server # [ 119.480140] postgres[1562]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 119.482190] postgres[1562]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 119.482610] postgres[1562]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 119.483193] postgres[1562]: ); vm-test-run-timescaledb> server # [ 119.483519] postgres[1562]: END IF; vm-test-run-timescaledb> server # [ 119.484502] postgres[1562]: END; vm-test-run-timescaledb> server # [ 119.485506] postgres[1562]: $$; vm-test-run-timescaledb> server # [ 119.486310] postgres[1562]: END IF; vm-test-run-timescaledb> server # [ 119.486608] postgres[1562]: vm-test-run-timescaledb> server # [ 119.487231] postgres[1562]: END; vm-test-run-timescaledb> server # [ 119.487721] postgres[1562]: $func$; vm-test-run-timescaledb> server # [ 119.489344] postgres[1562]: ::1 2026-10-08 00:52:22.878 UTC [1562] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-timescaledb> server # [ 119.490585] postgres[1562]: ::1 2026-10-08 00:52:22.885 UTC [1562] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-timescaledb> server # [ 119.491586] postgres[1562]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-timescaledb> server # [ 119.493571] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 119.495046] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping vm-test-run-timescaledb> server # [ 119.501210] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 119.502032] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 119.503370] postgres[1562]: ::1 2026-10-08 00:52:22.897 UTC [1562] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql'; vm-test-run-timescaledb> server # [ 119.513132] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1561]: COMMENT vm-test-run-timescaledb> server # [ 119.555223] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-timescaledb> server # [ 119.835454] postgres[1567]: ::1 2026-10-08 00:52:23.223 UTC [1567] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 119.872216] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1563]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-timescaledb> server # [ 119.881057] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1563]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 119.881931] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1563]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-timescaledb> server # [ 119.884051] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1563]: DROP FUNCTION vm-test-run-timescaledb> server # [ 119.892273] postgres[1567]: ::1 2026-10-08 00:52:23.254 UTC [1567] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 119.895327] postgres[1567]: ::1 2026-10-08 00:52:23.276 UTC [1567] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 119.900288] postgres[1567]: DECLARE vm-test-run-timescaledb> server # [ 119.901428] postgres[1567]: cmd record; vm-test-run-timescaledb> server # [ 119.902146] postgres[1567]: BEGIN vm-test-run-timescaledb> server # [ 119.903586] postgres[1567]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 119.905148] postgres[1567]: LOOP vm-test-run-timescaledb> server # [ 119.906234] postgres[1567]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 119.906755] postgres[1567]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 119.908366] postgres[1567]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 119.909381] postgres[1567]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 119.910176] postgres[1567]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 119.912867] postgres[1567]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 119.913612] postgres[1567]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 119.914228] postgres[1567]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 119.915092] postgres[1567]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-timescaledb> server # [ 119.915765] postgres[1567]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 119.918180] postgres[1567]: , 'COMMENT' vm-test-run-timescaledb> server # [ 119.919308] postgres[1567]: ) vm-test-run-timescaledb> server # [ 119.919587] postgres[1567]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 119.920788] postgres[1567]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 119.921116] postgres[1567]: THEN vm-test-run-timescaledb> server # [ 119.921945] postgres[1567]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 119.922260] postgres[1567]: END IF; vm-test-run-timescaledb> server # [ 119.922501] postgres[1567]: END LOOP; vm-test-run-timescaledb> server # [ 119.922916] postgres[1567]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 119.966400] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1563]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 119.972100] postgres[1567]: ::1 2026-10-08 00:52:23.365 UTC [1567] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 119.977110] postgres[1567]: DECLARE vm-test-run-timescaledb> server # [ 119.979637] postgres[1567]: obj record; vm-test-run-timescaledb> server # [ 119.980071] postgres[1567]: BEGIN vm-test-run-timescaledb> server # [ 119.982587] postgres[1567]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 119.983454] postgres[1567]: LOOP vm-test-run-timescaledb> server # [ 119.983795] postgres[1567]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 119.985494] postgres[1567]: 'schema' vm-test-run-timescaledb> server # [ 119.986054] postgres[1567]: , 'table' vm-test-run-timescaledb> server # [ 119.986361] postgres[1567]: , 'foreign table' vm-test-run-timescaledb> server # [ 119.986621] postgres[1567]: , 'view' vm-test-run-timescaledb> server # [ 119.987058] postgres[1567]: , 'materialized view' vm-test-run-timescaledb> server # [ 119.987956] postgres[1567]: , 'function' vm-test-run-timescaledb> server # [ 119.988630] postgres[1567]: , 'trigger' vm-test-run-timescaledb> server # [ 119.989478] postgres[1567]: , 'type' vm-test-run-timescaledb> server # [ 119.989954] postgres[1567]: , 'rule' vm-test-run-timescaledb> server # [ 119.990875] postgres[1567]: ) vm-test-run-timescaledb> server # [ 119.991848] postgres[1567]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 119.992362] postgres[1567]: THEN vm-test-run-timescaledb> server # [ 119.993461] postgres[1567]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 119.994498] postgres[1567]: END IF; vm-test-run-timescaledb> server # [ 119.995479] postgres[1567]: END LOOP; vm-test-run-timescaledb> server # [ 119.996951] postgres[1567]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 120.015727] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1563]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 120.021307] postgres[1567]: ::1 2026-10-08 00:52:23.417 UTC [1567] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 120.032468] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1563]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 120.036925] postgres[1567]: ::1 2026-10-08 00:52:23.433 UTC [1567] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 120.038478] postgres[1567]: ON ddl_command_end vm-test-run-timescaledb> server # [ 120.039211] postgres[1567]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 120.044822] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1563]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 120.049381] postgres[1567]: ::1 2026-10-08 00:52:23.446 UTC [1567] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 120.060544] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1563]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 120.062171] postgres[1567]: ::1 2026-10-08 00:52:23.456 UTC [1567] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 120.063161] postgres[1567]: ON sql_drop vm-test-run-timescaledb> server # [ 120.063678] postgres[1567]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 120.074623] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1563]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 120.122219] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-timescaledb> server # [ 120.443537] postgres[1570]: ::1 2026-10-08 00:52:23.837 UTC [1570] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-timescaledb> server # [ 120.465039] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1569]: ALTER ROLE vm-test-run-timescaledb> server # [ 120.512851] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-timescaledb> server # [ 120.859196] postgres[1579]: ::1 2026-10-08 00:52:24.250 UTC [1579] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 120.861315] postgres[1579]: returns event_trigger vm-test-run-timescaledb> server # [ 120.862997] postgres[1579]: language plpgsql vm-test-run-timescaledb> server # [ 120.864044] postgres[1579]: AS $func$ vm-test-run-timescaledb> server # [ 120.875030] postgres[1579]: DECLARE vm-test-run-timescaledb> server # [ 120.880424] postgres[1579]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 120.881227] postgres[1579]: BEGIN vm-test-run-timescaledb> server # [ 120.881730] postgres[1579]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 120.882119] postgres[1579]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 120.883573] postgres[1579]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 120.884073] postgres[1579]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 120.893800] postgres[1579]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 120.895260] postgres[1579]: ); vm-test-run-timescaledb> server # [ 120.900065] postgres[1579]: vm-test-run-timescaledb> server # [ 120.907382] postgres[1579]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 120.915081] postgres[1579]: THEN vm-test-run-timescaledb> server # [ 120.915582] postgres[1579]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 120.915907] postgres[1579]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 120.921928] postgres[1579]: vm-test-run-timescaledb> server # [ 120.923822] postgres[1579]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 120.929836] postgres[1579]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 120.937385] postgres[1579]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 120.938513] postgres[1579]: vm-test-run-timescaledb> server # [ 120.939169] postgres[1579]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 120.939612] postgres[1579]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 120.940443] postgres[1579]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 120.942217] postgres[1579]: "operationName" text default null, vm-test-run-timescaledb> server # [ 120.943302] postgres[1579]: query text default null, vm-test-run-timescaledb> server # [ 120.948987] postgres[1579]: variables jsonb default null, vm-test-run-timescaledb> server # [ 120.954279] postgres[1579]: extensions jsonb default null vm-test-run-timescaledb> server # [ 120.960772] postgres[1579]: ) vm-test-run-timescaledb> server # [ 120.961740] postgres[1579]: returns jsonb vm-test-run-timescaledb> server # [ 120.962253] postgres[1579]: language sql vm-test-run-timescaledb> server # [ 120.962575] postgres[1579]: as $$ vm-test-run-timescaledb> server # [ 120.963611] postgres[1579]: -- This changed vm-test-run-timescaledb> server # [ 120.970540] postgres[1579]: select graphql.resolve( vm-test-run-timescaledb> server # [ 120.976967] postgres[1579]: query := query, vm-test-run-timescaledb> server # [ 120.978626] postgres[1579]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 120.985161] postgres[1579]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 120.986389] postgres[1579]: extensions := extensions vm-test-run-timescaledb> server # [ 120.987282] postgres[1579]: ); vm-test-run-timescaledb> server # [ 120.993043] postgres[1579]: $$; vm-test-run-timescaledb> server # [ 120.993531] postgres[1579]: vm-test-run-timescaledb> server # [ 120.993827] postgres[1579]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 120.994507] postgres[1579]: END IF; vm-test-run-timescaledb> server # [ 120.995133] postgres[1579]: vm-test-run-timescaledb> server # [ 120.995819] postgres[1579]: END; vm-test-run-timescaledb> server # [ 121.001307] postgres[1579]: $func$; vm-test-run-timescaledb> server # [ 121.006605] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1573]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 121.007787] postgres[1579]: ::1 2026-10-08 00:52:24.404 UTC [1579] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 121.015755] postgres[1579]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 121.020706] postgres[1579]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 121.021874] postgres[1579]: AS $func$ vm-test-run-timescaledb> server # [ 121.022192] postgres[1579]: DECLARE vm-test-run-timescaledb> server # [ 121.022466] postgres[1579]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 121.035474] postgres[1579]: BEGIN vm-test-run-timescaledb> server # [ 121.052797] postgres[1579]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 121.054459] postgres[1579]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 121.055132] postgres[1579]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 121.055943] postgres[1579]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 121.056794] postgres[1579]: ); vm-test-run-timescaledb> server # [ 121.057829] postgres[1579]: vm-test-run-timescaledb> server # [ 121.058327] postgres[1579]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 121.059119] postgres[1579]: THEN vm-test-run-timescaledb> server # [ 121.059884] postgres[1579]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 121.060919] postgres[1579]: "operationName" text default null, vm-test-run-timescaledb> server # [ 121.061314] postgres[1579]: query text default null, vm-test-run-timescaledb> server # [ 121.061604] postgres[1579]: variables jsonb default null, vm-test-run-timescaledb> server # [ 121.062081] postgres[1579]: extensions jsonb default null vm-test-run-timescaledb> server # [ 121.062447] postgres[1579]: ) vm-test-run-timescaledb> server # [ 121.062841] postgres[1579]: returns jsonb vm-test-run-timescaledb> server # [ 121.063153] postgres[1579]: language plpgsql vm-test-run-timescaledb> server # [ 121.063408] postgres[1579]: as $$ vm-test-run-timescaledb> server # [ 121.063638] postgres[1579]: DECLARE vm-test-run-timescaledb> server # [ 121.063856] postgres[1579]: server_version float; vm-test-run-timescaledb> server # [ 121.064091] postgres[1579]: BEGIN vm-test-run-timescaledb> server # [ 121.069082] postgres[1579]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 121.069801] postgres[1579]: vm-test-run-timescaledb> server # [ 121.070077] postgres[1579]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 121.070334] postgres[1579]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 121.071596] postgres[1579]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 121.073552] postgres[1579]: jsonb_build_object( vm-test-run-timescaledb> server # [ 121.074382] postgres[1579]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 121.075176] postgres[1579]: ) vm-test-run-timescaledb> server # [ 121.075765] postgres[1579]: ) vm-test-run-timescaledb> server # [ 121.081188] postgres[1579]: ); vm-test-run-timescaledb> server # [ 121.081868] postgres[1579]: ELSE vm-test-run-timescaledb> server # [ 121.082918] postgres[1579]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 121.084009] postgres[1579]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 121.085961] postgres[1579]: jsonb_build_object( vm-test-run-timescaledb> server # [ 121.086504] postgres[1579]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 121.087393] postgres[1579]: ) vm-test-run-timescaledb> server # [ 121.087773] postgres[1579]: ) vm-test-run-timescaledb> server # [ 121.088044] postgres[1579]: ); vm-test-run-timescaledb> server # [ 121.088898] postgres[1579]: END IF; vm-test-run-timescaledb> server # [ 121.090078] postgres[1579]: END; vm-test-run-timescaledb> server # [ 121.090936] postgres[1579]: $$; vm-test-run-timescaledb> server # [ 121.093339] postgres[1579]: END IF; vm-test-run-timescaledb> server # [ 121.094517] postgres[1579]: vm-test-run-timescaledb> server # [ 121.094951] postgres[1579]: END; vm-test-run-timescaledb> server # [ 121.095285] postgres[1579]: $func$; vm-test-run-timescaledb> server # [ 121.096021] postgres[1579]: ::1 2026-10-08 00:52:24.431 UTC [1579] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 121.101244] postgres[1579]: "operationName" text default null, vm-test-run-timescaledb> server # [ 121.102147] postgres[1579]: query text default null, vm-test-run-timescaledb> server # [ 121.102586] postgres[1579]: variables jsonb default null, vm-test-run-timescaledb> server # [ 121.103044] postgres[1579]: extensions jsonb default null vm-test-run-timescaledb> server # [ 121.103846] postgres[1579]: ) vm-test-run-timescaledb> server # [ 121.104194] postgres[1579]: returns jsonb vm-test-run-timescaledb> server # [ 121.106616] postgres[1579]: language plpgsql vm-test-run-timescaledb> server # [ 121.108904] postgres[1579]: as $$ vm-test-run-timescaledb> server # [ 121.109349] postgres[1579]: DECLARE vm-test-run-timescaledb> server # [ 121.109943] postgres[1579]: server_version float; vm-test-run-timescaledb> server # [ 121.110637] postgres[1579]: BEGIN vm-test-run-timescaledb> server # [ 121.112084] postgres[1579]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 121.115687] postgres[1579]: vm-test-run-timescaledb> server # [ 121.123025] postgres[1579]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 121.125091] postgres[1579]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 121.125934] postgres[1579]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 121.126482] postgres[1579]: jsonb_build_object( vm-test-run-timescaledb> server # [ 121.126910] postgres[1579]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 121.129698] postgres[1579]: ) vm-test-run-timescaledb> server # [ 121.131622] postgres[1579]: ) vm-test-run-timescaledb> server # [ 121.133785] postgres[1579]: ); vm-test-run-timescaledb> server # [ 121.134387] postgres[1579]: ELSE vm-test-run-timescaledb> server # [ 121.135814] postgres[1579]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 121.136110] postgres[1579]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 121.136997] postgres[1579]: jsonb_build_object( vm-test-run-timescaledb> server # [ 121.138040] postgres[1579]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 121.139577] postgres[1579]: ) vm-test-run-timescaledb> server # [ 121.140521] postgres[1579]: ) vm-test-run-timescaledb> server # [ 121.141585] postgres[1579]: ); vm-test-run-timescaledb> server # [ 121.143343] postgres[1579]: END IF; vm-test-run-timescaledb> server # [ 121.143820] postgres[1579]: END; vm-test-run-timescaledb> server # [ 121.150396] postgres[1579]: $$; vm-test-run-timescaledb> server # [ 121.151074] postgres[1579]: ::1 2026-10-08 00:52:24.477 UTC [1579] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 121.154001] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1573]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 121.156877] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1573]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 121.158810] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1573]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping vm-test-run-timescaledb> server # [ 121.161882] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1573]: DROP EXTENSION vm-test-run-timescaledb> server # [ 122.644888] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1573]: DO vm-test-run-timescaledb> server # [ 122.661826] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql vm-test-run-timescaledb> server # [ 122.902155] postgres[1598]: ::1 2026-10-08 00:52:26.297 UTC [1598] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-timescaledb> server # [ 122.928457] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1597]: GRANT ROLE vm-test-run-timescaledb> server # [ 122.960726] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-timescaledb> server # [ 123.286156] postgres[1602]: ::1 2026-10-08 00:52:26.675 UTC [1602] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 123.287998] postgres[1602]: returns event_trigger vm-test-run-timescaledb> server # [ 123.297901] postgres[1602]: language plpgsql vm-test-run-timescaledb> server # [ 123.299039] postgres[1602]: AS $func$ vm-test-run-timescaledb> server # [ 123.300433] postgres[1602]: DECLARE vm-test-run-timescaledb> server # [ 123.307097] postgres[1602]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 123.308831] postgres[1602]: BEGIN vm-test-run-timescaledb> server # [ 123.313494] postgres[1602]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 123.315243] postgres[1602]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 123.315701] postgres[1602]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 123.316008] postgres[1602]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 123.316309] postgres[1602]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 123.323324] postgres[1602]: ); vm-test-run-timescaledb> server # [ 123.324005] postgres[1602]: vm-test-run-timescaledb> server # [ 123.330324] postgres[1602]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 123.331696] postgres[1602]: THEN vm-test-run-timescaledb> server # [ 123.337451] postgres[1602]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 123.338983] postgres[1602]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 123.339850] postgres[1602]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 123.346226] postgres[1602]: "operationName" text default null, vm-test-run-timescaledb> server # [ 123.348042] postgres[1602]: query text default null, vm-test-run-timescaledb> server # [ 123.361770] postgres[1602]: variables jsonb default null, vm-test-run-timescaledb> server # [ 123.362885] postgres[1602]: extensions jsonb default null vm-test-run-timescaledb> server # [ 123.363410] postgres[1602]: ) vm-test-run-timescaledb> server # [ 123.363684] postgres[1602]: returns jsonb vm-test-run-timescaledb> server # [ 123.363926] postgres[1602]: language sql vm-test-run-timescaledb> server # [ 123.364351] postgres[1602]: as $$ vm-test-run-timescaledb> server # [ 123.372738] postgres[1602]: select graphql.resolve( vm-test-run-timescaledb> server # [ 123.374870] postgres[1602]: query := query, vm-test-run-timescaledb> server # [ 123.381368] postgres[1602]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 123.383874] postgres[1602]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 123.390006] postgres[1602]: extensions := extensions vm-test-run-timescaledb> server # [ 123.391605] postgres[1602]: ); vm-test-run-timescaledb> server # [ 123.403570] postgres[1602]: $$; vm-test-run-timescaledb> server # [ 123.405661] postgres[1602]: vm-test-run-timescaledb> server # [ 123.406829] postgres[1602]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 123.408623] postgres[1602]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 123.419083] postgres[1602]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 123.421206] postgres[1602]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.422269] postgres[1602]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.423230] postgres[1602]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.435755] postgres[1602]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.438343] postgres[1602]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.441005] postgres[1602]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.448950] postgres[1602]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.450417] postgres[1602]: END IF; vm-test-run-timescaledb> server # [ 123.450928] postgres[1602]: vm-test-run-timescaledb> server # [ 123.451635] postgres[1602]: END; vm-test-run-timescaledb> server # [ 123.453337] postgres[1602]: $func$; vm-test-run-timescaledb> server # [ 123.453691] postgres[1602]: ::1 2026-10-08 00:52:26.829 UTC [1602] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 123.474542] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1599]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 123.517280] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1599]: DROP EXTENSION vm-test-run-timescaledb> server # [ 125.382379] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1599]: DO vm-test-run-timescaledb> server # [ 125.427655] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-timescaledb> server # [ 126.330313] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1628]: DO vm-test-run-timescaledb> server # [ 126.896878] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1628]: DO vm-test-run-timescaledb> server # [ 126.942799] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-timescaledb> server # [ 127.391295] postgres[1642]: ::1 2026-10-08 00:52:30.785 UTC [1642] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 127.419806] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1634]: ALTER ROLE vm-test-run-timescaledb> server # [ 127.457094] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-timescaledb> server # [ 128.019227] postgres[1653]: ::1 2026-10-08 00:52:31.385 UTC [1653] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-timescaledb> server # [ 128.042534] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1647]: REVOKE ROLE vm-test-run-timescaledb> server # [ 128.092251] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-timescaledb> server # [ 130.382447] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1658]: DO vm-test-run-timescaledb> server # [ 130.433269] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 130.804010] postgres[1683]: ::1 2026-10-08 00:52:34.197 UTC [1683] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-timescaledb> server # [ 130.820983] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1677]: GRANT ROLE vm-test-run-timescaledb> server # [ 130.856859] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-timescaledb> server # [ 131.183655] postgres[1688]: ::1 2026-10-08 00:52:34.563 UTC [1688] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 131.251279] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1686]: GRANT vm-test-run-timescaledb> server # [ 131.253797] postgres[1688]: ::1 2026-10-08 00:52:34.634 UTC [1688] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 131.282464] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1686]: GRANT vm-test-run-timescaledb> server # [ 131.288925] postgres[1688]: ::1 2026-10-08 00:52:34.686 UTC [1688] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 131.297065] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1686]: GRANT vm-test-run-timescaledb> server # [ 131.302119] postgres[1688]: ::1 2026-10-08 00:52:34.698 UTC [1688] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 131.318575] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1686]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 131.324894] postgres[1688]: ::1 2026-10-08 00:52:34.721 UTC [1688] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option; vm-test-run-timescaledb> server # [ 131.345129] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1686]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 131.347304] postgres[1688]: ::1 2026-10-08 00:52:34.741 UTC [1688] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 131.355334] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1686]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 131.407398] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-timescaledb> server # [ 131.766582] postgres[1694]: ::1 2026-10-08 00:52:35.157 UTC [1694] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-timescaledb> server # [ 131.811109] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1693]: GRANT ROLE vm-test-run-timescaledb> server # [ 131.836128] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 132.097851] postgres[1696]: ::1 2026-10-08 00:52:35.490 UTC [1696] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-timescaledb> server # [ 132.111766] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1695]: GRANT ROLE vm-test-run-timescaledb> server # [ 132.148333] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-timescaledb> server # [ 132.393200] postgres[1698]: ::1 2026-10-08 00:52:35.785 UTC [1698] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-timescaledb> server # [ 132.403772] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1697]: ALTER ROLE vm-test-run-timescaledb> server # [ 132.416438] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1697]: ALTER ROLE vm-test-run-timescaledb> server # [ 132.424694] postgres[1698]: ::1 2026-10-08 00:52:35.805 UTC [1698] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-timescaledb> server # [ 132.426281] postgres[1698]: ::1 2026-10-08 00:52:35.814 UTC [1698] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-timescaledb> server # [ 132.427186] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1697]: ALTER ROLE vm-test-run-timescaledb> server # [ 132.457571] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1697]: DO vm-test-run-timescaledb> server # [ 132.480078] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 132.751073] postgres[1700]: ::1 2026-10-08 00:52:36.141 UTC [1700] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-timescaledb> server # [ 132.767666] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1699]: GRANT ROLE vm-test-run-timescaledb> server # [ 132.770109] postgres[1700]: ::1 2026-10-08 00:52:36.163 UTC [1700] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-timescaledb> server # [ 132.779019] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1699]: REVOKE ROLE vm-test-run-timescaledb> server # [ 132.842105] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-timescaledb> server # [ 133.370579] postgres[1706]: ::1 2026-10-08 00:52:36.755 UTC [1706] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 133.377185] postgres[1706]: returns event_trigger vm-test-run-timescaledb> server # [ 133.378295] postgres[1706]: language plpgsql vm-test-run-timescaledb> server # [ 133.379152] postgres[1706]: AS $func$ vm-test-run-timescaledb> server # [ 133.385092] postgres[1706]: DECLARE vm-test-run-timescaledb> server # [ 133.387658] postgres[1706]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 133.394426] postgres[1706]: BEGIN vm-test-run-timescaledb> server # [ 133.396158] postgres[1706]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 133.401405] postgres[1706]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 133.410665] postgres[1706]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 133.412102] postgres[1706]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 133.412534] postgres[1706]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 133.412795] postgres[1706]: ); vm-test-run-timescaledb> server # [ 133.413020] postgres[1706]: vm-test-run-timescaledb> server # [ 133.413255] postgres[1706]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 133.422272] postgres[1706]: THEN vm-test-run-timescaledb> server # [ 133.423142] postgres[1706]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 133.424029] postgres[1706]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 133.430821] postgres[1706]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 133.431851] postgres[1706]: "operationName" text default null, vm-test-run-timescaledb> server # [ 133.435832] postgres[1706]: query text default null, vm-test-run-timescaledb> server # [ 133.441523] postgres[1706]: variables jsonb default null, vm-test-run-timescaledb> server # [ 133.442222] postgres[1706]: extensions jsonb default null vm-test-run-timescaledb> server # [ 133.442842] postgres[1706]: ) vm-test-run-timescaledb> server # [ 133.443635] postgres[1706]: returns jsonb vm-test-run-timescaledb> server # [ 133.449743] postgres[1706]: language sql vm-test-run-timescaledb> server # [ 133.451152] postgres[1706]: as $$ vm-test-run-timescaledb> server # [ 133.451647] postgres[1706]: select graphql.resolve( vm-test-run-timescaledb> server # [ 133.452167] postgres[1706]: query := query, vm-test-run-timescaledb> server # [ 133.452437] postgres[1706]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 133.457962] postgres[1706]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 133.459299] postgres[1706]: extensions := extensions vm-test-run-timescaledb> server # [ 133.465638] postgres[1706]: ); vm-test-run-timescaledb> server # [ 133.467025] postgres[1706]: $$; vm-test-run-timescaledb> server # [ 133.474348] postgres[1706]: vm-test-run-timescaledb> server # [ 133.475874] postgres[1706]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 133.477070] postgres[1706]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 133.478885] postgres[1706]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 133.480123] postgres[1706]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.486962] postgres[1706]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.487735] postgres[1706]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.488254] postgres[1706]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.493921] postgres[1706]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.495112] postgres[1706]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.506220] postgres[1706]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.513038] postgres[1706]: vm-test-run-timescaledb> server # [ 133.514369] postgres[1706]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-timescaledb> server # [ 133.516394] postgres[1706]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-timescaledb> server # [ 133.522917] postgres[1706]: grant usage on schema graphql to postgres with grant option; vm-test-run-timescaledb> server # [ 133.523570] postgres[1706]: END IF; vm-test-run-timescaledb> server # [ 133.529722] postgres[1706]: vm-test-run-timescaledb> server # [ 133.531770] postgres[1706]: END; vm-test-run-timescaledb> server # [ 133.539656] postgres[1706]: $func$; vm-test-run-timescaledb> server # [ 133.661747] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1701]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 133.664250] postgres[1706]: ::1 2026-10-08 00:52:37.046 UTC [1706] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 133.752265] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1701]: DROP EXTENSION vm-test-run-timescaledb> server # [ 135.760774] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1701]: DO vm-test-run-timescaledb> server # [ 135.813476] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-timescaledb> server # [ 136.117871] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1731]: DO vm-test-run-timescaledb> server # [ 136.129699] postgres[1732]: ::1 2026-10-08 00:52:39.511 UTC [1732] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-timescaledb> server # [ 136.134221] postgres[1732]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 136.135938] postgres[1732]: AS $$ vm-test-run-timescaledb> server # [ 136.136874] postgres[1732]: BEGIN vm-test-run-timescaledb> server # [ 136.139191] postgres[1732]: IF EXISTS ( vm-test-run-timescaledb> server # [ 136.141662] postgres[1732]: SELECT vm-test-run-timescaledb> server # [ 136.143000] postgres[1732]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 136.143647] postgres[1732]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 136.145230] postgres[1732]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 136.146317] postgres[1732]: WHERE ext.extname = 'pg_cron' vm-test-run-timescaledb> server # [ 136.147502] postgres[1732]: ) vm-test-run-timescaledb> server # [ 136.149166] postgres[1732]: THEN vm-test-run-timescaledb> server # [ 136.149755] postgres[1732]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 136.150326] postgres[1732]: vm-test-run-timescaledb> server # [ 136.151364] postgres[1732]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 136.154147] postgres[1732]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 136.155084] postgres[1732]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 136.156903] postgres[1732]: vm-test-run-timescaledb> server # [ 136.158494] postgres[1732]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 136.159842] postgres[1732]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 136.162552] postgres[1732]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 136.163764] postgres[1732]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 136.165056] postgres[1732]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 136.167584] postgres[1732]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 136.170321] postgres[1732]: vm-test-run-timescaledb> server # [ 136.171340] postgres[1732]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 136.172948] postgres[1732]: revoke all on table cron.job from postgres; vm-test-run-timescaledb> server # [ 136.175228] postgres[1732]: grant select on table cron.job to postgres with grant option; vm-test-run-timescaledb> server # [ 136.175842] postgres[1732]: END IF; vm-test-run-timescaledb> server # [ 136.176765] postgres[1732]: END; vm-test-run-timescaledb> server # [ 136.178053] postgres[1732]: $$; vm-test-run-timescaledb> server # [ 136.209637] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1731]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 136.214522] postgres[1732]: ::1 2026-10-08 00:52:39.612 UTC [1732] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-timescaledb> server # [ 136.227501] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1731]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 136.233436] postgres[1732]: ::1 2026-10-08 00:52:39.627 UTC [1732] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-timescaledb> server # [ 136.241847] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1731]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 136.243934] postgres[1732]: ::1 2026-10-08 00:52:39.643 UTC [1732] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-timescaledb> server # [ 136.247430] postgres[1732]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-timescaledb> server # [ 136.250263] postgres[1732]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 136.257281] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1731]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 136.309347] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-timescaledb> server # [ 136.680495] postgres[1735]: ::1 2026-10-08 00:52:40.072 UTC [1735] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-timescaledb> server # [ 136.748925] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1733]: ALTER ROLE vm-test-run-timescaledb> server # [ 136.754130] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-timescaledb> server # [ 137.231828] postgres[1749]: ::1 2026-10-08 00:52:40.622 UTC [1749] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-timescaledb> server # [ 137.319279] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1741]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 137.331173] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1741]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 137.338343] postgres[1749]: ::1 2026-10-08 00:52:40.701 UTC [1749] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-timescaledb> server # [ 137.339837] postgres[1749]: ::1 2026-10-08 00:52:40.733 UTC [1749] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-timescaledb> server # [ 137.353963] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1741]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 137.435536] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 137.951114] postgres[1759]: ::1 2026-10-08 00:52:41.324 UTC [1759] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-timescaledb> server # [ 137.995976] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1754]: GRANT ROLE vm-test-run-timescaledb> server # [ 138.045627] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-timescaledb> server # [ 139.039617] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1763]: DO vm-test-run-timescaledb> server # [ 139.085840] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-timescaledb> server # [ 139.527074] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1768]: DO vm-test-run-timescaledb> server # [ 139.545756] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1768]: DO vm-test-run-timescaledb> server # [ 139.604859] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-timescaledb> server # [ 140.043214] postgres[1775]: ::1 2026-10-08 00:52:43.421 UTC [1775] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-timescaledb> server # [ 140.095217] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1771]: ALTER ROLE vm-test-run-timescaledb> server # [ 140.099093] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1771]: ALTER ROLE vm-test-run-timescaledb> server # [ 140.099883] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1771]: ALTER ROLE vm-test-run-timescaledb> server # [ 140.101418] postgres[1775]: ::1 2026-10-08 00:52:43.462 UTC [1775] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-timescaledb> server # [ 140.103247] postgres[1775]: ::1 2026-10-08 00:52:43.481 UTC [1775] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-timescaledb> server # [ 140.163947] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-timescaledb> server # [ 140.703432] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1781]: DO vm-test-run-timescaledb> server # [ 140.742129] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-timescaledb> server # [ 141.271501] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1793]: DO vm-test-run-timescaledb> server # [ 141.314825] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-timescaledb> server # [ 141.761694] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1801]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 141.768266] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1801]: DO vm-test-run-timescaledb> server # [ 141.805445] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-timescaledb> server # [ 142.139770] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1803]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 142.145130] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1803]: GRANT vm-test-run-timescaledb> server # [ 142.188117] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-timescaledb> server # [ 142.484092] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1805]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 142.507802] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1805]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 142.519246] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1805]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 142.578158] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 142.983907] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1807]: DO vm-test-run-timescaledb> server # [ 143.009936] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-timescaledb> server # [ 143.566292] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1812]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 143.593727] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1812]: GRANT vm-test-run-timescaledb> server # [ 143.633933] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-timescaledb> server # [ 144.103298] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1819]: REVOKE ROLE vm-test-run-timescaledb> server # [ 144.176846] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1819]: DO vm-test-run-timescaledb> server # [ 144.205346] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1819]: DO vm-test-run-timescaledb> server # [ 144.218326] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1819]: REVOKE ROLE vm-test-run-timescaledb> server # [ 144.245158] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1819]: REVOKE vm-test-run-timescaledb> server # [ 144.302455] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1819]: DO vm-test-run-timescaledb> server # [ 144.356916] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 144.894597] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1832]: DO vm-test-run-timescaledb> server # [ 144.962160] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 145.412588] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1842]: DO vm-test-run-timescaledb> server # [ 145.453921] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 145.775393] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1845]: DO vm-test-run-timescaledb> server # [ 145.816936] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-timescaledb> server # [ 146.119005] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1847]: ALTER ROLE vm-test-run-timescaledb> server # [ 146.150339] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-timescaledb> server # [ 146.435758] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1849]: GRANT ROLE vm-test-run-timescaledb> server # [ 146.446843] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1849]: DO vm-test-run-timescaledb> server # [ 146.491948] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-timescaledb> server # [ 146.923853] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 vm-test-run-timescaledb> server # [ 147.056399] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1851]: GRANT vm-test-run-timescaledb> server # [ 147.091609] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-timescaledb> server # [ 147.683473] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1866]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 147.694223] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1866]: REVOKE vm-test-run-timescaledb> server # [ 147.715077] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1866]: REVOKE vm-test-run-timescaledb> server # [ 147.724357] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1866]: GRANT vm-test-run-timescaledb> server # [ 147.781959] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-timescaledb> server # [ 148.210875] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1873]: DO vm-test-run-timescaledb> server # [ 148.232035] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-timescaledb> server # [ 148.712282] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1881]: ALTER ROLE vm-test-run-timescaledb> server # [ 148.728143] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-timescaledb> server # [ 149.394027] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1885]: DROP EXTENSION vm-test-run-timescaledb> server # [ 149.451148] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-timescaledb> server # [ 149.827144] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1891]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 149.839393] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1891]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 149.849077] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1891]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 149.885381] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-timescaledb> server # [ 150.138121] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1893]: DO vm-test-run-timescaledb> server # [ 150.160130] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1893]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 150.206962] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-timescaledb> server # [ 150.537758] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1895]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 150.546532] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1895]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 150.637706] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Running postgresql schema... vm-test-run-timescaledb> server # [ 151.147582] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER DATABASE vm-test-run-timescaledb> server # [ 151.161562] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER DATABASE vm-test-run-timescaledb> server # [ 151.297080] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.441931] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.581207] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.698311] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.777890] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.877487] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.961607] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.064991] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.177241] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.178256] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1899]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.242863] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1388]: Database initialization complete vm-test-run-timescaledb> server # [ 152.314294] systemd[1]: Finished Supabase Database Initialization. vm-test-run-timescaledb> server # [ 152.330125] systemd[1]: Reached target Multi-User System. vm-test-run-timescaledb> server # [ 152.342247] systemd[1]: Startup finished in 20.597s (kernel) + 2min 11.738s (userspace) = 2min 32.336s. vm-test-run-timescaledb> server: (finished: waiting for unit supabase-db-init.service, in 154.09 seconds) vm-test-run-timescaledb> subtest: Verify PostgreSQL 15 is our custom build vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT version();" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT version();", in 0.48 seconds) vm-test-run-timescaledb> server: must succeed: readlink -f $(which postgres) vm-test-run-timescaledb> server: (finished: must succeed: readlink -f $(which postgres), in 0.50 seconds) vm-test-run-timescaledb> (finished: subtest: Verify PostgreSQL 15 is our custom build, in 0.98 seconds) vm-test-run-timescaledb> subtest: Verify ansible config loaded vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW shared_preload_libraries;" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW shared_preload_libraries;", in 0.76 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW session_preload_libraries;" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW session_preload_libraries;", in 0.65 seconds) vm-test-run-timescaledb> (finished: subtest: Verify ansible config loaded, in 1.41 seconds) vm-test-run-timescaledb> subtest: Verify init scripts and migrations ran vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT rolname FROM pg_roles ORDER BY rolname;" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT rolname FROM pg_roles ORDER BY rolname;", in 0.62 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT schema_name FROM information_schema.schemata ORDER BY schema_name;" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT schema_name FROM information_schema.schemata ORDER BY schema_name;", in 0.54 seconds) vm-test-run-timescaledb> (finished: subtest: Verify init scripts and migrations ran, in 1.16 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 # [ 162.162430] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-timescaledb> server # [ 162.402796] systemd[1]: Starting Virtual Console Setup... vm-test-run-timescaledb> server # [ 162.742109] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 162.761473] systemd[1]: Stopped Virtual Console Setup. vm-test-run-timescaledb> server # [ 162.857832] systemd[1]: Starting Virtual Console Setup... 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 # [ 165.532107] postgres[1984]: [local] 2026-10-08 00:53:08.912 UTC [1984] supabase_admin@postgres WARNING: vm-test-run-timescaledb> server # [ 165.543044] postgres[1984]: WELCOME TO vm-test-run-timescaledb> server # [ 165.550832] postgres[1984]: _____ _ _ ____________ vm-test-run-timescaledb> server # [ 165.557659] postgres[1984]: |_ _(_) | | | _ \ ___ \ vm-test-run-timescaledb> server # [ 165.565780] postgres[1984]: | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ / vm-test-run-timescaledb> server # [ 165.567020] postgres[1984]: | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \ vm-test-run-timescaledb> server # [ 165.581574] postgres[1984]: | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ / vm-test-run-timescaledb> server # [ 165.587759] postgres[1984]: |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/ vm-test-run-timescaledb> server # [ 165.592115] postgres[1984]: Running version 2.9.1 vm-test-run-timescaledb> server # [ 165.609926] postgres[1984]: For more information on TimescaleDB, please visit the following links: vm-test-run-timescaledb> server # [ 165.618790] postgres[1984]: vm-test-run-timescaledb> server # [ 165.630645] postgres[1984]: 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started vm-test-run-timescaledb> server # [ 165.632104] postgres[1984]: 2. API reference documentation: https://docs.timescale.com/api/latest vm-test-run-timescaledb> server # [ 165.641470] postgres[1984]: 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts vm-test-run-timescaledb> server # [ 165.653923] postgres[1984]: vm-test-run-timescaledb> server # [ 165.655088] postgres[1984]: 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 # [ 165.663914] postgres[1984]: vm-test-run-timescaledb> server # [ 165.678839] postgres[1984]: [local] 2026-10-08 00:53:08.912 UTC [1984] 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 8.81 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 # [ 166.593805] postgres[2052]: 2026-10-08 00:53:09.949 UTC [2052] LOG: job 2 threw an error vm-test-run-timescaledb> server # [ 166.607923] postgres[2052]: 2026-10-08 00:53:10.002 UTC [2052] ERROR: functionality not supported under the current "apache" license vm-test-run-timescaledb> server # [ 166.615128] postgres[2052]: 2026-10-08 00:53:10.002 UTC [2052] HINT: Upgrade your license to 'timescale' to use this free community feature. vm-test-run-timescaledb> server # [ 166.786999] postgres[1347]: 2026-10-08 00:53:10.146 UTC [1347] LOG: background worker "Error Log Retention Policy [2]" (PID 2052) 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.27 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 # [ 168.173595] systemd[1]: Finished Virtual Console Setup. vm-test-run-timescaledb> server # [ 168.504257] postgres[2044]: 2026-10-08 00:53:11.872 UTC [2044] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 168.518372] postgres[1347]: 2026-10-08 00:53:11.902 UTC [1347] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2044) exited with exit code 1 vm-test-run-timescaledb> server # [ 169.939549] systemd-logind[655]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-timescaledb> server # [ 173.176955] postgres[2061]: 2026-10-08 00:53:16.562 UTC [2061] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 173.210720] postgres[1347]: 2026-10-08 00:53:16.591 UTC [1347] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2061) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "ALTER EXTENSION timescaledb UPDATE TO '2.16.1';" , in 6.34 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 # [ 173.721572] postgres[2076]: 2026-10-08 00:53:17.117 UTC [2076] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 173.726475] postgres[2076]: 2026-10-08 00:53:17.125 UTC [2076] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 173.735608] postgres[2076]: 2026-10-08 00:53:17.125 UTC [2076] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 173.763106] postgres[1347]: 2026-10-08 00:53:17.160 UTC [1347] LOG: background worker "Job History Log Retention Policy [3]" (PID 2076) 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.51 seconds) vm-test-run-timescaledb> (finished: subtest: Check upgrade path with postgresql 15, in 17.46 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 # [ 174.398203] postgres[2072]: 2026-10-08 00:53:17.783 UTC [2072] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 174.423887] postgres[1347]: 2026-10-08 00:53:17.813 UTC [1347] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2072) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" , in 0.94 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" , in 3.76 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" vm-test-run-timescaledb> server # [ 179.017367] postgres[2091]: 2026-10-08 00:53:22.409 UTC [2091] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 179.019643] postgres[2091]: 2026-10-08 00:53:22.419 UTC [2091] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 179.022155] postgres[2091]: 2026-10-08 00:53:22.419 UTC [2091] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 179.066989] postgres[1347]: 2026-10-08 00:53:22.460 UTC [1347] LOG: background worker "Job History Log Retention Policy [3]" (PID 2091) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.53 seconds) vm-test-run-timescaledb> (finished: subtest: Check the install of the last version of the extension, in 5.24 seconds) vm-test-run-timescaledb> (finished: run the VM test script, in 180.56 seconds) vm-test-run-timescaledb> test script finished in 180.95s vm-test-run-timescaledb> cleanup vm-test-run-timescaledb> kill machine (pid 9) vm-test-run-timescaledb> qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13) vm-test-run-timescaledb> vde_switch: EOF data port: Interrupted system call vm-test-run-timescaledb> kill vlan (pid 7) vm-test-run-timescaledb> (finished: cleanup, in 0.01 seconds) vm-test-run-timescaledb> vde_switch: Caught signal 15, cleaning up and exiting