these 2 derivations will be built: /nix/store/6ywp0zmhrd45dlhgjkw8lygnbxk81xig-nixos-test-driver-timescaledb.drv /nix/store/d65c7pvy2dg21qqil10r4d58ap6dnbc6-vm-test-run-timescaledb.drv building '/nix/store/6ywp0zmhrd45dlhgjkw8lygnbxk81xig-nixos-test-driver-timescaledb.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/6ywp0zmhrd45dlhgjkw8lygnbxk81xig-nixos-test-driver-timescaledb.drv' nixos-test-driver-timescaledb> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-timescaledb> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-timescaledb> Success: no issues found in 1 source file nixos-test-driver-timescaledb> additionally exposed symbols: nixos-test-driver-timescaledb> , nixos-test-driver-timescaledb> , nixos-test-driver-timescaledb> start_all, test_script, machines, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, Machine, t, debug nixos-test-driver-timescaledb> Linting test script (enable/disable: config.skipLint) nixos-test-driver-timescaledb> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint building '/nix/store/d65c7pvy2dg21qqil10r4d58ap6dnbc6-vm-test-run-timescaledb.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/d65c7pvy2dg21qqil10r4d58ap6dnbc6-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.QCSHRY5UPZ', 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: 535db1e3-9ed0-477b-962a-def202a0f1b5 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.13 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/wj8iglzrrwgfycay7axszhlik5a9rv2b-nixos-system-server-test/init regInfo=/nix/store/y6hb95p00w1j59hkhzmnq623i7z1ccys-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-timescaledb> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/y6hb95p00w1j59hkhzmnq623i7z1ccys-closure-info/registration", will be passed to user space. vm-test-run-timescaledb> server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-timescaledb> server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-timescaledb> server # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-timescaledb> server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 vm-test-run-timescaledb> server # [ 0.000000] Policy zone: Normal vm-test-run-timescaledb> server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-timescaledb> server # [ 0.000000] software IO TLB: area num 2. vm-test-run-timescaledb> server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) vm-test-run-timescaledb> server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm-test-run-timescaledb> server # [ 0.000000] allocated 8388608 bytes of page_ext vm-test-run-timescaledb> server # [ 0.000000] ftrace: allocating 72257 entries in 283 pages vm-test-run-timescaledb> server # [ 0.000000] ftrace: allocated 283 pages with 5 groups vm-test-run-timescaledb> server # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. vm-test-run-timescaledb> server # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-timescaledb> server # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-timescaledb> server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm-test-run-timescaledb> server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-timescaledb> server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-timescaledb> server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-timescaledb> server # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-timescaledb> server # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-timescaledb> server # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-timescaledb> server # [ 0.000000] GICv3: GICv3 features: 16 PPIs vm-test-run-timescaledb> server # [ 0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 vm-test-run-timescaledb> server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-timescaledb> server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-timescaledb> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100ae0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-timescaledb> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100af0000 (flat, esz 8, psz 64K, shr 1) vm-test-run-timescaledb> server # [ 0.000000] GICv3: using LPI property table @0x0000000100b00000 vm-test-run-timescaledb> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b10000 vm-test-run-timescaledb> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-timescaledb> server # [ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (virt). vm-test-run-timescaledb> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-timescaledb> server # [ 0.000034] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-timescaledb> server # [ 0.003240] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-timescaledb> server # [ 0.013682] Console: colour dummy device 80x25 vm-test-run-timescaledb> server # [ 0.015377] printk: legacy console [tty0] enabled vm-test-run-timescaledb> server # [ 0.021205] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-timescaledb> server # [ 0.021580] pid_max: default: 32768 minimum: 301 vm-test-run-timescaledb> server # [ 0.024242] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-timescaledb> server # [ 0.026386] landlock: Up and running. vm-test-run-timescaledb> server # [ 0.026443] Yama: becoming mindful. vm-test-run-timescaledb> server # [ 0.029448] LSM support for eBPF active vm-test-run-timescaledb> server # [ 0.032963] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.033121] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.063152] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-timescaledb> server # [ 0.074223] rcu: Hierarchical SRCU implementation. vm-test-run-timescaledb> server # [ 0.074311] rcu: Max phase no-delay instances is 1000. vm-test-run-timescaledb> server # [ 0.076715] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-timescaledb> server # [ 0.084467] fsl-mc MSI: its@8080000 domain created vm-test-run-timescaledb> server # [ 0.086601] EFI services will not be available. vm-test-run-timescaledb> server # [ 0.088500] smp: Bringing up secondary CPUs ... vm-test-run-timescaledb> server # [ 0.093060] Detected PIPT I-cache on CPU1 vm-test-run-timescaledb> server # [ 0.094311] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-timescaledb> server # [ 0.095121] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000 vm-test-run-timescaledb> server # [ 0.096838] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-timescaledb> server # [ 0.100777] smp: Brought up 1 node, 2 CPUs vm-test-run-timescaledb> server # [ 0.100933] SMP: Total of 2 processors activated. vm-test-run-timescaledb> server # [ 0.100978] CPU: All CPU(s) started at EL1 vm-test-run-timescaledb> server # [ 0.101150] CPU features: detected: Branch Target Identification vm-test-run-timescaledb> server # [ 0.101209] CPU features: detected: 32-bit EL0 Support vm-test-run-timescaledb> server # [ 0.101244] CPU features: detected: 32-bit EL1 Support vm-test-run-timescaledb> server # [ 0.101271] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-timescaledb> server # [ 0.101302] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-timescaledb> server # [ 0.101342] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-timescaledb> server # [ 0.101414] CPU features: detected: Common not Private translations vm-test-run-timescaledb> server # [ 0.101439] CPU features: detected: CRC32 instructions vm-test-run-timescaledb> server # [ 0.101460] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-timescaledb> server # [ 0.101493] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-timescaledb> server # [ 0.101517] CPU features: detected: Data independent timing control (DIT) vm-test-run-timescaledb> server # [ 0.101544] CPU features: detected: E0PD vm-test-run-timescaledb> server # [ 0.101567] CPU features: detected: Enhanced Counter Virtualization vm-test-run-timescaledb> server # [ 0.101595] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-timescaledb> server # [ 0.101623] CPU features: detected: Enhanced Privileged Access Never vm-test-run-timescaledb> server # [ 0.101647] CPU features: detected: Enhanced Virtualization Traps vm-test-run-timescaledb> server # [ 0.101674] CPU features: detected: Fine Grained Traps vm-test-run-timescaledb> server # [ 0.101733] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.101822] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-timescaledb> server # [ 0.101880] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-timescaledb> server # [ 0.101908] CPU features: detected: LSE atomic instructions vm-test-run-timescaledb> server # [ 0.101935] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-timescaledb> server # [ 0.101965] CPU features: detected: Privileged Access Never vm-test-run-timescaledb> server # [ 0.101987] CPU features: detected: RAS Extension Support vm-test-run-timescaledb> server # [ 0.102008] CPU features: detected: Random Number Generator vm-test-run-timescaledb> server # [ 0.102030] CPU features: detected: Speculation barrier (SB) vm-test-run-timescaledb> server # [ 0.102051] CPU features: detected: Stage-2 Force Write-Back vm-test-run-timescaledb> server # [ 0.102077] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-timescaledb> server # [ 0.102109] CPU features: detected: TLB range maintenance instructions vm-test-run-timescaledb> server # [ 0.102134] CPU features: detected: WFx with timeout vm-test-run-timescaledb> server # [ 0.102175] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-timescaledb> server # [ 0.102204] CPU features: detected: Scalable Vector Extension vm-test-run-timescaledb> server # [ 0.108864] alternatives: applying system-wide alternatives vm-test-run-timescaledb> server # [ 0.126980] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-timescaledb> server # [ 0.127684] SVE: maximum available vector length 256 bytes per vector vm-test-run-timescaledb> server # [ 0.127772] SVE: default vector length 64 bytes per vector vm-test-run-timescaledb> server # [ 0.142985] 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.166590] devtmpfs: initialized vm-test-run-timescaledb> server # [ 0.197460] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-timescaledb> server # [ 0.198126] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.201214] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-timescaledb> server # [ 0.201285] 0 pages in range for non-PLT usage vm-test-run-timescaledb> server # [ 0.201331] 509248 pages in range for PLT usage vm-test-run-timescaledb> server # [ 0.204308] pinctrl core: initialized pinctrl subsystem vm-test-run-timescaledb> server # [ 0.215620] DMI not present or invalid. vm-test-run-timescaledb> server # [ 0.236757] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-timescaledb> server # [ 0.248834] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-timescaledb> server # [ 0.250170] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-timescaledb> server # [ 0.251522] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-timescaledb> server # [ 0.251787] audit: initializing netlink subsys (disabled) vm-test-run-timescaledb> server # [ 0.253953] audit: type=2000 audit(0.192:1): state=initialized audit_enabled=0 res=1 vm-test-run-timescaledb> server # [ 0.260653] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-timescaledb> server # [ 0.260708] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-timescaledb> server # [ 0.260764] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-timescaledb> server # [ 0.260791] thermal_sys: Registered thermal governor 'user_space' vm-test-run-timescaledb> server # [ 0.260816] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-timescaledb> server # [ 0.261541] cpuidle: using governor ladder vm-test-run-timescaledb> server # [ 0.262065] cpuidle: using governor menu vm-test-run-timescaledb> server # [ 0.264163] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-timescaledb> server # [ 0.265346] ASID allocator initialised with 65536 entries vm-test-run-timescaledb> server # [ 0.272965] Serial: AMBA PL011 UART driver vm-test-run-timescaledb> server # [ 0.323660] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-timescaledb> server # [ 0.324930] printk: legacy console [ttyAMA0] enabled vm-test-run-timescaledb> server # [ 0.363222] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.363461] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-timescaledb> server # [ 0.363578] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.363725] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-timescaledb> server # [ 0.363841] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.363939] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-timescaledb> server # [ 0.364038] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.364136] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-timescaledb> server # [ 0.375879] fbcon: Taking over console vm-test-run-timescaledb> server # [ 0.376559] ACPI: Interpreter disabled. vm-test-run-timescaledb> server # [ 0.383633] iommu: Default domain type: Translated vm-test-run-timescaledb> server # [ 0.383798] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-timescaledb> server # [ 0.390917] SCSI subsystem initialized vm-test-run-timescaledb> server # [ 0.393053] usbcore: registered new interface driver usbfs vm-test-run-timescaledb> server # [ 0.393495] usbcore: registered new interface driver hub vm-test-run-timescaledb> server # [ 0.394344] usbcore: registered new device driver usb vm-test-run-timescaledb> server # [ 0.396725] pps_core: LinuxPPS API ver. 1 registered vm-test-run-timescaledb> server # [ 0.397056] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-timescaledb> server # [ 0.397393] PTP clock support registered vm-test-run-timescaledb> server # [ 0.397879] EDAC MC: Ver: 3.0.0 vm-test-run-timescaledb> server # [ 0.399962] scmi_core: SCMI protocol bus registered vm-test-run-timescaledb> server # [ 0.403378] FPGA manager framework vm-test-run-timescaledb> server # [ 0.404495] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-timescaledb> server # [ 0.412639] vgaarb: loaded vm-test-run-timescaledb> server # [ 0.421299] clocksource: Switched to clocksource arch_sys_counter vm-test-run-timescaledb> server # [ 0.424362] VFS: Disk quotas dquot_6.6.0 vm-test-run-timescaledb> server # [ 0.424579] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-timescaledb> server # [ 0.427272] netfs: FS-Cache loaded vm-test-run-timescaledb> server # [ 0.429116] pnp: PnP ACPI: disabled vm-test-run-timescaledb> server # [ 0.460529] NET: Registered PF_INET protocol family vm-test-run-timescaledb> server # [ 0.462426] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-timescaledb> server # [ 0.581832] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.582190] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.582495] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.583418] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-timescaledb> server # [ 0.584108] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-timescaledb> server # [ 0.585763] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-timescaledb> server # [ 0.586305] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.586644] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.588166] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-timescaledb> server # [ 0.588613] NET: Registered PF_XDP protocol family vm-test-run-timescaledb> server # [ 0.588985] PCI: CLS 0 bytes, default 64 vm-test-run-timescaledb> server # [ 0.591986] kvm [1]: HYP mode not available vm-test-run-timescaledb> server # [ 0.593561] Trying to unpack rootfs image as initramfs... vm-test-run-timescaledb> server # [ 0.705990] Initialise system trusted keyrings vm-test-run-timescaledb> server # [ 0.707647] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-timescaledb> server # [ 0.711599] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-timescaledb> server # [ 0.712280] 9p: Installing v9fs 9p2000 file system support vm-test-run-timescaledb> server # [ 0.788921] Key type asymmetric registered vm-test-run-timescaledb> server # [ 0.789191] Asymmetric key parser 'x509' registered vm-test-run-timescaledb> server # [ 0.789622] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-timescaledb> server # [ 0.793221] io scheduler mq-deadline registered vm-test-run-timescaledb> server # [ 0.793864] io scheduler kyber registered vm-test-run-timescaledb> server # [ 0.825899] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-timescaledb> server # [ 0.831160] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-timescaledb> server # [ 0.835519] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-timescaledb> server # [ 0.836272] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-timescaledb> server # [ 0.836848] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-timescaledb> server # [ 0.837093] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-timescaledb> server # [ 0.837921] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-timescaledb> server # [ 0.839375] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-timescaledb> server # [ 0.841558] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-timescaledb> server # [ 0.842009] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-timescaledb> server # [ 0.842188] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.842324] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.842444] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.844635] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.848311] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.848687] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.848834] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.848982] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.849137] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.850487] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.850839] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.850950] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.851108] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.851631] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.852026] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.852294] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.852478] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.852964] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.853116] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.853215] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.853953] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.854465] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.854615] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.854935] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.855071] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.855707] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.855982] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-timescaledb> server # [ 0.856076] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.856196] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.856632] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.856772] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.856869] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.856978] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.857084] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.857548] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.857962] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.858079] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.858576] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.859061] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.859324] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.859937] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.860535] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.861050] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.861263] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.862577] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.863013] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.863548] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.863701] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.863799] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.863919] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.865687] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.866624] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.866906] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.867138] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.867308] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.867454] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.867594] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.867728] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.867856] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.867989] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.868120] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.868251] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.868408] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.868537] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-timescaledb> server # [ 0.868652] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-timescaledb> server # [ 0.868762] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-timescaledb> server # [ 0.868870] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-timescaledb> server # [ 0.868980] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-timescaledb> server # [ 0.869085] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-timescaledb> server # [ 0.869192] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-timescaledb> server # [ 0.869299] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-timescaledb> server # [ 0.869514] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-timescaledb> server # [ 0.870291] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-timescaledb> server # [ 0.870418] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-timescaledb> server # [ 0.870528] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-timescaledb> server # [ 0.870647] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-timescaledb> server # [ 0.871102] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-timescaledb> server # [ 0.871294] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-timescaledb> server # [ 0.871405] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-timescaledb> server # [ 0.871881] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-timescaledb> server # [ 0.872209] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-timescaledb> server # [ 0.872429] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-timescaledb> server # [ 0.872612] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-timescaledb> server # [ 0.872877] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-timescaledb> server # [ 0.873209] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.873792] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.874102] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.875626] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.939557] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.944150] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.947810] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.950620] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.954816] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.956532] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.959274] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.962118] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.964222] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.967806] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.971528] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.992030] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-timescaledb> server # [ 1.002199] msm_serial: driver initialized vm-test-run-timescaledb> server # [ 1.003160] SuperH (H)SCI(F) driver initialized vm-test-run-timescaledb> server # [ 1.003948] STM32 USART driver initialized vm-test-run-timescaledb> server # [ 1.054013] loop: module loaded vm-test-run-timescaledb> server # [ 1.055340] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-timescaledb> server # [ 1.060616] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-timescaledb> server # [ 1.073941] megasas: 07.727.03.00-rc1 vm-test-run-timescaledb> server # [ 1.079955] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-timescaledb> server # [ 1.083066] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 1.083707] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 1.085913] Using buffer write method vm-test-run-timescaledb> server # [ 1.087048] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-timescaledb> server # [ 1.088265] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 1.088559] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 1.089905] Using buffer write method vm-test-run-timescaledb> server # [ 1.090363] Concatenating MTD devices: vm-test-run-timescaledb> server # [ 1.090530] (0): "0.flash" vm-test-run-timescaledb> server # [ 1.090596] (1): "0.flash" vm-test-run-timescaledb> server # [ 1.090658] into device "0.flash" vm-test-run-timescaledb> server # [ 1.109789] Freeing initrd memory: 10684K vm-test-run-timescaledb> server # [ 1.132831] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-timescaledb> server # [ 1.146467] thunder_xcv, ver 1.0 vm-test-run-timescaledb> server # [ 1.146968] thunder_bgx, ver 1.0 vm-test-run-timescaledb> server # [ 1.147179] nicpf, ver 1.0 vm-test-run-timescaledb> server # [ 1.150140] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-timescaledb> server # [ 1.150334] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-timescaledb> server # [ 1.150768] hclge is initializing vm-test-run-timescaledb> server # [ 1.151208] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.151401] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-timescaledb> server # [ 1.151642] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.151742] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-timescaledb> server # [ 1.152136] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-timescaledb> server # [ 1.152691] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-timescaledb> server # [ 1.152930] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-timescaledb> server # [ 1.153035] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-timescaledb> server # [ 1.154154] sky2: driver version 1.30 vm-test-run-timescaledb> server # [ 1.164001] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-timescaledb> server # [ 1.164553] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-timescaledb> server # [ 1.164840] usbcore: registered new interface driver usb-storage vm-test-run-timescaledb> server # [ 1.166921] usbcore: registered new interface driver usbserial_generic vm-test-run-timescaledb> server # [ 1.167293] usbserial: USB Serial support registered for generic vm-test-run-timescaledb> server # [ 1.168206] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-timescaledb> server # [ 1.177913] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-timescaledb> server # [ 1.178420] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-timescaledb> server # [ 1.179312] rtc-pl031 9010000.pl031: setting system clock to 2026-10-10T11:23:50 UTC (1791631430) vm-test-run-timescaledb> server # [ 1.181950] i2c_dev: i2c /dev entries driver vm-test-run-timescaledb> server # [ 1.187341] hub 1-0:1.0: USB hub found vm-test-run-timescaledb> server # [ 1.187977] hub 1-0:1.0: 6 ports detected vm-test-run-timescaledb> server # [ 1.196804] sdhci: Secure Digital Host Controller Interface driver vm-test-run-timescaledb> server # [ 1.196967] sdhci: Copyright(c) Pierre Ossman vm-test-run-timescaledb> server # [ 1.198275] Synopsys Designware Multimedia Card Interface Driver vm-test-run-timescaledb> server # [ 1.200993] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-timescaledb> server # [ 1.208193] hid: raw HID events driver (C) Jiri Kosina vm-test-run-timescaledb> server # [ 1.210670] usbcore: registered new interface driver usbhid vm-test-run-timescaledb> server # [ 1.210857] usbhid: USB HID core driver vm-test-run-timescaledb> server # [ 1.220042] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-timescaledb> server # [ 1.235430] drop_monitor: Initializing network drop monitor service vm-test-run-timescaledb> server # [ 1.236737] NET: Registered PF_INET6 protocol family vm-test-run-timescaledb> server # [ 1.259910] Segment Routing with IPv6 vm-test-run-timescaledb> server # [ 1.260404] In-situ OAM (IOAM) with IPv6 vm-test-run-timescaledb> server # [ 1.261162] NET: Registered PF_PACKET protocol family vm-test-run-timescaledb> server # [ 1.263481] 9pnet: Installing 9P2000 support vm-test-run-timescaledb> server # [ 1.268189] Key type dns_resolver registered vm-test-run-timescaledb> server # [ 1.307145] registered taskstats version 1 vm-test-run-timescaledb> server # [ 1.309805] Loading compiled-in X.509 certificates vm-test-run-timescaledb> server # [ 1.372088] Demotion targets for Node 0: null vm-test-run-timescaledb> server # [ 1.374519] Key type .fscrypt registered vm-test-run-timescaledb> server # [ 1.374661] Key type fscrypt-provisioning registered vm-test-run-timescaledb> server # [ 1.384869] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-timescaledb> server # [ 1.432489] clk: Disabling unused clocks vm-test-run-timescaledb> server # [ 1.432816] PM: genpd: Disabling unused power domains vm-test-run-timescaledb> server # [ 1.433270] ALSA device list: vm-test-run-timescaledb> server # [ 1.433555] No soundcards found. vm-test-run-timescaledb> server # [ 1.443545] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-timescaledb> server # [ 1.524616] Freeing unused kernel memory: 4416K vm-test-run-timescaledb> server # [ 1.527201] Run /init as init process vm-test-run-timescaledb> server # [ 1.637403] 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.763493] 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.889885] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-timescaledb> server # [ 2.076747] 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.085714] 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.173542] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-timescaledb> server # [ 2.306388] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-timescaledb> server # [ 2.307133] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-timescaledb> server # [ 2.307159] [drm] features: -context_init vm-test-run-timescaledb> server # [ 2.309761] [drm] number of scanouts: 1 vm-test-run-timescaledb> server # [ 2.309906] [drm] number of cap sets: 0 vm-test-run-timescaledb> server # [ 2.321620] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-timescaledb> server # [ 2.357155] Console: switching to colour frame buffer device 160x50 vm-test-run-timescaledb> server # [ 2.369896] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-timescaledb> server # [ 5.469663] EXT4-fs (vda): mounted filesystem 535db1e3-9ed0-477b-962a-def202a0f1b5 r/w with ordered data mode. Quota mode: none. vm-test-run-timescaledb> server # [ 8.206104] EXT4-fs (vda): re-mounted 535db1e3-9ed0-477b-962a-def202a0f1b5. vm-test-run-timescaledb> server # [ 8.228472] booting system configuration /nix/store/wj8iglzrrwgfycay7axszhlik5a9rv2b-nixos-system-server-test vm-test-run-timescaledb> server # [ 21.631450] 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.642302] systemd[1]: Detected virtualization qemu. vm-test-run-timescaledb> server # [ 21.648354] systemd[1]: Detected architecture arm64. vm-test-run-timescaledb> server # [ 21.653870] systemd[1]: Detected first boot. vm-test-run-timescaledb> server # [ 21.685505] systemd[1]: Initializing machine ID from random generator. vm-test-run-timescaledb> server # [ 21.721746] systemd[1]: Hostname set to . vm-test-run-timescaledb> server # [ 23.003192] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-timescaledb> server # [ 24.548554] systemd[1]: Applying preset policy. vm-test-run-timescaledb> server # [ 28.734480] systemd[1]: Populated /etc with preset unit settings. vm-test-run-timescaledb> server: Guest root shell did not produce any data yet... vm-test-run-timescaledb> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-timescaledb> server # [ 32.427414] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-timescaledb> server # [ 32.650109] systemd[1]: Created slice Slice /system/getty. vm-test-run-timescaledb> server # [ 32.666139] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-timescaledb> server # [ 32.680362] systemd[1]: Created slice User and Session Slice. vm-test-run-timescaledb> server # [ 32.690487] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-timescaledb> server # [ 32.696308] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-timescaledb> server # [ 32.701242] systemd[1]: Expecting device /dev/hvc0... vm-test-run-timescaledb> server # [ 32.706949] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-timescaledb> server # [ 32.711506] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-timescaledb> server # [ 32.715928] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-timescaledb> server # [ 32.720363] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-timescaledb> server # [ 32.725128] systemd[1]: Reached target Path Units. vm-test-run-timescaledb> server # [ 32.730163] systemd[1]: Reached target Remote File Systems. vm-test-run-timescaledb> server # [ 32.735064] systemd[1]: Reached target Slice Units. vm-test-run-timescaledb> server # [ 32.739248] systemd[1]: Reached target Swaps. vm-test-run-timescaledb> server # [ 32.776557] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-timescaledb> server # [ 32.800505] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-timescaledb> server # [ 32.811382] systemd[1]: Listening on Journal Audit Socket. vm-test-run-timescaledb> server # [ 32.818183] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-timescaledb> server # [ 32.823753] systemd[1]: Listening on Journal Sockets. vm-test-run-timescaledb> server # [ 32.831515] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-timescaledb> server # [ 32.836517] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 32.843378] systemd[1]: Listening on udev Control Socket. vm-test-run-timescaledb> server # [ 32.848534] systemd[1]: Listening on udev Kernel Socket. vm-test-run-timescaledb> server # [ 32.892030] systemd[1]: Mounting Huge Pages File System... vm-test-run-timescaledb> server # [ 32.931195] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-timescaledb> server # [ 32.976046] systemd[1]: Mounting Kernel Debug File System... vm-test-run-timescaledb> server # [ 33.032654] systemd[1]: Mounting Kernel Trace File System... vm-test-run-timescaledb> server # [ 33.147961] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-timescaledb> server # [ 33.284021] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-timescaledb> server # [ 33.301942] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-timescaledb> server # [ 33.459000] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-timescaledb> server # [ 33.465244] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-timescaledb> server # [ 33.477920] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-timescaledb> server # [ 33.612860] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-timescaledb> server # [ 33.625122] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-timescaledb> server # [ 33.634971] systemd[1]: Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). vm-test-run-timescaledb> server # [ 33.735178] systemd[1]: Starting Journal Service... vm-test-run-timescaledb> server # [ 33.816281] systemd[1]: Starting Load Kernel Modules... vm-test-run-timescaledb> server # [ 33.891475] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-timescaledb> server # [ 33.957896] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-timescaledb> server # [ 33.967119] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 34.043161] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-timescaledb> server # [ 34.123175] systemd[1]: Mounted Huge Pages File System. vm-test-run-timescaledb> server # [ 34.132628] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-timescaledb> server # [ 34.146029] systemd[1]: Mounted Kernel Debug File System. vm-test-run-timescaledb> server # [ 34.153827] systemd[1]: Mounted Kernel Trace File System. vm-test-run-timescaledb> server # [ 34.183193] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-timescaledb> server # [ 34.208052] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-timescaledb> server # [ 34.285923] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-timescaledb> server # [ 34.596523] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 34.620093] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-timescaledb> server # [ 35.164935] systemd[1]: Finished Load Kernel Modules. vm-test-run-timescaledb> server # [ 35.232293] systemd[1]: Starting Firewall... vm-test-run-timescaledb> server # [ 35.294523] systemd[1]: Starting Apply Kernel Variables... vm-test-run-timescaledb> server # [ 35.347078] fuse: init (API version 7.41) vm-test-run-timescaledb> server # [ 35.432423] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 35.458810] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-timescaledb> server # [ 35.467028] EXT4-fs (vda): re-mounted 535db1e3-9ed0-477b-962a-def202a0f1b5. vm-test-run-timescaledb> server # [ 35.512013] systemd[1]: Mounting FUSE Control File System... vm-test-run-timescaledb> server # [ 35.647727] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-timescaledb> server # [ 35.669266] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-timescaledb> server # [ 35.780705] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-timescaledb> server # [ 35.790904] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 35.829451] systemd[1]: Mounted FUSE Control File System. vm-test-run-timescaledb> server # [ 35.909206] systemd-journald[398]: Collecting audit messages is enabled. vm-test-run-timescaledb> server # [ 36.831737] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-timescaledb> server # [ 36.848652] systemd[1]: Reached target First Boot Complete. vm-test-run-timescaledb> server # [ 36.984566] systemd[1]: Finished Apply Kernel Variables. vm-test-run-timescaledb> server # [ 37.097319] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-timescaledb> server # [ 37.156451] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-timescaledb> server # [ 37.251716] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-timescaledb> server # [ 38.328664] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-timescaledb> server # [ 38.362796] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-timescaledb> server # [ 38.411467] systemd[1]: Mounting /run/wrappers... vm-test-run-timescaledb> server # [ 38.459928] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-timescaledb> server # [ 38.732526] systemd[1]: Started Journal Service. vm-test-run-timescaledb> server # [ 38.664162] systemd-modules-load[399]: Module 'atkbd' is built in vm-test-run-timescaledb> server # [ 38.695272] systemd-modules-load[399]: Module 'loop' is built in vm-test-run-timescaledb> server # [ 38.728285] systemd-oomd[400]: No swap; memory pressure usage will be degraded vm-test-run-timescaledb> server # [ 38.815139] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-timescaledb> server # [ 38.839130] systemd[1]: Mounted /run/wrappers. vm-test-run-timescaledb> server # [ 38.859045] systemd[1]: Reached target Local File Systems. vm-test-run-timescaledb> server # [ 38.891510] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-timescaledb> server # [ 38.903645] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-timescaledb> server # [ 38.947547] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-timescaledb> server # [ 38.978043] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-timescaledb> server # [ 39.890371] systemd-journald[398]: Received client request to flush runtime journal. vm-test-run-timescaledb> server # [ 40.526081] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-timescaledb> server # [ 40.550213] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-timescaledb> server # [ 40.582497] systemd-udevd[428]: Using default interface naming scheme 'v258'. vm-test-run-timescaledb> server # [ 40.590369] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-timescaledb> server # [ 40.623523] systemd[1]: Starting Create System Files and Directories... vm-test-run-timescaledb> server # [ 42.762821] systemd[1]: Finished Create System Files and Directories. vm-test-run-timescaledb> server # [ 42.831111] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-timescaledb> server # [ 42.876775] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-timescaledb> server # [ 43.277315] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-timescaledb> server # [ 44.036704] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-timescaledb> server # [ 45.169501] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-timescaledb> server # [ 45.201879] systemd[1]: Starting Update is Completed... vm-test-run-timescaledb> server # [ 45.973373] systemd[1]: Finished Update is Completed. vm-test-run-timescaledb> server # [ 50.055559] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 50.075737] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-timescaledb> server # [ 50.078627] systemd[1]: suid-sgid-wrappers.service: Consumed 3.083s CPU time, 5.6M memory peak. vm-test-run-timescaledb> server # [ 52.459020] systemd[1]: Finished Firewall. vm-test-run-timescaledb> server # [ 54.122694] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-timescaledb> server # [ 54.134233] systemd[1]: Reached target System Initialization. vm-test-run-timescaledb> server # [ 54.143962] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-timescaledb> server # [ 54.159020] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-timescaledb> server # [ 54.161437] systemd[1]: Reached target Timer Units. vm-test-run-timescaledb> server # [ 54.164451] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-timescaledb> server # [ 54.167411] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-timescaledb> server # [ 54.169510] systemd[1]: Listening on Hostname Service Socket. vm-test-run-timescaledb> server # [ 54.170780] systemd[1]: Reached target Socket Units. vm-test-run-timescaledb> server # [ 54.171890] systemd[1]: Reached target Basic System. vm-test-run-timescaledb> server # [ 54.202125] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-timescaledb> server # [ 54.241856] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 54.287650] systemd[1]: Started Reset console on configuration changes. vm-test-run-timescaledb> server # [ 54.352900] systemd[1]: Starting resolvconf update... vm-test-run-timescaledb> server # [ 54.461957] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-timescaledb> server # [ 55.534893] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-timescaledb> server # [ 55.779452] nsncd[627]: Oct 10 11:24:45.108 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 55.788088] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 55.793756] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 55.797262] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 55.871266] systemd[1]: Starting User Login Management... vm-test-run-timescaledb> server # [ 56.068312] dbus-daemon[630]: dbus[630]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-timescaledb> server # [ 56.582479] systemd[1]: Started D-Bus System Message Bus. vm-test-run-timescaledb> server # [ 57.460208] systemd-logind[648]: New seat seat0. vm-test-run-timescaledb> server # [ 57.475037] systemd[1]: Started User Login Management. vm-test-run-timescaledb> server # [ 57.511652] systemd[1]: Starting linger-users.service... vm-test-run-timescaledb> server # [ 57.611493] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 57.615254] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-timescaledb> server # [ 57.625624] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 57.626867] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-timescaledb> server # [ 57.637469] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 57.687837] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 57.707484] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 57.902117] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 58.285331] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 58.293947] systemd[1]: Finished linger-users.service. vm-test-run-timescaledb> server # [ 58.768284] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 58.773337] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 58.785949] nsncd[690]: Oct 10 11:24:48.177 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 58.791803] systemd[1]: Reached target User and Group Name Lookups. 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.295769] systemd[1]: Finished resolvconf update. vm-test-run-timescaledb> server # [ 59.308780] systemd[1]: Reached target Preparation for Network. vm-test-run-timescaledb> server # [ 59.385466] systemd[1]: Starting DHCP Client... vm-test-run-timescaledb> server # [ 60.999110] dhcpcd[738]: dhcpcd-10.2.4 starting vm-test-run-timescaledb> server # [ 61.156469] dhcpcd[760]: dev: loaded udev vm-test-run-timescaledb> server # [ 61.581983] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-timescaledb> server # [ 62.068170] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-timescaledb> server # [ 62.329266] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-timescaledb> server # [ 62.340223] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-timescaledb> server # [ 62.375982] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-timescaledb> server # [ 62.387092] cfg80211: failed to load regulatory.db vm-test-run-timescaledb> server # [ 63.238210] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-timescaledb> server # [ 63.164776] dhcpcd[760]: eth0: waiting for carrier vm-test-run-timescaledb> server # [ 63.189764] dhcpcd[760]: eth0: carrier acquired vm-test-run-timescaledb> server # [ 63.338856] dhcpcd[760]: DUID 00:01:00:01:32:5c:dd:04:52:54:00:12:34:56 vm-test-run-timescaledb> server # [ 63.343313] dhcpcd[760]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 63.347998] dhcpcd[760]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-timescaledb> server # [ 64.072297] systemd[1]: Found device /dev/hvc0. vm-test-run-timescaledb> server # [ 64.458675] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-timescaledb> server # [ 64.504684] systemd[1]: Started backdoor.service. vm-test-run-timescaledb> server # [ 64.746004] dhcpcd[760]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 64.768144] dhcpcd[760]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 64.790186] dhcpcd[760]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # connecting to host... vm-test-run-timescaledb> server # [ 65.253626] (udev-worker)[786]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-timescaledb> server # [ 65.306561] (udev-worker)[790]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 65.307460] (udev-worker)[786]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 65.307963] dhcpcd[760]: eth0: soliciting an IPv6 router 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 66.35 seconds) vm-test-run-timescaledb> server: (finished: waiting for the VM to finish booting, in 66.35 seconds) vm-test-run-timescaledb> server # [ 65.323297] dhcpcd[760]: eth0: Router Advertisement from fe80::2 vm-test-run-timescaledb> server # [ 65.330037] dhcpcd[760]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-timescaledb> server # [ 65.334013] dhcpcd[760]: eth0: adding route to fec0::/64 vm-test-run-timescaledb> server # [ 65.336129] dhcpcd[760]: eth0: adding default route via fe80::2 vm-test-run-timescaledb> server # [ 66.329585] systemd[1]: Found device Virtio network device. vm-test-run-timescaledb> server # [ 66.372947] systemd[1]: Starting Address configuration of eth1... vm-test-run-timescaledb> server # [ 66.433618] dhcpcd[760]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 67.142153] dhcpcd[760]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 67.356881] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-timescaledb> server # [ 67.538032] network-addresses-eth1-start[810]: adding address 192.168.1.1/24... done vm-test-run-timescaledb> server # [ 67.721344] network-addresses-eth1-start[810]: adding address 2001:db8:1::1/64... done vm-test-run-timescaledb> server # [ 68.023915] systemd[1]: Finished Address configuration of eth1. vm-test-run-timescaledb> server # [ 68.082770] dhcpcd[760]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 68.085562] dhcpcd[760]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 68.090617] dhcpcd[760]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 68.109294] systemd[1]: Starting Networking Setup... vm-test-run-timescaledb> server # [ 70.089438] dhcpcd[760]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-timescaledb> server # [ 70.093563] dhcpcd[760]: eth0: adding route to 10.0.2.0/24 vm-test-run-timescaledb> server # [ 70.094949] dhcpcd[760]: eth0: adding default route via 10.0.2.2 vm-test-run-timescaledb> server # [ 70.643089] dhcpcd[892]: /nix/store/hsj50yr7hr62ql9xaynbihkhfhbgprcn-openresolv-3.17.0/sbin/.resolvconf-wrapped: line 1221: kill: (856) - Operation not permitted vm-test-run-timescaledb> server # [ 70.648988] dhcpcd[892]: clearing stale lock pid 856 vm-test-run-timescaledb> server # [ 70.953444] systemd[1]: Finished Networking Setup. vm-test-run-timescaledb> server # [ 70.963045] systemd[1]: Reached target Network. vm-test-run-timescaledb> server # [ 71.015741] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-timescaledb> server # [ 71.066611] systemd[1]: Starting Permit User Sessions... vm-test-run-timescaledb> server # [ 71.791831] systemd[1]: Finished Permit User Sessions. vm-test-run-timescaledb> server # [ 71.863239] systemd[1]: Started Getty on tty1. vm-test-run-timescaledb> server # [ 71.884279] systemd[1]: Reached target Login Prompts. vm-test-run-timescaledb> server # [ 72.844522] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[940]: Initializing database at /var/lib/postgresql/data vm-test-run-timescaledb> server # [ 74.310056] systemd[1]: Started DHCP Client. vm-test-run-timescaledb> server # [ 74.806563] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: The files belonging to this database system will be owned by user "postgres". vm-test-run-timescaledb> server # [ 74.809060] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: This user must also own the server process. vm-test-run-timescaledb> server # [ 74.944167] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-timescaledb> server # [ 74.946386] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: The default database encoding has accordingly been set to "UTF8". vm-test-run-timescaledb> server # [ 74.947937] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: The default text search configuration will be set to "english". vm-test-run-timescaledb> server # [ 74.949254] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: Data page checksums are enabled. vm-test-run-timescaledb> server # [ 74.951057] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-timescaledb> server # [ 74.963153] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: creating subdirectories ... ok vm-test-run-timescaledb> server # [ 74.972590] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: selecting dynamic shared memory implementation ... posix vm-test-run-timescaledb> server # [ 76.302605] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: selecting default max_connections ... 100 vm-test-run-timescaledb> server # [ 76.966438] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: selecting default shared_buffers ... 128MB vm-test-run-timescaledb> server # [ 80.294332] systemd-logind[648]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-timescaledb> server # [ 86.682346] mousedev: PS/2 mouse device common for all mice vm-test-run-timescaledb> server # [ 87.263283] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: selecting default time zone ... UTC vm-test-run-timescaledb> server # [ 87.294776] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: creating configuration files ... ok vm-test-run-timescaledb> server # [ 89.519074] systemd-logind[648]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-timescaledb> server # [ 91.723883] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: running bootstrap script ... ok vm-test-run-timescaledb> server # [ 101.677250] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: performing post-bootstrap initialization ... ok vm-test-run-timescaledb> server # [ 104.287763] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: syncing data to disk ... ok vm-test-run-timescaledb> server # [ 104.298034] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-timescaledb> server # [ 104.301301] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: 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 # [ 104.309583] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: Success. You can now start the database server using: vm-test-run-timescaledb> server # [ 104.311279] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[964]: /nix/store/2bhdbvpk81xy3mkfgqrpc719ip588cba-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-timescaledb> server # [ 105.629808] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[940]: Validating PostgreSQL configuration... vm-test-run-timescaledb> server # [ 106.147877] 3r3xsw4acnvky9qg628bk78h80pml8ac-postgresql-init[1324]: 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 # [ 107.130321] postgres[1333]: 2026-10-10 11:25:36.514 UTC [1333] LOG: pgaudit extension initialized vm-test-run-timescaledb> server # [ 107.867615] postgres[1333]: 2026-10-10 11:25:37.273 UTC [1333] LOG: pgsodium primary server secret key loaded vm-test-run-timescaledb> server # [ 108.433885] postgres[1333]: 2026-10-10 11:25:37.827 UTC [1333] LOG: vault primary server secret key loaded vm-test-run-timescaledb> server # [ 108.815631] postgres[1333]: 2026-10-10 11:25:38.221 UTC [1333] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-timescaledb> server # [ 108.829905] postgres[1333]: 2026-10-10 11:25:38.234 UTC [1333] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-timescaledb> server # [ 108.831679] postgres[1333]: 2026-10-10 11:25:38.237 UTC [1333] LOG: listening on IPv6 address "::", port 5432 vm-test-run-timescaledb> server # [ 108.845297] postgres[1333]: 2026-10-10 11:25:38.249 UTC [1333] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-timescaledb> server # [ 108.923779] postgres[1362]: 2026-10-10 11:25:38.324 UTC [1362] LOG: database system was shut down at 2026-10-10 11:25:30 UTC vm-test-run-timescaledb> server # [ 109.079173] postgres[1333]: 2026-10-10 11:25:38.484 UTC [1333] LOG: database system is ready to accept connections vm-test-run-timescaledb> server # [ 109.119277] systemd[1]: Started PostgreSQL Database Server. vm-test-run-timescaledb> server # [ 109.139110] postgres[1366]: 2026-10-10 11:25:38.540 UTC [1366] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 109.169281] postgres[1365]: 2026-10-10 11:25:38.571 UTC [1365] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-timescaledb> server # [ 109.186343] systemd[1]: Starting Supabase Database Initialization... vm-test-run-timescaledb> server # [ 109.337218] postgres[1333]: 2026-10-10 11:25:38.741 UTC [1333] LOG: background worker "pg_net 0.20.4 worker" (PID 1366) exited with exit code 1 vm-test-run-timescaledb> server # [ 109.477792] postgres[1367]: 2026-10-10 11:25:38.868 UTC [1367] LOG: pg_cron scheduler started vm-test-run-timescaledb> server # [ 109.531370] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Waiting for PostgreSQL to be ready... vm-test-run-timescaledb> server # [ 110.306322] postgres[1387]: ::1 2026-10-10 11:25:39.695 UTC [1387] root@root FATAL: role "root" does not exist vm-test-run-timescaledb> server # [ 110.345838] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: PostgreSQL is ready vm-test-run-timescaledb> server # [ 110.348333] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Creating postgres role... vm-test-run-timescaledb> server # [ 110.451230] postgres[1392]: 2026-10-10 11:25:39.842 UTC [1392] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 110.563455] postgres[1333]: 2026-10-10 11:25:39.960 UTC [1333] LOG: background worker "pg_net 0.20.4 worker" (PID 1392) exited with exit code 1 vm-test-run-timescaledb> server # [ 110.841820] postgres[1395]: ::1 2026-10-10 11:25:40.217 UTC [1395] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-timescaledb> server # [ 110.905013] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1391]: CREATE ROLE vm-test-run-timescaledb> server # [ 111.159132] postgres[1402]: ::1 2026-10-10 11:25:40.554 UTC [1402] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-timescaledb> server # [ 111.187663] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1401]: ALTER DATABASE vm-test-run-timescaledb> server # [ 111.233569] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running init-script: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-timescaledb> server # [ 111.417385] postgres[1404]: ::1 2026-10-10 11:25:40.819 UTC [1404] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-timescaledb> server # [ 111.437392] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: CREATE PUBLICATION vm-test-run-timescaledb> server # [ 111.445236] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: ALTER ROLE vm-test-run-timescaledb> server # [ 111.446163] postgres[1404]: ::1 2026-10-10 11:25:40.839 UTC [1404] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-timescaledb> server # [ 111.447235] postgres[1404]: ::1 2026-10-10 11:25:40.849 UTC [1404] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-timescaledb> server # [ 111.453588] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: CREATE ROLE vm-test-run-timescaledb> server # [ 111.454574] postgres[1404]: ::1 2026-10-10 11:25:40.859 UTC [1404] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-timescaledb> server # [ 111.460154] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: CREATE ROLE vm-test-run-timescaledb> server # [ 111.462714] postgres[1404]: ::1 2026-10-10 11:25:40.868 UTC [1404] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-timescaledb> server # [ 111.470972] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: GRANT ROLE vm-test-run-timescaledb> server # [ 111.473794] postgres[1404]: ::1 2026-10-10 11:25:40.877 UTC [1404] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-timescaledb> server # [ 111.480180] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: GRANT vm-test-run-timescaledb> server # [ 111.481362] postgres[1404]: ::1 2026-10-10 11:25:40.886 UTC [1404] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-timescaledb> server # [ 111.487593] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: CREATE ROLE vm-test-run-timescaledb> server # [ 111.489961] postgres[1404]: ::1 2026-10-10 11:25:40.895 UTC [1404] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-timescaledb> server # [ 111.497320] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: GRANT ROLE vm-test-run-timescaledb> server # [ 111.498346] postgres[1404]: ::1 2026-10-10 11:25:40.901 UTC [1404] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-timescaledb> server # [ 111.506225] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 111.507074] postgres[1404]: ::1 2026-10-10 11:25:40.911 UTC [1404] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-timescaledb> server # [ 113.890917] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 113.902248] postgres[1404]: ::1 2026-10-10 11:25:43.289 UTC [1404] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-timescaledb> server # [ 114.589135] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 114.594526] postgres[1404]: ::1 2026-10-10 11:25:43.996 UTC [1404] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-timescaledb> server # [ 114.599899] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: CREATE ROLE vm-test-run-timescaledb> server # [ 114.603309] postgres[1404]: ::1 2026-10-10 11:25:44.007 UTC [1404] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-timescaledb> server # [ 114.609049] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: CREATE ROLE vm-test-run-timescaledb> server # [ 114.610093] postgres[1404]: ::1 2026-10-10 11:25:44.015 UTC [1404] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-timescaledb> server # [ 114.615531] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: CREATE ROLE vm-test-run-timescaledb> server # [ 114.616996] postgres[1404]: ::1 2026-10-10 11:25:44.022 UTC [1404] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-timescaledb> server # [ 114.623631] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: CREATE ROLE vm-test-run-timescaledb> server # [ 114.626019] postgres[1404]: ::1 2026-10-10 11:25:44.028 UTC [1404] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-timescaledb> server # [ 114.629000] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: GRANT ROLE vm-test-run-timescaledb> server # [ 114.633048] postgres[1404]: ::1 2026-10-10 11:25:44.035 UTC [1404] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-timescaledb> server # [ 114.636136] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: GRANT ROLE vm-test-run-timescaledb> server # [ 114.640491] postgres[1404]: ::1 2026-10-10 11:25:44.044 UTC [1404] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-timescaledb> server # [ 114.643541] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: GRANT ROLE vm-test-run-timescaledb> server # [ 114.646959] postgres[1404]: ::1 2026-10-10 11:25:44.051 UTC [1404] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-timescaledb> server # [ 114.650659] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: GRANT ROLE vm-test-run-timescaledb> server # [ 114.651316] postgres[1404]: ::1 2026-10-10 11:25:44.057 UTC [1404] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 114.656162] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: GRANT vm-test-run-timescaledb> server # [ 114.659867] postgres[1404]: ::1 2026-10-10 11:25:44.065 UTC [1404] 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 # [ 114.670612] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 114.671707] postgres[1404]: ::1 2026-10-10 11:25:44.077 UTC [1404] 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 # [ 114.685512] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 114.686424] postgres[1404]: ::1 2026-10-10 11:25:44.092 UTC [1404] 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 # [ 114.693301] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 114.695286] postgres[1404]: ::1 2026-10-10 11:25:44.098 UTC [1404] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 114.700455] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: GRANT vm-test-run-timescaledb> server # [ 114.702507] postgres[1404]: ::1 2026-10-10 11:25:44.107 UTC [1404] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-timescaledb> server # [ 114.710040] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: ALTER ROLE vm-test-run-timescaledb> server # [ 114.714284] postgres[1404]: ::1 2026-10-10 11:25:44.117 UTC [1404] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 114.717079] postgres[1404]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 114.720769] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 114.725190] postgres[1404]: ::1 2026-10-10 11:25:44.128 UTC [1404] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 114.726290] postgres[1404]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 114.731692] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 114.735399] postgres[1404]: ::1 2026-10-10 11:25:44.137 UTC [1404] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 114.741483] postgres[1404]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 114.743392] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 114.747431] postgres[1404]: ::1 2026-10-10 11:25:44.151 UTC [1404] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-timescaledb> server # [ 114.754302] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: ALTER ROLE vm-test-run-timescaledb> server # [ 114.758519] postgres[1404]: ::1 2026-10-10 11:25:44.161 UTC [1404] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 114.763571] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1403]: ALTER ROLE vm-test-run-timescaledb> server # [ 114.800632] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running init-script: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-timescaledb> server # [ 115.024053] postgres[1435]: ::1 2026-10-10 11:25:44.424 UTC [1435] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 115.038258] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 115.039621] postgres[1435]: ::1 2026-10-10 11:25:44.443 UTC [1435] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-timescaledb> server # [ 115.046739] postgres[1435]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 115.047301] postgres[1435]: id uuid NOT NULL UNIQUE, vm-test-run-timescaledb> server # [ 115.047803] postgres[1435]: aud varchar(255) NULL, vm-test-run-timescaledb> server # [ 115.055062] postgres[1435]: "role" varchar(255) NULL, vm-test-run-timescaledb> server # [ 115.061397] postgres[1435]: email varchar(255) NULL UNIQUE, vm-test-run-timescaledb> server # [ 115.062202] postgres[1435]: encrypted_password varchar(255) NULL, vm-test-run-timescaledb> server # [ 115.062729] postgres[1435]: confirmed_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.063240] postgres[1435]: invited_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.064468] postgres[1435]: confirmation_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 115.070898] postgres[1435]: confirmation_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.071571] postgres[1435]: recovery_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 115.077982] postgres[1435]: recovery_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.080725] postgres[1435]: email_change_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 115.082750] postgres[1435]: email_change varchar(255) NULL, vm-test-run-timescaledb> server # [ 115.083421] postgres[1435]: email_change_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.083927] postgres[1435]: last_sign_in_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.085185] postgres[1435]: raw_app_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 115.100926] postgres[1435]: raw_user_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 115.102072] postgres[1435]: is_super_admin bool NULL, vm-test-run-timescaledb> server # [ 115.103973] postgres[1435]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.109553] postgres[1435]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.111648] postgres[1435]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 115.113498] postgres[1435]: ); vm-test-run-timescaledb> server # [ 115.155464] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE TABLE vm-test-run-timescaledb> server # [ 115.161771] postgres[1435]: ::1 2026-10-10 11:25:44.565 UTC [1435] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-timescaledb> server # [ 115.191043] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE INDEX vm-test-run-timescaledb> server # [ 115.192151] postgres[1435]: ::1 2026-10-10 11:25:44.595 UTC [1435] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-timescaledb> server # [ 115.221090] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE INDEX vm-test-run-timescaledb> server # [ 115.222322] postgres[1435]: ::1 2026-10-10 11:25:44.628 UTC [1435] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-timescaledb> server # [ 115.231488] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: COMMENT vm-test-run-timescaledb> server # [ 115.234002] postgres[1435]: ::1 2026-10-10 11:25:44.637 UTC [1435] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-timescaledb> server # [ 115.237108] postgres[1435]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 115.238066] postgres[1435]: id bigserial NOT NULL, vm-test-run-timescaledb> server # [ 115.238684] postgres[1435]: "token" varchar(255) NULL, vm-test-run-timescaledb> server # [ 115.239571] postgres[1435]: user_id varchar(255) NULL, vm-test-run-timescaledb> server # [ 115.241908] postgres[1435]: revoked bool NULL, vm-test-run-timescaledb> server # [ 115.242304] postgres[1435]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.242590] postgres[1435]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.242856] postgres[1435]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 115.243110] postgres[1435]: ); vm-test-run-timescaledb> server # [ 115.304009] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE TABLE vm-test-run-timescaledb> server # [ 115.312980] postgres[1435]: ::1 2026-10-10 11:25:44.716 UTC [1435] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-timescaledb> server # [ 115.347008] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE INDEX vm-test-run-timescaledb> server # [ 115.358416] postgres[1435]: ::1 2026-10-10 11:25:44.756 UTC [1435] 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 # [ 115.385630] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE INDEX vm-test-run-timescaledb> server # [ 115.395722] postgres[1435]: ::1 2026-10-10 11:25:44.800 UTC [1435] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-timescaledb> server # [ 115.436050] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE INDEX vm-test-run-timescaledb> server # [ 115.443488] postgres[1435]: ::1 2026-10-10 11:25:44.845 UTC [1435] 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 # [ 115.453979] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: COMMENT vm-test-run-timescaledb> server # [ 115.464730] postgres[1435]: ::1 2026-10-10 11:25:44.863 UTC [1435] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-timescaledb> server # [ 115.466910] postgres[1435]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 115.467885] postgres[1435]: uuid uuid NULL, vm-test-run-timescaledb> server # [ 115.478413] postgres[1435]: raw_base_config text NULL, vm-test-run-timescaledb> server # [ 115.480050] postgres[1435]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.480419] postgres[1435]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.491003] postgres[1435]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 115.494353] postgres[1435]: ); vm-test-run-timescaledb> server # [ 115.594629] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE TABLE vm-test-run-timescaledb> server # [ 115.595976] postgres[1435]: ::1 2026-10-10 11:25:44.995 UTC [1435] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-timescaledb> server # [ 115.614600] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: COMMENT vm-test-run-timescaledb> server # [ 115.617202] postgres[1435]: ::1 2026-10-10 11:25:45.013 UTC [1435] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-timescaledb> server # [ 115.628975] postgres[1435]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 115.629602] postgres[1435]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 115.629948] postgres[1435]: payload json NULL, vm-test-run-timescaledb> server # [ 115.630350] postgres[1435]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 115.631129] postgres[1435]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 115.631617] postgres[1435]: ); vm-test-run-timescaledb> server # [ 115.707109] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE TABLE vm-test-run-timescaledb> server # [ 115.722026] postgres[1435]: ::1 2026-10-10 11:25:45.125 UTC [1435] 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 # [ 115.777634] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE INDEX vm-test-run-timescaledb> server # [ 115.785232] postgres[1435]: ::1 2026-10-10 11:25:45.187 UTC [1435] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-timescaledb> server # [ 115.802393] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: COMMENT vm-test-run-timescaledb> server # [ 115.803910] postgres[1435]: ::1 2026-10-10 11:25:45.209 UTC [1435] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-timescaledb> server # [ 115.821555] postgres[1435]: "version" varchar(255) NOT NULL, vm-test-run-timescaledb> server # [ 115.825531] postgres[1435]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-timescaledb> server # [ 115.827667] postgres[1435]: ); vm-test-run-timescaledb> server # [ 115.843100] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE TABLE vm-test-run-timescaledb> server # [ 115.851776] postgres[1435]: ::1 2026-10-10 11:25:45.256 UTC [1435] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-timescaledb> server # [ 115.865118] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: COMMENT vm-test-run-timescaledb> server # [ 115.923737] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: INSERT 0 7 vm-test-run-timescaledb> server # [ 115.926323] postgres[1435]: ::1 2026-10-10 11:25:45.332 UTC [1435] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-timescaledb> server # [ 115.926968] postgres[1435]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-timescaledb> server # [ 115.927852] postgres[1435]: $$ language sql stable; vm-test-run-timescaledb> server # [ 115.961817] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 115.982043] postgres[1435]: ::1 2026-10-10 11:25:45.379 UTC [1435] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-timescaledb> server # [ 115.983144] postgres[1435]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-timescaledb> server # [ 115.985105] postgres[1435]: $$ language sql stable; vm-test-run-timescaledb> server # [ 115.987502] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 115.993576] postgres[1435]: ::1 2026-10-10 11:25:45.395 UTC [1435] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-timescaledb> server # [ 116.005317] postgres[1435]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-timescaledb> server # [ 116.006717] postgres[1435]: $$ language sql stable; vm-test-run-timescaledb> server # [ 116.051595] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 116.071191] postgres[1435]: ::1 2026-10-10 11:25:45.452 UTC [1435] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 116.078384] postgres[1435]: ::1 2026-10-10 11:25:45.476 UTC [1435] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 116.079503] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: GRANT vm-test-run-timescaledb> server # [ 116.093848] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: CREATE ROLE vm-test-run-timescaledb> server # [ 116.094579] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: GRANT vm-test-run-timescaledb> server # [ 116.095159] postgres[1435]: ::1 2026-10-10 11:25:45.488 UTC [1435] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 116.095648] postgres[1435]: ::1 2026-10-10 11:25:45.498 UTC [1435] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 116.110137] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: GRANT vm-test-run-timescaledb> server # [ 116.115064] postgres[1435]: ::1 2026-10-10 11:25:45.513 UTC [1435] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 116.121955] postgres[1435]: ::1 2026-10-10 11:25:45.524 UTC [1435] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-timescaledb> server # [ 116.126273] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: GRANT vm-test-run-timescaledb> server # [ 116.126842] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: ALTER ROLE vm-test-run-timescaledb> server # [ 116.127213] postgres[1435]: ::1 2026-10-10 11:25:45.530 UTC [1435] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 116.151097] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: ALTER TABLE vm-test-run-timescaledb> server # [ 116.152382] postgres[1435]: ::1 2026-10-10 11:25:45.557 UTC [1435] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 116.169925] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: ALTER TABLE vm-test-run-timescaledb> server # [ 116.173364] postgres[1435]: ::1 2026-10-10 11:25:45.570 UTC [1435] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 116.190795] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: ALTER TABLE vm-test-run-timescaledb> server # [ 116.193899] postgres[1435]: ::1 2026-10-10 11:25:45.599 UTC [1435] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 116.211141] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: ALTER TABLE vm-test-run-timescaledb> server # [ 116.216478] postgres[1435]: ::1 2026-10-10 11:25:45.619 UTC [1435] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 116.225449] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1434]: ALTER TABLE vm-test-run-timescaledb> server # [ 116.277505] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running init-script: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-timescaledb> server # [ 116.627787] postgres[1458]: ::1 2026-10-10 11:25:46.010 UTC [1458] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 116.650219] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1453]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 116.651415] postgres[1458]: ::1 2026-10-10 11:25:46.042 UTC [1458] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 116.654987] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1453]: CREATE ROLE vm-test-run-timescaledb> server # [ 116.661250] postgres[1458]: ::1 2026-10-10 11:25:46.062 UTC [1458] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-timescaledb> server # [ 116.669990] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1453]: ALTER ROLE vm-test-run-timescaledb> server # [ 116.672801] postgres[1458]: ::1 2026-10-10 11:25:46.077 UTC [1458] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-timescaledb> server # [ 116.681270] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1453]: GRANT vm-test-run-timescaledb> server # [ 116.717061] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1453]: DO vm-test-run-timescaledb> server # [ 116.743643] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running init-script: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-timescaledb> server # [ 116.970273] postgres[1463]: ::1 2026-10-10 11:25:46.373 UTC [1463] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-timescaledb> server # [ 116.993867] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: ALTER ROLE vm-test-run-timescaledb> server # [ 116.994812] postgres[1463]: ::1 2026-10-10 11:25:46.389 UTC [1463] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-timescaledb> server # [ 116.995967] postgres[1463]: ::1 2026-10-10 11:25:46.399 UTC [1463] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-timescaledb> server # [ 117.001432] postgres[1463]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 117.002367] postgres[1463]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 117.003018] postgres[1463]: AS $$ vm-test-run-timescaledb> server # [ 117.003322] postgres[1463]: DECLARE vm-test-run-timescaledb> server # [ 117.003573] postgres[1463]: schema_is_cron bool; vm-test-run-timescaledb> server # [ 117.004107] postgres[1463]: BEGIN vm-test-run-timescaledb> server # [ 117.009130] postgres[1463]: schema_is_cron = ( vm-test-run-timescaledb> server # [ 117.009920] postgres[1463]: SELECT n.nspname = 'cron' vm-test-run-timescaledb> server # [ 117.010261] postgres[1463]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 117.011962] postgres[1463]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-timescaledb> server # [ 117.017810] postgres[1463]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 117.018242] postgres[1463]: ); vm-test-run-timescaledb> server # [ 117.018652] postgres[1463]: vm-test-run-timescaledb> server # [ 117.019033] postgres[1463]: IF schema_is_cron vm-test-run-timescaledb> server # [ 117.019553] postgres[1463]: THEN vm-test-run-timescaledb> server # [ 117.019838] postgres[1463]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 117.022954] postgres[1463]: vm-test-run-timescaledb> server # [ 117.023527] postgres[1463]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 117.023872] postgres[1463]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 117.024270] postgres[1463]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 117.030075] postgres[1463]: vm-test-run-timescaledb> server # [ 117.030964] postgres[1463]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 117.031976] postgres[1463]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 117.035333] postgres[1463]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 117.035902] postgres[1463]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 117.036824] postgres[1463]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 117.037517] postgres[1463]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 117.037917] postgres[1463]: vm-test-run-timescaledb> server # [ 117.038170] postgres[1463]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 117.038618] postgres[1463]: vm-test-run-timescaledb> server # [ 117.039799] postgres[1463]: END IF; vm-test-run-timescaledb> server # [ 117.043262] postgres[1463]: vm-test-run-timescaledb> server # [ 117.044848] postgres[1463]: END; vm-test-run-timescaledb> server # [ 117.045429] postgres[1463]: $$; vm-test-run-timescaledb> server # [ 117.046205] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: ALTER ROLE vm-test-run-timescaledb> server # [ 117.046817] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 117.047365] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 117.051549] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: COMMENT vm-test-run-timescaledb> server # [ 117.053922] postgres[1463]: ::1 2026-10-10 11:25:46.422 UTC [1463] 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 # [ 117.055099] postgres[1463]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 117.055455] postgres[1463]: ::1 2026-10-10 11:25:46.441 UTC [1463] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-timescaledb> server # [ 117.056837] postgres[1463]: ::1 2026-10-10 11:25:46.451 UTC [1463] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-timescaledb> server # [ 117.057460] postgres[1463]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 117.058373] postgres[1463]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 117.058708] postgres[1463]: AS $$ vm-test-run-timescaledb> server # [ 117.059101] postgres[1463]: BEGIN vm-test-run-timescaledb> server # [ 117.059349] postgres[1463]: IF EXISTS ( vm-test-run-timescaledb> server # [ 117.059587] postgres[1463]: SELECT 1 vm-test-run-timescaledb> server # [ 117.061164] postgres[1463]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 117.061565] postgres[1463]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 117.062786] postgres[1463]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 117.063632] postgres[1463]: WHERE ext.extname = 'pg_net' vm-test-run-timescaledb> server # [ 117.066532] postgres[1463]: ) vm-test-run-timescaledb> server # [ 117.077079] postgres[1463]: THEN vm-test-run-timescaledb> server # [ 117.078027] postgres[1463]: IF NOT EXISTS ( vm-test-run-timescaledb> server # [ 117.078679] postgres[1463]: SELECT 1 vm-test-run-timescaledb> server # [ 117.079627] postgres[1463]: FROM pg_roles vm-test-run-timescaledb> server # [ 117.085617] postgres[1463]: WHERE rolname = 'supabase_functions_admin' vm-test-run-timescaledb> server # [ 117.086673] postgres[1463]: ) vm-test-run-timescaledb> server # [ 117.087666] postgres[1463]: THEN vm-test-run-timescaledb> server # [ 117.088048] postgres[1463]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 117.088365] postgres[1463]: END IF; vm-test-run-timescaledb> server # [ 117.100277] postgres[1463]: vm-test-run-timescaledb> server # [ 117.102049] postgres[1463]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 117.102792] postgres[1463]: vm-test-run-timescaledb> server # [ 117.106404] postgres[1463]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 117.114346] postgres[1463]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 117.118297] postgres[1463]: vm-test-run-timescaledb> server # [ 117.119100] postgres[1463]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-timescaledb> server # [ 117.119639] postgres[1463]: 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 # [ 117.119995] postgres[1463]: vm-test-run-timescaledb> server # [ 117.120222] postgres[1463]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-timescaledb> server # [ 117.126831] postgres[1463]: 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 # [ 117.134201] postgres[1463]: vm-test-run-timescaledb> server # [ 117.134747] postgres[1463]: 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 # [ 117.135582] postgres[1463]: 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 # [ 117.140067] postgres[1463]: END IF; vm-test-run-timescaledb> server # [ 117.142093] postgres[1463]: END; vm-test-run-timescaledb> server # [ 117.143006] postgres[1463]: $$; vm-test-run-timescaledb> server # [ 117.150140] postgres[1463]: ::1 2026-10-10 11:25:46.466 UTC [1463] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-timescaledb> server # [ 117.158743] postgres[1463]: ::1 2026-10-10 11:25:46.516 UTC [1463] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-timescaledb> server # [ 117.159705] postgres[1463]: ::1 2026-10-10 11:25:46.528 UTC [1463] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-timescaledb> server # [ 117.163526] postgres[1463]: ::1 2026-10-10 11:25:46.537 UTC [1463] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 117.166552] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 117.167571] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: COMMENT vm-test-run-timescaledb> server # [ 117.168475] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: DO vm-test-run-timescaledb> server # [ 117.175928] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: CREATE ROLE vm-test-run-timescaledb> server # [ 117.178972] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: GRANT vm-test-run-timescaledb> server # [ 117.179606] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: GRANT vm-test-run-timescaledb> server # [ 117.179919] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: GRANT vm-test-run-timescaledb> server # [ 117.183011] postgres[1463]: ::1 2026-10-10 11:25:46.552 UTC [1463] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 117.185256] postgres[1463]: ::1 2026-10-10 11:25:46.560 UTC [1463] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 117.186097] postgres[1463]: ::1 2026-10-10 11:25:46.577 UTC [1463] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 117.187617] postgres[1463]: ::1 2026-10-10 11:25:46.584 UTC [1463] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 117.189221] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: GRANT vm-test-run-timescaledb> server # [ 117.190204] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: GRANT vm-test-run-timescaledb> server # [ 117.195415] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: GRANT vm-test-run-timescaledb> server # [ 117.197040] postgres[1463]: ::1 2026-10-10 11:25:46.602 UTC [1463] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 117.199220] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: GRANT vm-test-run-timescaledb> server # [ 117.199890] postgres[1463]: ::1 2026-10-10 11:25:46.605 UTC [1463] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 117.230930] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: GRANT vm-test-run-timescaledb> server # [ 117.239603] postgres[1463]: ::1 2026-10-10 11:25:46.634 UTC [1463] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 117.279874] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: GRANT vm-test-run-timescaledb> server # [ 117.302407] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1462]: DO vm-test-run-timescaledb> server # [ 117.354190] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running pgbouncer auth schema... vm-test-run-timescaledb> server # [ 117.649647] postgres[1469]: ::1 2026-10-10 11:25:47.031 UTC [1469] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-timescaledb> server # [ 117.661066] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1467]: CREATE ROLE vm-test-run-timescaledb> server # [ 117.665378] postgres[1469]: ::1 2026-10-10 11:25:47.060 UTC [1469] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-timescaledb> server # [ 117.675058] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1467]: REVOKE vm-test-run-timescaledb> server # [ 117.676952] postgres[1469]: ::1 2026-10-10 11:25:47.076 UTC [1469] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-timescaledb> server # [ 117.749596] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1467]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 117.753517] postgres[1469]: ::1 2026-10-10 11:25:47.158 UTC [1469] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-timescaledb> server # [ 117.766443] postgres[1469]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-timescaledb> server # [ 117.767382] postgres[1469]: $$ vm-test-run-timescaledb> server # [ 117.774210] postgres[1469]: BEGIN vm-test-run-timescaledb> server # [ 117.777751] postgres[1469]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-timescaledb> server # [ 117.778741] postgres[1469]: vm-test-run-timescaledb> server # [ 117.779383] postgres[1469]: RETURN QUERY vm-test-run-timescaledb> server # [ 117.779833] postgres[1469]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-timescaledb> server # [ 117.782249] postgres[1469]: WHERE usename = p_usename; vm-test-run-timescaledb> server # [ 117.790690] postgres[1469]: END; vm-test-run-timescaledb> server # [ 117.791229] postgres[1469]: $$ LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 117.791697] postgres[1469]: SET search_path = '' vm-test-run-timescaledb> server # [ 117.801150] postgres[1469]: SECURITY DEFINER; vm-test-run-timescaledb> server # [ 117.802037] postgres[1469]: ::1 2026-10-10 11:25:47.204 UTC [1469] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-timescaledb> server # [ 117.803248] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1467]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 117.818180] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1467]: REVOKE vm-test-run-timescaledb> server # [ 117.824548] postgres[1469]: ::1 2026-10-10 11:25:47.226 UTC [1469] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-timescaledb> server # [ 117.840962] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1467]: GRANT vm-test-run-timescaledb> server # [ 117.866589] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running stat extension... vm-test-run-timescaledb> server # [ 118.119208] postgres[1471]: ::1 2026-10-10 11:25:47.520 UTC [1471] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-timescaledb> server # [ 118.134260] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1470]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-timescaledb> server # [ 118.153393] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1470]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 118.158904] postgres[1471]: ::1 2026-10-10 11:25:47.561 UTC [1471] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-timescaledb> server # [ 119.367801] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1470]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 119.436803] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-timescaledb> server # [ 119.952134] postgres[1497]: ::1 2026-10-10 11:25:49.349 UTC [1497] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-timescaledb> server # [ 119.967791] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 119.970502] postgres[1497]: ::1 2026-10-10 11:25:49.376 UTC [1497] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 119.998649] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 120.000864] postgres[1497]: ::1 2026-10-10 11:25:49.406 UTC [1497] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 120.011472] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 120.013439] postgres[1497]: ::1 2026-10-10 11:25:49.417 UTC [1497] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 120.025865] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 120.027272] postgres[1497]: ::1 2026-10-10 11:25:49.432 UTC [1497] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 120.034875] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 120.036573] postgres[1497]: ::1 2026-10-10 11:25:49.442 UTC [1497] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 120.046450] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 120.047273] postgres[1497]: ::1 2026-10-10 11:25:49.452 UTC [1497] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 120.053525] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 120.054375] postgres[1497]: ::1 2026-10-10 11:25:49.457 UTC [1497] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 120.069373] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 120.070957] postgres[1497]: ::1 2026-10-10 11:25:49.471 UTC [1497] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 120.106924] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1492]: GRANT vm-test-run-timescaledb> server # [ 120.150685] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1492]: DO vm-test-run-timescaledb> server # [ 120.151961] postgres[1497]: ::1 2026-10-10 11:25:49.557 UTC [1497] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-timescaledb> server # [ 120.164712] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1492]: ALTER ROLE vm-test-run-timescaledb> server # [ 120.202028] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-timescaledb> server # [ 120.459805] postgres[1499]: ::1 2026-10-10 11:25:49.858 UTC [1499] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.477310] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 120.478433] postgres[1499]: ::1 2026-10-10 11:25:49.876 UTC [1499] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.487941] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 120.489553] postgres[1499]: ::1 2026-10-10 11:25:49.892 UTC [1499] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.493904] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 120.500725] postgres[1499]: ::1 2026-10-10 11:25:49.903 UTC [1499] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.508322] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: ALTER TABLE vm-test-run-timescaledb> server # [ 120.510166] postgres[1499]: ::1 2026-10-10 11:25:49.916 UTC [1499] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.523775] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: ALTER TABLE vm-test-run-timescaledb> server # [ 120.525880] postgres[1499]: ::1 2026-10-10 11:25:49.930 UTC [1499] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.532054] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: ALTER TABLE vm-test-run-timescaledb> server # [ 120.534110] postgres[1499]: ::1 2026-10-10 11:25:49.939 UTC [1499] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.541656] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: ALTER TABLE vm-test-run-timescaledb> server # [ 120.544615] postgres[1499]: ::1 2026-10-10 11:25:49.950 UTC [1499] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.555517] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: ALTER TABLE vm-test-run-timescaledb> server # [ 120.558841] postgres[1499]: ::1 2026-10-10 11:25:49.959 UTC [1499] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 120.561116] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 120.566317] postgres[1499]: ::1 2026-10-10 11:25:49.969 UTC [1499] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 120.574958] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 120.578790] postgres[1499]: ::1 2026-10-10 11:25:49.982 UTC [1499] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 120.584011] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 120.589545] postgres[1499]: ::1 2026-10-10 11:25:49.991 UTC [1499] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 120.594614] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: GRANT vm-test-run-timescaledb> server # [ 120.599057] postgres[1499]: ::1 2026-10-10 11:25:50.005 UTC [1499] 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 # [ 120.613159] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 120.614223] postgres[1499]: ::1 2026-10-10 11:25:50.016 UTC [1499] 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 # [ 120.619006] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 120.622834] postgres[1499]: ::1 2026-10-10 11:25:50.026 UTC [1499] 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 # [ 120.632880] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1498]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 120.651500] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-timescaledb> server # [ 120.873585] postgres[1501]: ::1 2026-10-10 11:25:50.260 UTC [1501] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-timescaledb> server # [ 120.878754] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1500]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 120.907216] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 121.184134] postgres[1506]: ::1 2026-10-10 11:25:50.578 UTC [1506] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-timescaledb> server # [ 121.207319] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1502]: GRANT vm-test-run-timescaledb> server # [ 121.208198] postgres[1506]: ::1 2026-10-10 11:25:50.609 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 121.221123] postgres[1506]: ::1 2026-10-10 11:25:50.613 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 121.222851] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1502]: GRANT vm-test-run-timescaledb> server # [ 121.223304] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1502]: GRANT vm-test-run-timescaledb> server # [ 121.223748] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1502]: GRANT vm-test-run-timescaledb> server # [ 121.233617] postgres[1506]: ::1 2026-10-10 11:25:50.616 UTC [1506] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 121.268992] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-timescaledb> server # [ 121.667832] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1508]: DO vm-test-run-timescaledb> server # [ 121.683522] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1508]: DO vm-test-run-timescaledb> server # [ 121.717369] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1508]: DO vm-test-run-timescaledb> server # [ 121.791465] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 122.153829] postgres[1521]: ::1 2026-10-10 11:25:51.551 UTC [1521] 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 # [ 122.196134] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1515]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 122.201360] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1515]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 122.209137] postgres[1521]: ::1 2026-10-10 11:25:51.591 UTC [1521] 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 # [ 122.219920] postgres[1521]: ::1 2026-10-10 11:25:51.602 UTC [1521] 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 # [ 122.223281] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1515]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 122.266732] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-timescaledb> server # [ 122.584562] postgres[1533]: ::1 2026-10-10 11:25:51.983 UTC [1533] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-timescaledb> server # [ 122.602980] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1528]: ALTER ROLE vm-test-run-timescaledb> server # [ 122.630523] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-timescaledb> server # [ 122.898425] postgres[1536]: ::1 2026-10-10 11:25:52.293 UTC [1536] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 122.919355] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: psql:/nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-timescaledb> server # [ 122.928912] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 122.930385] postgres[1536]: ::1 2026-10-10 11:25:52.315 UTC [1536] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 122.931699] postgres[1536]: ::1 2026-10-10 11:25:52.328 UTC [1536] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 122.938276] postgres[1536]: DECLARE vm-test-run-timescaledb> server # [ 122.939635] postgres[1536]: cmd record; vm-test-run-timescaledb> server # [ 122.940261] postgres[1536]: BEGIN vm-test-run-timescaledb> server # [ 122.946090] postgres[1536]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 122.946506] postgres[1536]: LOOP vm-test-run-timescaledb> server # [ 122.946747] postgres[1536]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 122.947569] postgres[1536]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 122.948148] postgres[1536]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 122.950720] postgres[1536]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 122.961855] postgres[1536]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 122.962357] postgres[1536]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 122.962846] postgres[1536]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 122.971190] postgres[1536]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 122.972116] postgres[1536]: , 'CREATE TYPE' vm-test-run-timescaledb> server # [ 122.977474] postgres[1536]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 122.978173] postgres[1536]: , 'COMMENT' vm-test-run-timescaledb> server # [ 122.978913] postgres[1536]: ) vm-test-run-timescaledb> server # [ 122.979330] postgres[1536]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 122.980014] postgres[1536]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 122.980315] postgres[1536]: THEN vm-test-run-timescaledb> server # [ 122.989337] postgres[1536]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 122.989999] postgres[1536]: END IF; vm-test-run-timescaledb> server # [ 122.990275] postgres[1536]: END LOOP; vm-test-run-timescaledb> server # [ 122.990498] postgres[1536]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 122.991233] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: psql:/nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-timescaledb> server # [ 122.992096] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: DROP FUNCTION vm-test-run-timescaledb> server # [ 123.001252] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 123.002498] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 123.003319] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: psql:/nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 123.004269] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 123.018241] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 123.029919] postgres[1536]: ::1 2026-10-10 11:25:52.359 UTC [1536] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 123.031458] postgres[1536]: DECLARE vm-test-run-timescaledb> server # [ 123.037217] postgres[1536]: obj record; vm-test-run-timescaledb> server # [ 123.038122] postgres[1536]: BEGIN vm-test-run-timescaledb> server # [ 123.039041] postgres[1536]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 123.039553] postgres[1536]: LOOP vm-test-run-timescaledb> server # [ 123.039890] postgres[1536]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 123.040200] postgres[1536]: 'schema' vm-test-run-timescaledb> server # [ 123.040782] postgres[1536]: , 'table' vm-test-run-timescaledb> server # [ 123.059797] postgres[1536]: , 'foreign table' vm-test-run-timescaledb> server # [ 123.063993] postgres[1536]: , 'view' vm-test-run-timescaledb> server # [ 123.067401] postgres[1536]: , 'materialized view' vm-test-run-timescaledb> server # [ 123.067947] postgres[1536]: , 'function' vm-test-run-timescaledb> server # [ 123.068307] postgres[1536]: , 'trigger' vm-test-run-timescaledb> server # [ 123.077333] postgres[1536]: , 'type' vm-test-run-timescaledb> server # [ 123.080166] postgres[1536]: , 'rule' vm-test-run-timescaledb> server # [ 123.087084] postgres[1536]: ) vm-test-run-timescaledb> server # [ 123.087572] postgres[1536]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 123.095507] postgres[1536]: THEN vm-test-run-timescaledb> server # [ 123.101252] postgres[1536]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 123.102691] postgres[1536]: END IF; vm-test-run-timescaledb> server # [ 123.103079] postgres[1536]: END LOOP; vm-test-run-timescaledb> server # [ 123.103514] postgres[1536]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 123.103948] postgres[1536]: ::1 2026-10-10 11:25:52.375 UTC [1536] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 123.105711] postgres[1536]: ::1 2026-10-10 11:25:52.381 UTC [1536] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 123.113920] postgres[1536]: ON ddl_command_end vm-test-run-timescaledb> server # [ 123.114687] postgres[1536]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 123.115263] postgres[1536]: ::1 2026-10-10 11:25:52.396 UTC [1536] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 123.115847] postgres[1536]: ::1 2026-10-10 11:25:52.404 UTC [1536] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 123.119903] postgres[1536]: ON sql_drop vm-test-run-timescaledb> server # [ 123.123912] postgres[1536]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 123.130217] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: psql:/nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 123.133590] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 123.135415] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1534]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 123.146376] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-timescaledb> server # [ 123.980106] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1540]: DO vm-test-run-timescaledb> server # [ 124.010984] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-timescaledb> server # [ 124.199692] postgres[1543]: ::1 2026-10-10 11:25:53.602 UTC [1543] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-timescaledb> server # [ 124.241209] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 124.249183] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: psql:/nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-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 # [ 124.250063] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: DROP FUNCTION vm-test-run-timescaledb> server # [ 124.250617] postgres[1543]: ::1 2026-10-10 11:25:53.640 UTC [1543] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-timescaledb> server # [ 124.251592] postgres[1543]: ::1 2026-10-10 11:25:53.648 UTC [1543] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 124.252059] postgres[1543]: "operationName" text default null, vm-test-run-timescaledb> server # [ 124.253619] postgres[1543]: query text default null, vm-test-run-timescaledb> server # [ 124.258800] postgres[1543]: variables jsonb default null, vm-test-run-timescaledb> server # [ 124.259899] postgres[1543]: extensions jsonb default null vm-test-run-timescaledb> server # [ 124.260709] postgres[1543]: ) vm-test-run-timescaledb> server # [ 124.264045] postgres[1543]: returns jsonb vm-test-run-timescaledb> server # [ 124.270698] postgres[1543]: language plpgsql vm-test-run-timescaledb> server # [ 124.271829] postgres[1543]: as $$ vm-test-run-timescaledb> server # [ 124.274265] postgres[1543]: DECLARE vm-test-run-timescaledb> server # [ 124.274724] postgres[1543]: server_version float; vm-test-run-timescaledb> server # [ 124.275035] postgres[1543]: BEGIN vm-test-run-timescaledb> server # [ 124.275293] postgres[1543]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 124.275995] postgres[1543]: vm-test-run-timescaledb> server # [ 124.276249] postgres[1543]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 124.278962] postgres[1543]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 124.281206] postgres[1543]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 124.281968] postgres[1543]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 124.282466] postgres[1543]: ); vm-test-run-timescaledb> server # [ 124.283531] postgres[1543]: ELSE vm-test-run-timescaledb> server # [ 124.283812] postgres[1543]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 124.284069] postgres[1543]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 124.285741] postgres[1543]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 124.286591] postgres[1543]: ); vm-test-run-timescaledb> server # [ 124.287094] postgres[1543]: END IF; vm-test-run-timescaledb> server # [ 124.287464] postgres[1543]: END; vm-test-run-timescaledb> server # [ 124.289508] postgres[1543]: $$; vm-test-run-timescaledb> server # [ 124.290360] postgres[1543]: ::1 2026-10-10 11:25:53.672 UTC [1543] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.290857] postgres[1543]: ::1 2026-10-10 11:25:53.689 UTC [1543] 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 # [ 124.293260] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 124.294964] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: GRANT vm-test-run-timescaledb> server # [ 124.296812] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.297404] postgres[1543]: ::1 2026-10-10 11:25:53.703 UTC [1543] 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 # [ 124.304679] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.305967] postgres[1543]: ::1 2026-10-10 11:25:53.709 UTC [1543] 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 # [ 124.313547] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.319229] postgres[1543]: ::1 2026-10-10 11:25:53.722 UTC [1543] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 124.323048] postgres[1543]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.327486] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.328177] postgres[1543]: ::1 2026-10-10 11:25:53.734 UTC [1543] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 124.335232] postgres[1543]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.339280] postgres[1543]: ::1 2026-10-10 11:25:53.744 UTC [1543] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 124.345017] postgres[1543]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.346625] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.351994] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.355976] postgres[1543]: ::1 2026-10-10 11:25:53.761 UTC [1543] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 124.357998] postgres[1543]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 124.358464] postgres[1543]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 124.358839] postgres[1543]: AS $func$ vm-test-run-timescaledb> server # [ 124.359387] postgres[1543]: DECLARE vm-test-run-timescaledb> server # [ 124.359726] postgres[1543]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 124.360175] postgres[1543]: BEGIN vm-test-run-timescaledb> server # [ 124.361442] postgres[1543]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 124.363026] postgres[1543]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 124.364233] postgres[1543]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 124.366725] postgres[1543]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 124.367640] postgres[1543]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 124.369061] postgres[1543]: ); vm-test-run-timescaledb> server # [ 124.369878] postgres[1543]: vm-test-run-timescaledb> server # [ 124.370498] postgres[1543]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 124.371099] postgres[1543]: THEN vm-test-run-timescaledb> server # [ 124.371885] postgres[1543]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.373139] postgres[1543]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.374495] postgres[1543]: vm-test-run-timescaledb> server # [ 124.374897] postgres[1543]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.375478] postgres[1543]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.377488] postgres[1543]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.378563] postgres[1543]: vm-test-run-timescaledb> server # [ 124.378870] postgres[1543]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 124.379731] postgres[1543]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 124.381133] postgres[1543]: "operationName" text default null, vm-test-run-timescaledb> server # [ 124.382722] postgres[1543]: query text default null, vm-test-run-timescaledb> server # [ 124.384638] postgres[1543]: variables jsonb default null, vm-test-run-timescaledb> server # [ 124.386362] postgres[1543]: extensions jsonb default null vm-test-run-timescaledb> server # [ 124.387627] postgres[1543]: ) vm-test-run-timescaledb> server # [ 124.390818] postgres[1543]: returns jsonb vm-test-run-timescaledb> server # [ 124.392915] postgres[1543]: language sql vm-test-run-timescaledb> server # [ 124.394199] postgres[1543]: as $$ vm-test-run-timescaledb> server # [ 124.394973] postgres[1543]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-timescaledb> server # [ 124.396845] postgres[1543]: $$; vm-test-run-timescaledb> server # [ 124.397518] postgres[1543]: vm-test-run-timescaledb> server # [ 124.398215] postgres[1543]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.398765] postgres[1543]: END IF; vm-test-run-timescaledb> server # [ 124.399160] postgres[1543]: vm-test-run-timescaledb> server # [ 124.399702] postgres[1543]: END; vm-test-run-timescaledb> server # [ 124.399940] postgres[1543]: $func$; vm-test-run-timescaledb> server # [ 124.401666] postgres[1543]: ::1 2026-10-10 11:25:53.804 UTC [1543] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-timescaledb> server # [ 124.403070] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 124.404096] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: psql:/nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping vm-test-run-timescaledb> server # [ 124.411314] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 124.413365] postgres[1543]: ::1 2026-10-10 11:25:53.814 UTC [1543] 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 # [ 124.414878] postgres[1543]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-timescaledb> server # [ 124.420119] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 124.421664] postgres[1543]: ::1 2026-10-10 11:25:53.826 UTC [1543] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-timescaledb> server # [ 124.434321] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: COMMENT vm-test-run-timescaledb> server # [ 124.435872] postgres[1543]: ::1 2026-10-10 11:25:53.838 UTC [1543] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 124.437529] postgres[1543]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 124.438246] postgres[1543]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 124.438647] postgres[1543]: AS $func$ vm-test-run-timescaledb> server # [ 124.438923] postgres[1543]: DECLARE vm-test-run-timescaledb> server # [ 124.439459] postgres[1543]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 124.440328] postgres[1543]: BEGIN vm-test-run-timescaledb> server # [ 124.451984] postgres[1543]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 124.454953] postgres[1543]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 124.455542] postgres[1543]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 124.456082] postgres[1543]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 124.464861] postgres[1543]: ); vm-test-run-timescaledb> server # [ 124.465484] postgres[1543]: vm-test-run-timescaledb> server # [ 124.466044] postgres[1543]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 124.466486] postgres[1543]: THEN vm-test-run-timescaledb> server # [ 124.467293] postgres[1543]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 124.467989] postgres[1543]: "operationName" text default null, vm-test-run-timescaledb> server # [ 124.483262] postgres[1543]: query text default null, vm-test-run-timescaledb> server # [ 124.487421] postgres[1543]: variables jsonb default null, vm-test-run-timescaledb> server # [ 124.488011] postgres[1543]: extensions jsonb default null vm-test-run-timescaledb> server # [ 124.492561] postgres[1543]: ) vm-test-run-timescaledb> server # [ 124.503717] postgres[1543]: returns jsonb vm-test-run-timescaledb> server # [ 124.504931] postgres[1543]: language plpgsql vm-test-run-timescaledb> server # [ 124.505297] postgres[1543]: as $$ vm-test-run-timescaledb> server # [ 124.505567] postgres[1543]: DECLARE vm-test-run-timescaledb> server # [ 124.506302] postgres[1543]: server_version float; vm-test-run-timescaledb> server # [ 124.506708] postgres[1543]: BEGIN vm-test-run-timescaledb> server # [ 124.518309] postgres[1543]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 124.520397] postgres[1543]: vm-test-run-timescaledb> server # [ 124.524133] postgres[1543]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 124.529279] postgres[1543]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 124.531633] postgres[1543]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 124.555243] postgres[1543]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 124.558102] postgres[1543]: ); vm-test-run-timescaledb> server # [ 124.559819] postgres[1543]: ELSE vm-test-run-timescaledb> server # [ 124.571886] postgres[1543]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 124.581315] postgres[1543]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 124.582080] postgres[1543]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 124.583011] postgres[1543]: ); vm-test-run-timescaledb> server # [ 124.584547] postgres[1543]: END IF; vm-test-run-timescaledb> server # [ 124.590955] postgres[1543]: END; vm-test-run-timescaledb> server # [ 124.591476] postgres[1543]: $$; vm-test-run-timescaledb> server # [ 124.592195] postgres[1543]: END IF; vm-test-run-timescaledb> server # [ 124.602853] postgres[1543]: vm-test-run-timescaledb> server # [ 124.606388] postgres[1543]: END; vm-test-run-timescaledb> server # [ 124.607431] postgres[1543]: $func$; vm-test-run-timescaledb> server # [ 124.621207] postgres[1543]: ::1 2026-10-10 11:25:53.874 UTC [1543] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-timescaledb> server # [ 124.624102] postgres[1543]: ::1 2026-10-10 11:25:53.880 UTC [1543] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-timescaledb> server # [ 124.625581] postgres[1543]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-timescaledb> server # [ 124.627561] postgres[1543]: ::1 2026-10-10 11:25:53.889 UTC [1543] 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 # [ 124.635439] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 124.637291] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: psql:/nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping vm-test-run-timescaledb> server # [ 124.639495] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 124.643129] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 124.644978] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1542]: COMMENT vm-test-run-timescaledb> server # [ 124.656841] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-timescaledb> server # [ 125.038564] postgres[1554]: ::1 2026-10-10 11:25:54.412 UTC [1554] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 125.046468] postgres[1554]: ::1 2026-10-10 11:25:54.441 UTC [1554] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 125.086189] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1544]: psql:/nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-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 # [ 125.091518] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1544]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 125.101491] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1544]: psql:/nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-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 # [ 125.103393] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1544]: DROP FUNCTION vm-test-run-timescaledb> server # [ 125.103889] postgres[1554]: ::1 2026-10-10 11:25:54.501 UTC [1554] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 125.110192] postgres[1554]: DECLARE vm-test-run-timescaledb> server # [ 125.110960] postgres[1554]: cmd record; vm-test-run-timescaledb> server # [ 125.117506] postgres[1554]: BEGIN vm-test-run-timescaledb> server # [ 125.119204] postgres[1554]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 125.125667] postgres[1554]: LOOP vm-test-run-timescaledb> server # [ 125.126924] postgres[1554]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 125.127472] postgres[1554]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 125.134618] postgres[1554]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 125.135969] postgres[1554]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 125.141267] postgres[1554]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 125.142322] postgres[1554]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 125.143297] postgres[1554]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 125.150892] postgres[1554]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 125.151868] postgres[1554]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-timescaledb> server # [ 125.156609] postgres[1554]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 125.157285] postgres[1554]: , 'COMMENT' vm-test-run-timescaledb> server # [ 125.158067] postgres[1554]: ) vm-test-run-timescaledb> server # [ 125.158331] postgres[1554]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 125.159013] postgres[1554]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 125.166444] postgres[1554]: THEN vm-test-run-timescaledb> server # [ 125.167468] postgres[1554]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 125.167851] postgres[1554]: END IF; vm-test-run-timescaledb> server # [ 125.168113] postgres[1554]: END LOOP; vm-test-run-timescaledb> server # [ 125.174055] postgres[1554]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 125.201917] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1544]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 125.203037] postgres[1554]: ::1 2026-10-10 11:25:54.605 UTC [1554] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 125.203574] postgres[1554]: DECLARE vm-test-run-timescaledb> server # [ 125.203898] postgres[1554]: obj record; vm-test-run-timescaledb> server # [ 125.204160] postgres[1554]: BEGIN vm-test-run-timescaledb> server # [ 125.205269] postgres[1554]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 125.206312] postgres[1554]: LOOP vm-test-run-timescaledb> server # [ 125.206656] postgres[1554]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 125.207209] postgres[1554]: 'schema' vm-test-run-timescaledb> server # [ 125.207943] postgres[1554]: , 'table' vm-test-run-timescaledb> server # [ 125.215562] postgres[1554]: , 'foreign table' vm-test-run-timescaledb> server # [ 125.220136] postgres[1554]: , 'view' vm-test-run-timescaledb> server # [ 125.221159] postgres[1554]: , 'materialized view' vm-test-run-timescaledb> server # [ 125.221631] postgres[1554]: , 'function' vm-test-run-timescaledb> server # [ 125.222310] postgres[1554]: , 'trigger' vm-test-run-timescaledb> server # [ 125.222842] postgres[1554]: , 'type' vm-test-run-timescaledb> server # [ 125.223286] postgres[1554]: , 'rule' vm-test-run-timescaledb> server # [ 125.223705] postgres[1554]: ) vm-test-run-timescaledb> server # [ 125.224004] postgres[1554]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 125.231247] postgres[1554]: THEN vm-test-run-timescaledb> server # [ 125.231740] postgres[1554]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 125.232058] postgres[1554]: END IF; vm-test-run-timescaledb> server # [ 125.241388] postgres[1554]: END LOOP; vm-test-run-timescaledb> server # [ 125.242922] postgres[1554]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 125.243406] postgres[1554]: ::1 2026-10-10 11:25:54.637 UTC [1554] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 125.243911] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1544]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 125.244455] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1544]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 125.254059] postgres[1554]: ::1 2026-10-10 11:25:54.650 UTC [1554] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 125.259934] postgres[1554]: ON ddl_command_end vm-test-run-timescaledb> server # [ 125.265081] postgres[1554]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 125.277279] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1544]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 125.280192] postgres[1554]: ::1 2026-10-10 11:25:54.680 UTC [1554] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 125.296577] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1544]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 125.297798] postgres[1554]: ::1 2026-10-10 11:25:54.700 UTC [1554] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 125.298941] postgres[1554]: ON sql_drop vm-test-run-timescaledb> server # [ 125.300350] postgres[1554]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 125.324467] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1544]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 125.374064] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-timescaledb> server # [ 125.751357] postgres[1568]: ::1 2026-10-10 11:25:55.144 UTC [1568] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-timescaledb> server # [ 125.788044] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1561]: ALTER ROLE vm-test-run-timescaledb> server # [ 125.830291] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-timescaledb> server # [ 126.139681] postgres[1573]: ::1 2026-10-10 11:25:55.527 UTC [1573] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 126.149811] postgres[1573]: returns event_trigger vm-test-run-timescaledb> server # [ 126.151016] postgres[1573]: language plpgsql vm-test-run-timescaledb> server # [ 126.151431] postgres[1573]: AS $func$ vm-test-run-timescaledb> server # [ 126.151701] postgres[1573]: DECLARE vm-test-run-timescaledb> server # [ 126.166661] postgres[1573]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 126.167207] postgres[1573]: BEGIN vm-test-run-timescaledb> server # [ 126.172922] postgres[1573]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 126.174783] postgres[1573]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 126.175348] postgres[1573]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 126.181906] postgres[1573]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 126.183254] postgres[1573]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 126.183767] postgres[1573]: ); vm-test-run-timescaledb> server # [ 126.184499] postgres[1573]: vm-test-run-timescaledb> server # [ 126.191677] postgres[1573]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 126.198565] postgres[1573]: THEN vm-test-run-timescaledb> server # [ 126.199059] postgres[1573]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.199966] postgres[1573]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.207137] postgres[1573]: vm-test-run-timescaledb> server # [ 126.207958] postgres[1573]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.210691] postgres[1573]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.211437] postgres[1573]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.216706] postgres[1573]: vm-test-run-timescaledb> server # [ 126.217364] postgres[1573]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 126.218802] postgres[1573]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 126.220327] postgres[1573]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 126.227995] postgres[1573]: "operationName" text default null, vm-test-run-timescaledb> server # [ 126.234269] postgres[1573]: query text default null, vm-test-run-timescaledb> server # [ 126.234722] postgres[1573]: variables jsonb default null, vm-test-run-timescaledb> server # [ 126.235248] postgres[1573]: extensions jsonb default null vm-test-run-timescaledb> server # [ 126.235906] postgres[1573]: ) vm-test-run-timescaledb> server # [ 126.238422] postgres[1573]: returns jsonb vm-test-run-timescaledb> server # [ 126.246135] postgres[1573]: language sql vm-test-run-timescaledb> server # [ 126.246645] postgres[1573]: as $$ vm-test-run-timescaledb> server # [ 126.247102] postgres[1573]: -- This changed vm-test-run-timescaledb> server # [ 126.247972] postgres[1573]: select graphql.resolve( vm-test-run-timescaledb> server # [ 126.249394] postgres[1573]: query := query, vm-test-run-timescaledb> server # [ 126.250029] postgres[1573]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 126.251040] postgres[1573]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 126.251500] postgres[1573]: extensions := extensions vm-test-run-timescaledb> server # [ 126.251806] postgres[1573]: ); vm-test-run-timescaledb> server # [ 126.252381] postgres[1573]: $$; vm-test-run-timescaledb> server # [ 126.261274] postgres[1573]: vm-test-run-timescaledb> server # [ 126.262520] postgres[1573]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.263416] postgres[1573]: END IF; vm-test-run-timescaledb> server # [ 126.263678] postgres[1573]: vm-test-run-timescaledb> server # [ 126.263904] postgres[1573]: END; vm-test-run-timescaledb> server # [ 126.265633] postgres[1573]: $func$; vm-test-run-timescaledb> server # [ 126.267612] postgres[1573]: ::1 2026-10-10 11:25:55.646 UTC [1573] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 126.269084] postgres[1573]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 126.269624] postgres[1573]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 126.270149] postgres[1573]: AS $func$ vm-test-run-timescaledb> server # [ 126.270459] postgres[1573]: DECLARE vm-test-run-timescaledb> server # [ 126.270774] postgres[1573]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 126.271414] postgres[1573]: BEGIN vm-test-run-timescaledb> server # [ 126.271674] postgres[1573]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 126.271922] postgres[1573]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 126.272190] postgres[1573]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 126.273321] postgres[1573]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 126.274386] postgres[1573]: ); vm-test-run-timescaledb> server # [ 126.274856] postgres[1573]: vm-test-run-timescaledb> server # [ 126.275209] postgres[1573]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 126.275511] postgres[1573]: THEN vm-test-run-timescaledb> server # [ 126.276957] postgres[1573]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 126.277589] postgres[1573]: "operationName" text default null, vm-test-run-timescaledb> server # [ 126.277885] postgres[1573]: query text default null, vm-test-run-timescaledb> server # [ 126.279732] postgres[1573]: variables jsonb default null, vm-test-run-timescaledb> server # [ 126.280753] postgres[1573]: extensions jsonb default null vm-test-run-timescaledb> server # [ 126.281420] postgres[1573]: ) vm-test-run-timescaledb> server # [ 126.282577] postgres[1573]: returns jsonb vm-test-run-timescaledb> server # [ 126.283228] postgres[1573]: language plpgsql vm-test-run-timescaledb> server # [ 126.284773] postgres[1573]: as $$ vm-test-run-timescaledb> server # [ 126.285328] postgres[1573]: DECLARE vm-test-run-timescaledb> server # [ 126.285971] postgres[1573]: server_version float; vm-test-run-timescaledb> server # [ 126.286750] postgres[1573]: BEGIN vm-test-run-timescaledb> server # [ 126.287141] postgres[1573]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 126.288942] postgres[1573]: vm-test-run-timescaledb> server # [ 126.289579] postgres[1573]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 126.290155] postgres[1573]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 126.290416] postgres[1573]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 126.290664] postgres[1573]: jsonb_build_object( vm-test-run-timescaledb> server # [ 126.290896] postgres[1573]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 126.291142] postgres[1573]: ) vm-test-run-timescaledb> server # [ 126.291369] postgres[1573]: ) vm-test-run-timescaledb> server # [ 126.291584] postgres[1573]: ); vm-test-run-timescaledb> server # [ 126.291795] postgres[1573]: ELSE vm-test-run-timescaledb> server # [ 126.292342] postgres[1573]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 126.293814] postgres[1573]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 126.294619] postgres[1573]: jsonb_build_object( vm-test-run-timescaledb> server # [ 126.295087] postgres[1573]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 126.297439] postgres[1573]: ) vm-test-run-timescaledb> server # [ 126.298246] postgres[1573]: ) vm-test-run-timescaledb> server # [ 126.298996] postgres[1573]: ); vm-test-run-timescaledb> server # [ 126.299292] postgres[1573]: END IF; vm-test-run-timescaledb> server # [ 126.299737] postgres[1573]: END; vm-test-run-timescaledb> server # [ 126.301886] postgres[1573]: $$; vm-test-run-timescaledb> server # [ 126.303442] postgres[1573]: END IF; vm-test-run-timescaledb> server # [ 126.303783] postgres[1573]: vm-test-run-timescaledb> server # [ 126.304018] postgres[1573]: END; vm-test-run-timescaledb> server # [ 126.304232] postgres[1573]: $func$; vm-test-run-timescaledb> server # [ 126.308010] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1572]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.309929] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1572]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.310526] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1572]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.311758] postgres[1573]: ::1 2026-10-10 11:25:55.683 UTC [1573] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 126.313280] postgres[1573]: "operationName" text default null, vm-test-run-timescaledb> server # [ 126.314030] postgres[1573]: query text default null, vm-test-run-timescaledb> server # [ 126.314743] postgres[1573]: variables jsonb default null, vm-test-run-timescaledb> server # [ 126.315341] postgres[1573]: extensions jsonb default null vm-test-run-timescaledb> server # [ 126.315814] postgres[1573]: ) vm-test-run-timescaledb> server # [ 126.316056] postgres[1573]: returns jsonb vm-test-run-timescaledb> server # [ 126.317006] postgres[1573]: language plpgsql vm-test-run-timescaledb> server # [ 126.317295] postgres[1573]: as $$ vm-test-run-timescaledb> server # [ 126.317529] postgres[1573]: DECLARE vm-test-run-timescaledb> server # [ 126.318108] postgres[1573]: server_version float; vm-test-run-timescaledb> server # [ 126.318661] postgres[1573]: BEGIN vm-test-run-timescaledb> server # [ 126.318932] postgres[1573]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 126.319341] postgres[1573]: vm-test-run-timescaledb> server # [ 126.319595] postgres[1573]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 126.324915] postgres[1573]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 126.326763] postgres[1573]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 126.327463] postgres[1573]: jsonb_build_object( vm-test-run-timescaledb> server # [ 126.330461] postgres[1573]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 126.331704] postgres[1573]: ) vm-test-run-timescaledb> server # [ 126.333295] postgres[1573]: ) vm-test-run-timescaledb> server # [ 126.334086] postgres[1573]: ); vm-test-run-timescaledb> server # [ 126.335834] postgres[1573]: ELSE vm-test-run-timescaledb> server # [ 126.336481] postgres[1573]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 126.338064] postgres[1573]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 126.338715] postgres[1573]: jsonb_build_object( vm-test-run-timescaledb> server # [ 126.339142] postgres[1573]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 126.341432] postgres[1573]: ) vm-test-run-timescaledb> server # [ 126.342263] postgres[1573]: ) vm-test-run-timescaledb> server # [ 126.343347] postgres[1573]: ); vm-test-run-timescaledb> server # [ 126.345084] postgres[1573]: END IF; vm-test-run-timescaledb> server # [ 126.346022] postgres[1573]: END; vm-test-run-timescaledb> server # [ 126.347847] postgres[1573]: $$; vm-test-run-timescaledb> server # [ 126.348460] postgres[1573]: ::1 2026-10-10 11:25:55.712 UTC [1573] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 126.351837] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1572]: psql:/nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping vm-test-run-timescaledb> server # [ 126.353395] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1572]: DROP EXTENSION vm-test-run-timescaledb> server # [ 127.681591] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1572]: DO vm-test-run-timescaledb> server # [ 127.714560] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql vm-test-run-timescaledb> server # [ 128.046088] postgres[1584]: ::1 2026-10-10 11:25:57.434 UTC [1584] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-timescaledb> server # [ 128.066518] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1579]: GRANT ROLE vm-test-run-timescaledb> server # [ 128.080294] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-timescaledb> server # [ 128.434862] postgres[1594]: ::1 2026-10-10 11:25:57.832 UTC [1594] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 128.435988] postgres[1594]: returns event_trigger vm-test-run-timescaledb> server # [ 128.447232] postgres[1594]: language plpgsql vm-test-run-timescaledb> server # [ 128.451463] postgres[1594]: AS $func$ vm-test-run-timescaledb> server # [ 128.453833] postgres[1594]: DECLARE vm-test-run-timescaledb> server # [ 128.457321] postgres[1594]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 128.458185] postgres[1594]: BEGIN vm-test-run-timescaledb> server # [ 128.458646] postgres[1594]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 128.469342] postgres[1594]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 128.470253] postgres[1594]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 128.470658] postgres[1594]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 128.471756] postgres[1594]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 128.472204] postgres[1594]: ); vm-test-run-timescaledb> server # [ 128.481160] postgres[1594]: vm-test-run-timescaledb> server # [ 128.481577] postgres[1594]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 128.482103] postgres[1594]: THEN vm-test-run-timescaledb> server # [ 128.482397] postgres[1594]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 128.483414] postgres[1594]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 128.483836] postgres[1594]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 128.493081] postgres[1594]: "operationName" text default null, vm-test-run-timescaledb> server # [ 128.494004] postgres[1594]: query text default null, vm-test-run-timescaledb> server # [ 128.494646] postgres[1594]: variables jsonb default null, vm-test-run-timescaledb> server # [ 128.495302] postgres[1594]: extensions jsonb default null vm-test-run-timescaledb> server # [ 128.501460] postgres[1594]: ) vm-test-run-timescaledb> server # [ 128.502288] postgres[1594]: returns jsonb vm-test-run-timescaledb> server # [ 128.503105] postgres[1594]: language sql vm-test-run-timescaledb> server # [ 128.503655] postgres[1594]: as $$ vm-test-run-timescaledb> server # [ 128.504103] postgres[1594]: select graphql.resolve( vm-test-run-timescaledb> server # [ 128.512512] postgres[1594]: query := query, vm-test-run-timescaledb> server # [ 128.513630] postgres[1594]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 128.514398] postgres[1594]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 128.514716] postgres[1594]: extensions := extensions vm-test-run-timescaledb> server # [ 128.514987] postgres[1594]: ); vm-test-run-timescaledb> server # [ 128.515247] postgres[1594]: $$; vm-test-run-timescaledb> server # [ 128.515697] postgres[1594]: vm-test-run-timescaledb> server # [ 128.516461] postgres[1594]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 128.525950] postgres[1594]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 128.532824] postgres[1594]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 128.534593] postgres[1594]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 128.540951] postgres[1594]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 128.542098] postgres[1594]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 128.543560] postgres[1594]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 128.549537] postgres[1594]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 128.558798] postgres[1594]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 128.569125] postgres[1594]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 128.570660] postgres[1594]: END IF; vm-test-run-timescaledb> server # [ 128.571228] postgres[1594]: vm-test-run-timescaledb> server # [ 128.571919] postgres[1594]: END; vm-test-run-timescaledb> server # [ 128.572171] postgres[1594]: $func$; vm-test-run-timescaledb> server # [ 128.593483] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1589]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 128.605418] postgres[1594]: ::1 2026-10-10 11:25:57.985 UTC [1594] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 128.675049] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1589]: DROP EXTENSION vm-test-run-timescaledb> server # [ 129.986459] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1589]: DO vm-test-run-timescaledb> server # [ 130.015671] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-timescaledb> server # [ 131.076536] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1606]: DO vm-test-run-timescaledb> server # [ 131.746671] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1606]: DO vm-test-run-timescaledb> server # [ 131.793211] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-timescaledb> server # [ 132.138425] postgres[1633]: ::1 2026-10-10 11:26:01.524 UTC [1633] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 132.197284] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1632]: ALTER ROLE vm-test-run-timescaledb> server # [ 132.198481] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-timescaledb> server # [ 132.471318] postgres[1639]: ::1 2026-10-10 11:26:01.865 UTC [1639] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-timescaledb> server # [ 132.486797] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1637]: REVOKE ROLE vm-test-run-timescaledb> server # [ 132.525481] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-timescaledb> server # [ 134.698774] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1640]: DO vm-test-run-timescaledb> server # [ 134.739145] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 135.098944] postgres[1667]: ::1 2026-10-10 11:26:04.492 UTC [1667] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-timescaledb> server # [ 135.118764] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1664]: GRANT ROLE vm-test-run-timescaledb> server # [ 135.152775] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-timescaledb> server # [ 135.407216] postgres[1669]: ::1 2026-10-10 11:26:04.804 UTC [1669] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 135.435741] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1668]: GRANT vm-test-run-timescaledb> server # [ 135.447489] postgres[1669]: ::1 2026-10-10 11:26:04.840 UTC [1669] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 135.468160] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1668]: GRANT vm-test-run-timescaledb> server # [ 135.470432] postgres[1669]: ::1 2026-10-10 11:26:04.876 UTC [1669] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 135.478118] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1668]: GRANT vm-test-run-timescaledb> server # [ 135.479494] postgres[1669]: ::1 2026-10-10 11:26:04.884 UTC [1669] 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 # [ 135.489306] postgres[1669]: ::1 2026-10-10 11:26:04.893 UTC [1669] 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 # [ 135.490374] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1668]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.500765] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1668]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.503100] postgres[1669]: ::1 2026-10-10 11:26:04.905 UTC [1669] 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 # [ 135.510063] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1668]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.548084] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-timescaledb> server # [ 135.883424] postgres[1675]: ::1 2026-10-10 11:26:05.284 UTC [1675] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-timescaledb> server # [ 135.915091] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1670]: GRANT ROLE vm-test-run-timescaledb> server # [ 135.975820] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 136.230720] postgres[1677]: ::1 2026-10-10 11:26:05.628 UTC [1677] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-timescaledb> server # [ 136.258306] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1676]: GRANT ROLE vm-test-run-timescaledb> server # [ 136.285804] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-timescaledb> server # [ 136.506391] postgres[1679]: ::1 2026-10-10 11:26:05.908 UTC [1679] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-timescaledb> server # [ 136.518203] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1678]: ALTER ROLE vm-test-run-timescaledb> server # [ 136.521255] postgres[1679]: ::1 2026-10-10 11:26:05.921 UTC [1679] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-timescaledb> server # [ 136.527877] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1678]: ALTER ROLE vm-test-run-timescaledb> server # [ 136.529511] postgres[1679]: ::1 2026-10-10 11:26:05.935 UTC [1679] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-timescaledb> server # [ 136.534720] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1678]: ALTER ROLE vm-test-run-timescaledb> server # [ 136.559297] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1678]: DO vm-test-run-timescaledb> server # [ 136.605797] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 136.910651] postgres[1684]: ::1 2026-10-10 11:26:06.298 UTC [1684] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-timescaledb> server # [ 136.942265] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1680]: GRANT ROLE vm-test-run-timescaledb> server # [ 136.943387] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1680]: REVOKE ROLE vm-test-run-timescaledb> server # [ 136.948864] postgres[1684]: ::1 2026-10-10 11:26:06.331 UTC [1684] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-timescaledb> server # [ 136.991632] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-timescaledb> server # [ 137.307927] postgres[1695]: ::1 2026-10-10 11:26:06.701 UTC [1695] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 137.318013] postgres[1695]: returns event_trigger vm-test-run-timescaledb> server # [ 137.319879] postgres[1695]: language plpgsql vm-test-run-timescaledb> server # [ 137.333917] postgres[1695]: AS $func$ vm-test-run-timescaledb> server # [ 137.335335] postgres[1695]: DECLARE vm-test-run-timescaledb> server # [ 137.336005] postgres[1695]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 137.339644] postgres[1695]: BEGIN vm-test-run-timescaledb> server # [ 137.347230] postgres[1695]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 137.358245] postgres[1695]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 137.361086] postgres[1695]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 137.362419] postgres[1695]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 137.363272] postgres[1695]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 137.369409] postgres[1695]: ); vm-test-run-timescaledb> server # [ 137.370508] postgres[1695]: vm-test-run-timescaledb> server # [ 137.370882] postgres[1695]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 137.371143] postgres[1695]: THEN vm-test-run-timescaledb> server # [ 137.371692] postgres[1695]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 137.381143] postgres[1695]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 137.384067] postgres[1695]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 137.388859] postgres[1695]: "operationName" text default null, vm-test-run-timescaledb> server # [ 137.396944] postgres[1695]: query text default null, vm-test-run-timescaledb> server # [ 137.398251] postgres[1695]: variables jsonb default null, vm-test-run-timescaledb> server # [ 137.398692] postgres[1695]: extensions jsonb default null vm-test-run-timescaledb> server # [ 137.399510] postgres[1695]: ) vm-test-run-timescaledb> server # [ 137.400041] postgres[1695]: returns jsonb vm-test-run-timescaledb> server # [ 137.407112] postgres[1695]: language sql vm-test-run-timescaledb> server # [ 137.410313] postgres[1695]: as $$ vm-test-run-timescaledb> server # [ 137.411880] postgres[1695]: select graphql.resolve( vm-test-run-timescaledb> server # [ 137.420855] postgres[1695]: query := query, vm-test-run-timescaledb> server # [ 137.422343] postgres[1695]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 137.422946] postgres[1695]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 137.431366] postgres[1695]: extensions := extensions vm-test-run-timescaledb> server # [ 137.438287] postgres[1695]: ); vm-test-run-timescaledb> server # [ 137.438881] postgres[1695]: $$; vm-test-run-timescaledb> server # [ 137.439429] postgres[1695]: vm-test-run-timescaledb> server # [ 137.439833] postgres[1695]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 137.440195] postgres[1695]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 137.455910] postgres[1695]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 137.461541] postgres[1695]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.474349] postgres[1695]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.475491] postgres[1695]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.476110] postgres[1695]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.476633] postgres[1695]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.483049] postgres[1695]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.484192] postgres[1695]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.495190] postgres[1695]: vm-test-run-timescaledb> server # [ 137.495809] postgres[1695]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-timescaledb> server # [ 137.497801] postgres[1695]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-timescaledb> server # [ 137.498528] postgres[1695]: grant usage on schema graphql to postgres with grant option; vm-test-run-timescaledb> server # [ 137.504967] postgres[1695]: END IF; vm-test-run-timescaledb> server # [ 137.505577] postgres[1695]: vm-test-run-timescaledb> server # [ 137.506033] postgres[1695]: END; vm-test-run-timescaledb> server # [ 137.506558] postgres[1695]: $func$; vm-test-run-timescaledb> server # [ 137.507520] postgres[1695]: ::1 2026-10-10 11:26:06.906 UTC [1695] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 137.515489] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1689]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 137.633093] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1689]: DROP EXTENSION vm-test-run-timescaledb> server # [ 138.867848] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1689]: DO vm-test-run-timescaledb> server # [ 138.914668] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-timescaledb> server # [ 139.113931] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1708]: DO vm-test-run-timescaledb> server # [ 139.118508] postgres[1709]: ::1 2026-10-10 11:26:08.517 UTC [1709] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-timescaledb> server # [ 139.122416] postgres[1709]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 139.123922] postgres[1709]: AS $$ vm-test-run-timescaledb> server # [ 139.124957] postgres[1709]: BEGIN vm-test-run-timescaledb> server # [ 139.125618] postgres[1709]: IF EXISTS ( vm-test-run-timescaledb> server # [ 139.126635] postgres[1709]: SELECT vm-test-run-timescaledb> server # [ 139.127209] postgres[1709]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 139.128499] postgres[1709]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 139.129474] postgres[1709]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 139.130221] postgres[1709]: WHERE ext.extname = 'pg_cron' vm-test-run-timescaledb> server # [ 139.130716] postgres[1709]: ) vm-test-run-timescaledb> server # [ 139.130987] postgres[1709]: THEN vm-test-run-timescaledb> server # [ 139.131581] postgres[1709]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 139.132699] postgres[1709]: vm-test-run-timescaledb> server # [ 139.138896] postgres[1709]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 139.140232] postgres[1709]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 139.149485] postgres[1709]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 139.150329] postgres[1709]: vm-test-run-timescaledb> server # [ 139.150847] postgres[1709]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 139.151161] postgres[1709]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 139.151429] postgres[1709]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 139.151704] postgres[1709]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 139.154842] postgres[1709]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 139.155488] postgres[1709]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 139.155802] postgres[1709]: vm-test-run-timescaledb> server # [ 139.156018] postgres[1709]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 139.157146] postgres[1709]: revoke all on table cron.job from postgres; vm-test-run-timescaledb> server # [ 139.158773] postgres[1709]: grant select on table cron.job to postgres with grant option; vm-test-run-timescaledb> server # [ 139.159507] postgres[1709]: END IF; vm-test-run-timescaledb> server # [ 139.160114] postgres[1709]: END; vm-test-run-timescaledb> server # [ 139.161271] postgres[1709]: $$; vm-test-run-timescaledb> server # [ 139.166299] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1708]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 139.167102] postgres[1709]: ::1 2026-10-10 11:26:08.573 UTC [1709] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-timescaledb> server # [ 139.177413] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1708]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 139.185104] postgres[1709]: ::1 2026-10-10 11:26:08.589 UTC [1709] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-timescaledb> server # [ 139.202262] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1708]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 139.213374] postgres[1709]: ::1 2026-10-10 11:26:08.609 UTC [1709] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-timescaledb> server # [ 139.214959] postgres[1709]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-timescaledb> server # [ 139.215666] postgres[1709]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 139.223005] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1708]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 139.274548] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-timescaledb> server # [ 139.573039] postgres[1715]: ::1 2026-10-10 11:26:08.965 UTC [1715] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-timescaledb> server # [ 139.589069] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1713]: ALTER ROLE vm-test-run-timescaledb> server # [ 139.629766] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-timescaledb> server # [ 139.954448] postgres[1720]: ::1 2026-10-10 11:26:09.343 UTC [1720] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-timescaledb> server # [ 140.012848] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1717]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 140.025477] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1717]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 140.026512] postgres[1720]: ::1 2026-10-10 11:26:09.411 UTC [1720] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-timescaledb> server # [ 140.027576] postgres[1720]: ::1 2026-10-10 11:26:09.427 UTC [1720] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-timescaledb> server # [ 140.043592] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1717]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 140.092406] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 140.447482] postgres[1729]: ::1 2026-10-10 11:26:09.838 UTC [1729] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-timescaledb> server # [ 140.538848] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1725]: GRANT ROLE vm-test-run-timescaledb> server # [ 140.546586] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-timescaledb> server # [ 141.561162] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1737]: DO vm-test-run-timescaledb> server # [ 141.583012] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-timescaledb> server # [ 141.909796] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1746]: DO vm-test-run-timescaledb> server # [ 141.919358] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1746]: DO vm-test-run-timescaledb> server # [ 141.957372] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-timescaledb> server # [ 142.168134] postgres[1749]: ::1 2026-10-10 11:26:11.555 UTC [1749] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-timescaledb> server # [ 142.170600] postgres[1749]: ::1 2026-10-10 11:26:11.574 UTC [1749] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-timescaledb> server # [ 142.176668] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1748]: ALTER ROLE vm-test-run-timescaledb> server # [ 142.177430] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1748]: ALTER ROLE vm-test-run-timescaledb> server # [ 142.178255] postgres[1749]: ::1 2026-10-10 11:26:11.583 UTC [1749] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-timescaledb> server # [ 142.194663] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1748]: ALTER ROLE vm-test-run-timescaledb> server # [ 142.215701] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-timescaledb> server # [ 142.459022] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1750]: DO vm-test-run-timescaledb> server # [ 142.475065] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-timescaledb> server # [ 142.735116] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1752]: DO vm-test-run-timescaledb> server # [ 142.751702] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-timescaledb> server # [ 143.201467] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1754]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 143.209953] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1754]: DO vm-test-run-timescaledb> server # [ 143.258122] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-timescaledb> server # [ 143.599064] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1766]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 143.614991] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1766]: GRANT vm-test-run-timescaledb> server # [ 143.650847] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-timescaledb> server # [ 144.063944] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1772]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 144.098410] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1772]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 144.114838] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1772]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 144.162074] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 144.429379] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1783]: DO vm-test-run-timescaledb> server # [ 144.449405] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-timescaledb> server # [ 144.848330] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1786]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 144.858403] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1786]: GRANT vm-test-run-timescaledb> server # [ 144.892553] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-timescaledb> server # [ 145.203225] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1792]: REVOKE ROLE vm-test-run-timescaledb> server # [ 145.258864] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1792]: DO vm-test-run-timescaledb> server # [ 145.274011] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1792]: DO vm-test-run-timescaledb> server # [ 145.278168] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1792]: REVOKE ROLE vm-test-run-timescaledb> server # [ 145.292787] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1792]: REVOKE vm-test-run-timescaledb> server # [ 145.324106] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1792]: DO vm-test-run-timescaledb> server # [ 145.356736] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 145.608847] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1794]: DO vm-test-run-timescaledb> server # [ 145.625562] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 145.882953] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1796]: DO vm-test-run-timescaledb> server # [ 145.926958] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 146.431152] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1798]: DO vm-test-run-timescaledb> server # [ 146.466937] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-timescaledb> server # [ 146.783830] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1813]: ALTER ROLE vm-test-run-timescaledb> server # [ 146.829249] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-timescaledb> server # [ 147.171495] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1820]: GRANT ROLE vm-test-run-timescaledb> server # [ 147.184204] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1820]: DO vm-test-run-timescaledb> server # [ 147.216995] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-timescaledb> server # [ 147.461729] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1828]: GRANT vm-test-run-timescaledb> server # [ 147.486279] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-timescaledb> server # [ 147.751548] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1830]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 147.757098] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1830]: REVOKE vm-test-run-timescaledb> server # [ 147.766941] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1830]: REVOKE vm-test-run-timescaledb> server # [ 147.777126] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1830]: GRANT vm-test-run-timescaledb> server # [ 147.816942] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-timescaledb> server # [ 148.156017] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1832]: DO vm-test-run-timescaledb> server # [ 148.184971] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-timescaledb> server # [ 148.502339] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1837]: ALTER ROLE vm-test-run-timescaledb> server # [ 148.555833] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-timescaledb> server # [ 148.923991] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1840]: DROP EXTENSION vm-test-run-timescaledb> server # [ 148.938653] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-timescaledb> server # [ 149.315167] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1842]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 149.321543] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1842]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 149.337533] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1842]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 149.369189] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-timescaledb> server # [ 149.709769] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1853]: DO vm-test-run-timescaledb> server # [ 149.725963] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1853]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 149.766541] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-timescaledb> server # [ 150.319721] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1863]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 150.326358] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1863]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 150.363636] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running migration: /nix/store/pbzqnvpkaiys24xhjss4f48vx7nldmb5-migrations-db/migrations/20261010094800_postgres-role-safeupdate.sql vm-test-run-timescaledb> server # [ 150.687157] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1872]: ALTER ROLE vm-test-run-timescaledb> server # [ 150.698210] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1872]: ALTER ROLE vm-test-run-timescaledb> server # [ 150.733129] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Running postgresql schema... vm-test-run-timescaledb> server # [ 151.012864] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER DATABASE vm-test-run-timescaledb> server # [ 151.014555] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER DATABASE vm-test-run-timescaledb> server # [ 151.113230] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.180085] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.241650] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.310020] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.380897] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.456286] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.519646] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.603238] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.695361] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.707320] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1874]: ALTER ROLE vm-test-run-timescaledb> server # [ 151.767746] yn37m7g6y2s2qwvvrb3pbns5l1qwx88x-supabase-db-init[1369]: Database initialization complete vm-test-run-timescaledb> server # [ 151.806101] systemd[1]: Finished Supabase Database Initialization. vm-test-run-timescaledb> server # [ 151.817105] systemd[1]: Reached target Multi-User System. vm-test-run-timescaledb> server # [ 151.818932] systemd[1]: Startup finished in 20.806s (kernel) + 2min 11.004s (userspace) = 2min 31.810s. vm-test-run-timescaledb> server: (finished: waiting for unit supabase-db-init.service, in 153.24 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 # [ 152.779204] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT version();", in 0.60 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.54 seconds) vm-test-run-timescaledb> (finished: subtest: Verify PostgreSQL 15 is our custom build, in 1.14 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.50 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.40 seconds) vm-test-run-timescaledb> (finished: subtest: Verify ansible config loaded, in 0.90 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.45 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.47 seconds) vm-test-run-timescaledb> (finished: subtest: Verify init scripts and migrations ran, in 0.92 seconds) vm-test-run-timescaledb> subtest: Check upgrade path with postgresql 15 vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" vm-test-run-timescaledb> server # NOTICE: extension "timescaledb" does not exist, skipping vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" , in 0.62 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 # [ 160.232387] systemd[1]: Starting Virtual Console Setup... vm-test-run-timescaledb> server # [ 160.513811] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 160.523259] systemd[1]: Stopped Virtual Console Setup. vm-test-run-timescaledb> server # [ 160.553282] 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 # [ 161.761774] postgres[1949]: [local] 2026-10-10 11:26:31.158 UTC [1949] supabase_admin@postgres WARNING: vm-test-run-timescaledb> server # [ 161.771059] postgres[1949]: WELCOME TO vm-test-run-timescaledb> server # [ 161.772162] postgres[1949]: _____ _ _ ____________ vm-test-run-timescaledb> server # [ 161.778474] postgres[1949]: |_ _(_) | | | _ \ ___ \ vm-test-run-timescaledb> server # [ 161.783186] postgres[1949]: | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ / vm-test-run-timescaledb> server # [ 161.783866] postgres[1949]: | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \ vm-test-run-timescaledb> server # [ 161.810215] postgres[1949]: | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ / vm-test-run-timescaledb> server # [ 161.825001] postgres[1949]: |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/ vm-test-run-timescaledb> server # [ 161.827268] postgres[1949]: Running version 2.9.1 vm-test-run-timescaledb> server # [ 161.833831] postgres[1949]: For more information on TimescaleDB, please visit the following links: vm-test-run-timescaledb> server # [ 161.841991] postgres[1949]: vm-test-run-timescaledb> server # [ 161.842533] postgres[1949]: 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started vm-test-run-timescaledb> server # [ 161.843653] postgres[1949]: 2. API reference documentation: https://docs.timescale.com/api/latest vm-test-run-timescaledb> server # [ 161.849669] postgres[1949]: 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts vm-test-run-timescaledb> server # [ 161.852091] postgres[1949]: vm-test-run-timescaledb> server # [ 161.852565] postgres[1949]: 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 # [ 161.857426] postgres[1949]: vm-test-run-timescaledb> server # [ 161.858555] postgres[1949]: [local] 2026-10-10 11:26:31.158 UTC [1949] supabase_admin@postgres CONTEXT: PL/pgSQL function inline_code_block line 16 at RAISE vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.9.1' CASCADE;" , in 6.27 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 # [ 162.531900] postgres[1999]: 2026-10-10 11:26:31.916 UTC [1999] LOG: job 2 threw an error vm-test-run-timescaledb> server # [ 162.543150] postgres[1999]: 2026-10-10 11:26:31.948 UTC [1999] ERROR: functionality not supported under the current "apache" license vm-test-run-timescaledb> server # [ 162.549420] postgres[1999]: 2026-10-10 11:26:31.948 UTC [1999] HINT: Upgrade your license to 'timescale' to use this free community feature. vm-test-run-timescaledb> server # [ 162.615774] postgres[1333]: 2026-10-10 11:26:32.003 UTC [1333] LOG: background worker "Error Log Retention Policy [2]" (PID 1999) 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.14 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 # [ 164.210942] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-timescaledb> server # [ 164.795322] postgres[1982]: 2026-10-10 11:26:34.185 UTC [1982] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 164.846450] postgres[1333]: 2026-10-10 11:26:34.232 UTC [1333] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 1982) exited with exit code 1 vm-test-run-timescaledb> server # [ 165.426044] systemd[1]: Finished Virtual Console Setup. vm-test-run-timescaledb> server # [ 167.803410] systemd-logind[648]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-timescaledb> server # [ 169.895151] postgres[2012]: 2026-10-10 11:26:39.292 UTC [2012] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 169.911545] postgres[1333]: 2026-10-10 11:26:39.314 UTC [1333] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2012) 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 7.04 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 # [ 170.401102] postgres[2041]: 2026-10-10 11:26:39.782 UTC [2041] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 170.411585] postgres[2041]: 2026-10-10 11:26:39.789 UTC [2041] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 170.414103] postgres[2041]: 2026-10-10 11:26:39.789 UTC [2041] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 170.416129] postgres[1333]: 2026-10-10 11:26:39.817 UTC [1333] LOG: background worker "Job History Log Retention Policy [3]" (PID 2041) 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.44 seconds) vm-test-run-timescaledb> (finished: subtest: Check upgrade path with postgresql 15, in 15.51 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 # [ 170.977536] postgres[2040]: 2026-10-10 11:26:40.370 UTC [2040] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 171.010464] postgres[1333]: 2026-10-10 11:26:40.397 UTC [1333] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2040) 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.89 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.24 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 # [ 175.018267] postgres[2059]: 2026-10-10 11:26:44.411 UTC [2059] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 175.020820] postgres[2059]: 2026-10-10 11:26:44.415 UTC [2059] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 175.022333] postgres[2059]: 2026-10-10 11:26:44.415 UTC [2059] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 175.055714] postgres[1333]: 2026-10-10 11:26:44.456 UTC [1333] LOG: background worker "Job History Log Retention Policy [3]" (PID 2059) 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.43 seconds) vm-test-run-timescaledb> (finished: subtest: Check the install of the last version of the extension, in 4.56 seconds) vm-test-run-timescaledb> (finished: run the VM test script, in 176.39 seconds) vm-test-run-timescaledb> test script finished in 176.71s vm-test-run-timescaledb> cleanup vm-test-run-timescaledb> kill machine (pid 9) vm-test-run-timescaledb> qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13) vm-test-run-timescaledb> vde_switch: EOF data port: Interrupted system call vm-test-run-timescaledb> kill vlan (pid 7) vm-test-run-timescaledb> vde_switch: (finished: cleanup, in 0.01 seconds) vm-test-run-timescaledb> Caught signal 15, cleaning up and exiting