these 2 derivations will be built: /nix/store/rhn0yxx71nchk0d26xl102pw55wm7ysj-nixos-test-driver-timescaledb.drv /nix/store/127bk96cp7cwpwb5pnyydkxaz1h43ymx-vm-test-run-timescaledb.drv building '/nix/store/rhn0yxx71nchk0d26xl102pw55wm7ysj-nixos-test-driver-timescaledb.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/rhn0yxx71nchk0d26xl102pw55wm7ysj-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/127bk96cp7cwpwb5pnyydkxaz1h43ymx-vm-test-run-timescaledb.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/127bk96cp7cwpwb5pnyydkxaz1h43ymx-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.jKAQrr6Xo7', 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: 6d193c1e-30d8-4dd7-bc5f-3bb8d9d88930 vm-test-run-timescaledb> server # Superblock backups stored on blocks: vm-test-run-timescaledb> server # 32768, 98304, 163840, 229376 vm-test-run-timescaledb> server # vm-test-run-timescaledb> server # Allocating group tables: 0/8 done vm-test-run-timescaledb> server # Writing inode tables: 0/8 done vm-test-run-timescaledb> server # Creating journal (8192 blocks): done vm-test-run-timescaledb> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-timescaledb> server # vm-test-run-timescaledb> server # Virtualisation disk image created. vm-test-run-timescaledb> server: QEMU running (pid 9) vm-test-run-timescaledb> (finished: start all VMs, in 0.14 seconds) vm-test-run-timescaledb> server: waiting for unit supabase-db-init.service vm-test-run-timescaledb> server: waiting for the VM to finish booting vm-test-run-timescaledb> server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510] vm-test-run-timescaledb> server # [ 0.000000] Linux version 6.12.63 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP Thu Dec 18 12:55:23 UTC 2025 vm-test-run-timescaledb> server # [ 0.000000] KASLR enabled vm-test-run-timescaledb> server # [ 0.000000] random: crng init done vm-test-run-timescaledb> server # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-timescaledb> server # [ 0.000000] efi: UEFI not found. vm-test-run-timescaledb> server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-timescaledb> server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f602200-0x13f60593f] vm-test-run-timescaledb> server # [ 0.000000] Zone ranges: vm-test-run-timescaledb> server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] vm-test-run-timescaledb> server # [ 0.000000] DMA32 empty vm-test-run-timescaledb> server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] Device empty vm-test-run-timescaledb> server # [ 0.000000] Movable zone start for each node vm-test-run-timescaledb> server # [ 0.000000] Early memory node ranges vm-test-run-timescaledb> server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -1 vm-test-run-timescaledb> server # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-timescaledb> server # [ 0.000000] psci: PSCIv1.1 detected in firmware. vm-test-run-timescaledb> server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-timescaledb> server # [ 0.000000] psci: Trusted OS migration not required vm-test-run-timescaledb> server # [ 0.000000] psci: SMC Calling Convention v1.0 vm-test-run-timescaledb> server # [ 0.000000] percpu: Embedded 88 pages/cpu s180056 r65536 d114856 u360448 vm-test-run-timescaledb> server # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: GIC system register CPU interface vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: HCRX_EL2 register vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2) vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-timescaledb> server # [ 0.000000] alternatives: applying boot alternatives vm-test-run-timescaledb> server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/0mlirx5mnz6rlss8w7c1w87cs35vdag0-nixos-system-server-test/init regInfo=/nix/store/icfkf9gv6a2mf8mjkicblxd9z0azrvd8-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-timescaledb> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/icfkf9gv6a2mf8mjkicblxd9z0azrvd8-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 @0x0000000100b10000 vm-test-run-timescaledb> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b20000 vm-test-run-timescaledb> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-timescaledb> server # [ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (virt). vm-test-run-timescaledb> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-timescaledb> server # [ 0.000030] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-timescaledb> server # [ 0.002667] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-timescaledb> server # [ 0.010653] Console: colour dummy device 80x25 vm-test-run-timescaledb> server # [ 0.011775] printk: legacy console [tty0] enabled vm-test-run-timescaledb> server # [ 0.016688] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-timescaledb> server # [ 0.016993] pid_max: default: 32768 minimum: 301 vm-test-run-timescaledb> server # [ 0.018547] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-timescaledb> server # [ 0.019743] landlock: Up and running. vm-test-run-timescaledb> server # [ 0.019778] Yama: becoming mindful. vm-test-run-timescaledb> server # [ 0.022091] LSM support for eBPF active vm-test-run-timescaledb> server # [ 0.024287] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.024375] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.048311] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-timescaledb> server # [ 0.057433] rcu: Hierarchical SRCU implementation. vm-test-run-timescaledb> server # [ 0.057503] rcu: Max phase no-delay instances is 1000. vm-test-run-timescaledb> server # [ 0.058501] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-timescaledb> server # [ 0.063349] fsl-mc MSI: its@8080000 domain created vm-test-run-timescaledb> server # [ 0.064848] EFI services will not be available. vm-test-run-timescaledb> server # [ 0.065950] smp: Bringing up secondary CPUs ... vm-test-run-timescaledb> server # [ 0.069960] Detected PIPT I-cache on CPU1 vm-test-run-timescaledb> server # [ 0.070880] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-timescaledb> server # [ 0.071408] GICv3: CPU1: using allocated LPI pending table @0x0000000100b30000 vm-test-run-timescaledb> server # [ 0.072620] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-timescaledb> server # [ 0.075381] smp: Brought up 1 node, 2 CPUs vm-test-run-timescaledb> server # [ 0.075491] SMP: Total of 2 processors activated. vm-test-run-timescaledb> server # [ 0.075526] CPU: All CPU(s) started at EL1 vm-test-run-timescaledb> server # [ 0.075653] CPU features: detected: Branch Target Identification vm-test-run-timescaledb> server # [ 0.075697] CPU features: detected: 32-bit EL0 Support vm-test-run-timescaledb> server # [ 0.075722] CPU features: detected: 32-bit EL1 Support vm-test-run-timescaledb> server # [ 0.075742] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-timescaledb> server # [ 0.075768] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-timescaledb> server # [ 0.075799] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-timescaledb> server # [ 0.075859] CPU features: detected: Common not Private translations vm-test-run-timescaledb> server # [ 0.075879] CPU features: detected: CRC32 instructions vm-test-run-timescaledb> server # [ 0.075897] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-timescaledb> server # [ 0.075918] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-timescaledb> server # [ 0.075936] CPU features: detected: Data independent timing control (DIT) vm-test-run-timescaledb> server # [ 0.075959] CPU features: detected: E0PD vm-test-run-timescaledb> server # [ 0.075977] CPU features: detected: Enhanced Counter Virtualization vm-test-run-timescaledb> server # [ 0.075996] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-timescaledb> server # [ 0.076017] CPU features: detected: Enhanced Privileged Access Never vm-test-run-timescaledb> server # [ 0.076035] CPU features: detected: Enhanced Virtualization Traps vm-test-run-timescaledb> server # [ 0.076054] CPU features: detected: Fine Grained Traps vm-test-run-timescaledb> server # [ 0.076103] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.076172] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-timescaledb> server # [ 0.076213] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-timescaledb> server # [ 0.076234] CPU features: detected: LSE atomic instructions vm-test-run-timescaledb> server # [ 0.076252] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-timescaledb> server # [ 0.076273] CPU features: detected: Privileged Access Never vm-test-run-timescaledb> server # [ 0.076291] CPU features: detected: RAS Extension Support vm-test-run-timescaledb> server # [ 0.076312] CPU features: detected: Random Number Generator vm-test-run-timescaledb> server # [ 0.076333] CPU features: detected: Speculation barrier (SB) vm-test-run-timescaledb> server # [ 0.076352] CPU features: detected: Stage-2 Force Write-Back vm-test-run-timescaledb> server # [ 0.076371] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-timescaledb> server # [ 0.076395] CPU features: detected: TLB range maintenance instructions vm-test-run-timescaledb> server # [ 0.076420] CPU features: detected: WFx with timeout vm-test-run-timescaledb> server # [ 0.076458] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-timescaledb> server # [ 0.076479] CPU features: detected: Scalable Vector Extension vm-test-run-timescaledb> server # [ 0.082590] alternatives: applying system-wide alternatives vm-test-run-timescaledb> server # [ 0.094672] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-timescaledb> server # [ 0.095171] SVE: maximum available vector length 256 bytes per vector vm-test-run-timescaledb> server # [ 0.095243] SVE: default vector length 64 bytes per vector vm-test-run-timescaledb> server # [ 0.105653] 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.123890] devtmpfs: initialized vm-test-run-timescaledb> server # [ 0.144844] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-timescaledb> server # [ 0.145219] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.146958] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-timescaledb> server # [ 0.147000] 0 pages in range for non-PLT usage vm-test-run-timescaledb> server # [ 0.147029] 509248 pages in range for PLT usage vm-test-run-timescaledb> server # [ 0.148887] pinctrl core: initialized pinctrl subsystem vm-test-run-timescaledb> server # [ 0.156551] DMI not present or invalid. vm-test-run-timescaledb> server # [ 0.170276] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-timescaledb> server # [ 0.179129] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-timescaledb> server # [ 0.179838] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-timescaledb> server # [ 0.180661] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-timescaledb> server # [ 0.180834] audit: initializing netlink subsys (disabled) vm-test-run-timescaledb> server # [ 0.182051] audit: type=2000 audit(0.084:1): state=initialized audit_enabled=0 res=1 vm-test-run-timescaledb> server # [ 0.186366] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-timescaledb> server # [ 0.186397] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-timescaledb> server # [ 0.186430] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-timescaledb> server # [ 0.186453] thermal_sys: Registered thermal governor 'user_space' vm-test-run-timescaledb> server # [ 0.186475] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-timescaledb> server # [ 0.186873] cpuidle: using governor ladder vm-test-run-timescaledb> server # [ 0.187061] cpuidle: using governor menu vm-test-run-timescaledb> server # [ 0.188682] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-timescaledb> server # [ 0.189198] ASID allocator initialised with 65536 entries vm-test-run-timescaledb> server # [ 0.195058] Serial: AMBA PL011 UART driver vm-test-run-timescaledb> server # [ 0.231064] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-timescaledb> server # [ 0.232406] printk: legacy console [ttyAMA0] enabled vm-test-run-timescaledb> server # [ 0.272540] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.272719] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-timescaledb> server # [ 0.272863] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.273062] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-timescaledb> server # [ 0.273926] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.274063] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-timescaledb> server # [ 0.274441] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.274791] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-timescaledb> server # [ 0.285667] fbcon: Taking over console vm-test-run-timescaledb> server # [ 0.286390] ACPI: Interpreter disabled. vm-test-run-timescaledb> server # [ 0.292011] iommu: Default domain type: Translated vm-test-run-timescaledb> server # [ 0.292156] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-timescaledb> server # [ 0.303790] SCSI subsystem initialized vm-test-run-timescaledb> server # [ 0.305665] usbcore: registered new interface driver usbfs vm-test-run-timescaledb> server # [ 0.306074] usbcore: registered new interface driver hub vm-test-run-timescaledb> server # [ 0.306293] usbcore: registered new device driver usb vm-test-run-timescaledb> server # [ 0.308704] pps_core: LinuxPPS API ver. 1 registered vm-test-run-timescaledb> server # [ 0.308817] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-timescaledb> server # [ 0.309187] PTP clock support registered vm-test-run-timescaledb> server # [ 0.309875] EDAC MC: Ver: 3.0.0 vm-test-run-timescaledb> server # [ 0.311224] scmi_core: SCMI protocol bus registered vm-test-run-timescaledb> server # [ 0.313855] FPGA manager framework vm-test-run-timescaledb> server # [ 0.314800] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-timescaledb> server # [ 0.321876] vgaarb: loaded vm-test-run-timescaledb> server # [ 0.324784] clocksource: Switched to clocksource arch_sys_counter vm-test-run-timescaledb> server # [ 0.327311] VFS: Disk quotas dquot_6.6.0 vm-test-run-timescaledb> server # [ 0.327697] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-timescaledb> server # [ 0.335635] netfs: FS-Cache loaded vm-test-run-timescaledb> server # [ 0.336753] pnp: PnP ACPI: disabled vm-test-run-timescaledb> server # [ 0.355558] NET: Registered PF_INET protocol family vm-test-run-timescaledb> server # [ 0.357089] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-timescaledb> server # [ 0.440738] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.441090] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.442105] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.443165] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-timescaledb> server # [ 0.443947] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-timescaledb> server # [ 0.445157] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-timescaledb> server # [ 0.445673] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.446461] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.447759] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-timescaledb> server # [ 0.448362] NET: Registered PF_XDP protocol family vm-test-run-timescaledb> server # [ 0.448770] PCI: CLS 0 bytes, default 64 vm-test-run-timescaledb> server # [ 0.450556] kvm [1]: HYP mode not available vm-test-run-timescaledb> server # [ 0.451914] Trying to unpack rootfs image as initramfs... vm-test-run-timescaledb> server # [ 0.526909] Initialise system trusted keyrings vm-test-run-timescaledb> server # [ 0.528360] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-timescaledb> server # [ 0.531568] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-timescaledb> server # [ 0.532155] 9p: Installing v9fs 9p2000 file system support vm-test-run-timescaledb> server # [ 0.577510] Key type asymmetric registered vm-test-run-timescaledb> server # [ 0.577729] Asymmetric key parser 'x509' registered vm-test-run-timescaledb> server # [ 0.578585] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-timescaledb> server # [ 0.579478] io scheduler mq-deadline registered vm-test-run-timescaledb> server # [ 0.579623] io scheduler kyber registered vm-test-run-timescaledb> server # [ 0.599858] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-timescaledb> server # [ 0.603265] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-timescaledb> server # [ 0.606148] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-timescaledb> server # [ 0.606996] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-timescaledb> server # [ 0.607683] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-timescaledb> server # [ 0.607888] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-timescaledb> server # [ 0.608718] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-timescaledb> server # [ 0.609497] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-timescaledb> server # [ 0.610772] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-timescaledb> server # [ 0.611313] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-timescaledb> server # [ 0.611499] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.612025] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.612175] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.613717] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.616329] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.616830] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.617535] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.617697] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.618047] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.618816] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.619000] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.619291] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.619421] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.620298] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.620469] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.620577] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.621320] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.621926] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.622112] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.622396] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.622703] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.623451] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.623641] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.623838] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.624046] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.625190] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.625358] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-timescaledb> server # [ 0.625480] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.625792] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.626765] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.626960] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.627246] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.627568] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.627894] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.628530] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.628727] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.628866] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.629879] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.630073] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.630367] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.631195] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.631399] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.632076] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.632282] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.632571] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.632707] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.633705] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.633900] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.634213] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.634539] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.636316] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.636736] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.636937] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.637712] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.637896] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.638225] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.638538] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.638662] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.638969] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.639281] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.639607] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.639863] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.640029] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.640414] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-timescaledb> server # [ 0.640721] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-timescaledb> server # [ 0.640839] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-timescaledb> server # [ 0.641697] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-timescaledb> server # [ 0.641924] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-timescaledb> server # [ 0.642032] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-timescaledb> server # [ 0.642145] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-timescaledb> server # [ 0.642538] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-timescaledb> server # [ 0.642937] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-timescaledb> server # [ 0.643248] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-timescaledb> server # [ 0.643465] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-timescaledb> server # [ 0.643589] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-timescaledb> server # [ 0.644116] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-timescaledb> server # [ 0.644417] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-timescaledb> server # [ 0.644639] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-timescaledb> server # [ 0.644830] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-timescaledb> server # [ 0.645137] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-timescaledb> server # [ 0.645828] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-timescaledb> server # [ 0.646191] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-timescaledb> server # [ 0.646513] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-timescaledb> server # [ 0.646789] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-timescaledb> server # [ 0.647349] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.647492] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.647700] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.648753] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.692433] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.695567] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.696906] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.698337] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.699687] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.700726] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.701954] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.703103] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.704367] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.706140] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.707617] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.719129] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-timescaledb> server # [ 0.726384] msm_serial: driver initialized vm-test-run-timescaledb> server # [ 0.727446] SuperH (H)SCI(F) driver initialized vm-test-run-timescaledb> server # [ 0.728155] STM32 USART driver initialized vm-test-run-timescaledb> server # [ 0.756018] Freeing initrd memory: 10684K vm-test-run-timescaledb> server # [ 0.761054] loop: module loaded vm-test-run-timescaledb> server # [ 0.761941] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-timescaledb> server # [ 0.764630] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-timescaledb> server # [ 0.773447] megasas: 07.727.03.00-rc1 vm-test-run-timescaledb> server # [ 0.777597] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-timescaledb> server # [ 0.779111] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 0.779784] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 0.781120] Using buffer write method vm-test-run-timescaledb> server # [ 0.781972] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-timescaledb> server # [ 0.782888] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 0.783106] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 0.784142] Using buffer write method vm-test-run-timescaledb> server # [ 0.784320] Concatenating MTD devices: vm-test-run-timescaledb> server # [ 0.784623] (0): "0.flash" vm-test-run-timescaledb> server # [ 0.784718] (1): "0.flash" vm-test-run-timescaledb> server # [ 0.785063] into device "0.flash" vm-test-run-timescaledb> server # [ 0.801689] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-timescaledb> server # [ 0.809658] thunder_xcv, ver 1.0 vm-test-run-timescaledb> server # [ 0.809853] thunder_bgx, ver 1.0 vm-test-run-timescaledb> server # [ 0.810471] nicpf, ver 1.0 vm-test-run-timescaledb> server # [ 0.812665] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-timescaledb> server # [ 0.812794] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-timescaledb> server # [ 0.813591] hclge is initializing vm-test-run-timescaledb> server # [ 0.813974] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 0.814075] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-timescaledb> server # [ 0.814679] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 0.814806] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-timescaledb> server # [ 0.815405] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-timescaledb> server # [ 0.815503] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-timescaledb> server # [ 0.815840] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-timescaledb> server # [ 0.816155] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-timescaledb> server # [ 0.817077] sky2: driver version 1.30 vm-test-run-timescaledb> server # [ 0.822960] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-timescaledb> server # [ 0.824113] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-timescaledb> server # [ 0.825097] usbcore: registered new interface driver usb-storage vm-test-run-timescaledb> server # [ 0.825714] usbcore: registered new interface driver usbserial_generic vm-test-run-timescaledb> server # [ 0.826158] usbserial: USB Serial support registered for generic vm-test-run-timescaledb> server # [ 0.826651] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-timescaledb> server # [ 0.832895] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-timescaledb> server # [ 0.833686] rtc-pl031 9010000.pl031: setting system clock to 2026-10-08T04:31:34 UTC (1791433894) vm-test-run-timescaledb> server # [ 0.835562] i2c_dev: i2c /dev entries driver vm-test-run-timescaledb> server # [ 0.845694] sdhci: Secure Digital Host Controller Interface driver vm-test-run-timescaledb> server # [ 0.845841] sdhci: Copyright(c) Pierre Ossman vm-test-run-timescaledb> server # [ 0.847345] Synopsys Designware Multimedia Card Interface Driver vm-test-run-timescaledb> server # [ 0.848955] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-timescaledb> server # [ 0.849669] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-timescaledb> server # [ 0.854850] hid: raw HID events driver (C) Jiri Kosina vm-test-run-timescaledb> server # [ 0.855693] hub 1-0:1.0: USB hub found vm-test-run-timescaledb> server # [ 0.856331] hub 1-0:1.0: 6 ports detected vm-test-run-timescaledb> server # [ 0.856943] usbcore: registered new interface driver usbhid vm-test-run-timescaledb> server # [ 0.857064] usbhid: USB HID core driver vm-test-run-timescaledb> server # [ 0.863201] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-timescaledb> server # [ 0.871907] drop_monitor: Initializing network drop monitor service vm-test-run-timescaledb> server # [ 0.873097] NET: Registered PF_INET6 protocol family vm-test-run-timescaledb> server # [ 0.882807] Segment Routing with IPv6 vm-test-run-timescaledb> server # [ 0.883133] In-situ OAM (IOAM) with IPv6 vm-test-run-timescaledb> server # [ 0.883732] NET: Registered PF_PACKET protocol family vm-test-run-timescaledb> server # [ 0.884610] 9pnet: Installing 9P2000 support vm-test-run-timescaledb> server # [ 0.887653] Key type dns_resolver registered vm-test-run-timescaledb> server # [ 0.912385] registered taskstats version 1 vm-test-run-timescaledb> server # [ 0.914713] Loading compiled-in X.509 certificates vm-test-run-timescaledb> server # [ 0.956398] Demotion targets for Node 0: null vm-test-run-timescaledb> server # [ 0.958003] Key type .fscrypt registered vm-test-run-timescaledb> server # [ 0.958113] Key type fscrypt-provisioning registered vm-test-run-timescaledb> server # [ 0.964715] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-timescaledb> server # [ 0.996634] clk: Disabling unused clocks vm-test-run-timescaledb> server # [ 0.996886] PM: genpd: Disabling unused power domains vm-test-run-timescaledb> server # [ 0.998242] ALSA device list: vm-test-run-timescaledb> server # [ 0.998359] No soundcards found. vm-test-run-timescaledb> server # [ 1.058467] Freeing unused kernel memory: 4416K vm-test-run-timescaledb> server # [ 1.059737] Run /init as init process vm-test-run-timescaledb> server # [ 1.115131] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-timescaledb> server # [ 1.332636] 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.407174] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-timescaledb> server # [ 1.469025] 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.503140] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-timescaledb> server # [ 1.503852] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-timescaledb> server # [ 1.503875] [drm] features: -context_init vm-test-run-timescaledb> server # [ 1.506246] [drm] number of scanouts: 1 vm-test-run-timescaledb> server # [ 1.506408] [drm] number of cap sets: 0 vm-test-run-timescaledb> server # [ 1.515142] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-timescaledb> server # [ 1.543156] Console: switching to colour frame buffer device 160x50 vm-test-run-timescaledb> server # [ 1.551874] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-timescaledb> server # [ 1.605929] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-timescaledb> server # [ 1.859560] 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 # [ 1.862005] 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 # [ 3.937518] EXT4-fs (vda): mounted filesystem 6d193c1e-30d8-4dd7-bc5f-3bb8d9d88930 r/w with ordered data mode. Quota mode: none. vm-test-run-timescaledb> server # [ 6.163045] EXT4-fs (vda): re-mounted 6d193c1e-30d8-4dd7-bc5f-3bb8d9d88930. vm-test-run-timescaledb> server # [ 6.184133] booting system configuration /nix/store/0mlirx5mnz6rlss8w7c1w87cs35vdag0-nixos-system-server-test vm-test-run-timescaledb> server # [ 17.009907] systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN -IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) vm-test-run-timescaledb> server # [ 17.019547] systemd[1]: Detected virtualization qemu. vm-test-run-timescaledb> server # [ 17.023901] systemd[1]: Detected architecture arm64. vm-test-run-timescaledb> server # [ 17.028924] systemd[1]: Detected first boot. vm-test-run-timescaledb> server # [ 17.056017] systemd[1]: Initializing machine ID from random generator. vm-test-run-timescaledb> server # [ 17.083725] systemd[1]: Hostname set to . vm-test-run-timescaledb> server # [ 18.242127] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-timescaledb> server # [ 19.425339] systemd[1]: Applying preset policy. vm-test-run-timescaledb> server # [ 22.386630] systemd[1]: Populated /etc with preset unit settings. vm-test-run-timescaledb> server # [ 25.427327] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-timescaledb> server # [ 25.610710] systemd[1]: Created slice Slice /system/getty. vm-test-run-timescaledb> server # [ 25.623262] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-timescaledb> server # [ 25.635141] systemd[1]: Created slice User and Session Slice. vm-test-run-timescaledb> server # [ 25.642982] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-timescaledb> server # [ 25.648815] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-timescaledb> server # [ 25.653994] systemd[1]: Expecting device /dev/hvc0... vm-test-run-timescaledb> server # [ 25.658122] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-timescaledb> server # [ 25.662471] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-timescaledb> server # [ 25.666644] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-timescaledb> server # [ 25.671173] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-timescaledb> server # [ 25.675443] systemd[1]: Reached target Path Units. vm-test-run-timescaledb> server # [ 25.679761] systemd[1]: Reached target Remote File Systems. vm-test-run-timescaledb> server # [ 25.684373] systemd[1]: Reached target Slice Units. vm-test-run-timescaledb> server # [ 25.689065] systemd[1]: Reached target Swaps. vm-test-run-timescaledb> server # [ 25.717569] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-timescaledb> server # [ 25.738681] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-timescaledb> server # [ 25.748689] systemd[1]: Listening on Journal Audit Socket. vm-test-run-timescaledb> server # [ 25.754680] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-timescaledb> server # [ 25.760018] systemd[1]: Listening on Journal Sockets. vm-test-run-timescaledb> server # [ 25.767558] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-timescaledb> server # [ 25.772476] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 25.778726] systemd[1]: Listening on udev Control Socket. vm-test-run-timescaledb> server # [ 25.783545] systemd[1]: Listening on udev Kernel Socket. vm-test-run-timescaledb> server # [ 25.825796] systemd[1]: Mounting Huge Pages File System... vm-test-run-timescaledb> server # [ 25.859802] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-timescaledb> server # [ 25.896676] systemd[1]: Mounting Kernel Debug File System... vm-test-run-timescaledb> server # [ 25.955213] systemd[1]: Mounting Kernel Trace File System... vm-test-run-timescaledb> server # [ 26.073934] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-timescaledb> server # [ 26.188009] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-timescaledb> server # [ 26.202273] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-timescaledb> server # [ 26.284535] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-timescaledb> server # [ 26.298334] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-timescaledb> server # [ 26.315109] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-timescaledb> server # [ 26.404442] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-timescaledb> server # [ 26.417851] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-timescaledb> server # [ 26.426162] 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 # [ 26.508248] systemd[1]: Starting Journal Service... vm-test-run-timescaledb> server # [ 26.567967] systemd[1]: Starting Load Kernel Modules... vm-test-run-timescaledb> server # [ 26.650442] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-timescaledb> server # [ 26.709689] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-timescaledb> server # [ 26.714761] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 26.759978] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-timescaledb> server # [ 26.832621] systemd[1]: Mounted Huge Pages File System. vm-test-run-timescaledb> server # [ 26.843534] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-timescaledb> server # [ 26.851501] systemd[1]: Mounted Kernel Debug File System. vm-test-run-timescaledb> server # [ 26.863131] systemd[1]: Mounted Kernel Trace File System. vm-test-run-timescaledb> server # [ 26.886901] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-timescaledb> server # [ 26.907477] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-timescaledb> server # [ 26.967803] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-timescaledb> server # [ 27.390383] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 27.407556] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-timescaledb> server # [ 27.651605] systemd[1]: Finished Load Kernel Modules. vm-test-run-timescaledb> server # [ 27.705714] systemd[1]: Starting Firewall... vm-test-run-timescaledb> server # [ 27.739090] EXT4-fs (vda): re-mounted 6d193c1e-30d8-4dd7-bc5f-3bb8d9d88930. vm-test-run-timescaledb> server # [ 27.770287] systemd[1]: Starting Apply Kernel Variables... vm-test-run-timescaledb> server # [ 27.859777] fuse: init (API version 7.41) vm-test-run-timescaledb> server # [ 27.863133] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-timescaledb> server # [ 27.877777] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-timescaledb> server # [ 27.940190] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-timescaledb> server # [ 27.945616] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 27.985911] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 27.994309] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-timescaledb> server # [ 28.001876] systemd-journald[397]: Collecting audit messages is enabled. vm-test-run-timescaledb> server # [ 28.027735] systemd[1]: Mounting FUSE Control File System... vm-test-run-timescaledb> server # [ 28.246940] systemd[1]: Mounted FUSE Control File System. vm-test-run-timescaledb> server # [ 28.844027] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-timescaledb> server # [ 28.857006] systemd[1]: Reached target First Boot Complete. vm-test-run-timescaledb> server # [ 29.128228] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-timescaledb> server # [ 29.158966] systemd[1]: Finished Apply Kernel Variables. vm-test-run-timescaledb> server # [ 29.225984] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-timescaledb> server: Guest root shell did not produce any data yet... vm-test-run-timescaledb> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-timescaledb> server # [ 29.295047] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-timescaledb> server # [ 30.215111] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-timescaledb> server # [ 30.240299] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-timescaledb> server # [ 30.291174] systemd[1]: Mounting /run/wrappers... vm-test-run-timescaledb> server # [ 30.351485] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-timescaledb> server # [ 30.459572] systemd[1]: Started Journal Service. vm-test-run-timescaledb> server # [ 30.295808] systemd-modules-load[398]: Module 'atkbd' is built in vm-test-run-timescaledb> server # [ 30.331721] systemd-modules-load[398]: Module 'loop' is built in vm-test-run-timescaledb> server # [ 30.387988] systemd-oomd[399]: No swap; memory pressure usage will be degraded vm-test-run-timescaledb> server # [ 30.445636] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-timescaledb> server # [ 30.952848] systemd[1]: Mounted /run/wrappers. vm-test-run-timescaledb> server # [ 30.982099] systemd[1]: Reached target Local File Systems. vm-test-run-timescaledb> server # [ 31.008233] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-timescaledb> server # [ 31.067489] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-timescaledb> server # [ 31.081805] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-timescaledb> server # [ 31.138828] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-timescaledb> server # [ 31.547622] systemd-journald[397]: Received client request to flush runtime journal. vm-test-run-timescaledb> server # [ 32.073458] systemd-udevd[428]: Using default interface naming scheme 'v258'. vm-test-run-timescaledb> server # [ 32.175752] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-timescaledb> server # [ 32.205311] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-timescaledb> server # [ 32.277033] systemd[1]: Starting Create System Files and Directories... vm-test-run-timescaledb> server # [ 32.317010] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-timescaledb> server # [ 34.449843] systemd[1]: Finished Create System Files and Directories. vm-test-run-timescaledb> server # [ 34.521838] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-timescaledb> server # [ 34.587784] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-timescaledb> server # [ 35.265968] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-timescaledb> server # [ 35.690668] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-timescaledb> server # [ 36.928938] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-timescaledb> server # [ 36.988147] systemd[1]: Starting Update is Completed... vm-test-run-timescaledb> server # [ 37.971220] systemd[1]: Finished Update is Completed. vm-test-run-timescaledb> server # [ 42.450939] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 42.471517] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-timescaledb> server # [ 42.479402] systemd[1]: suid-sgid-wrappers.service: Consumed 3.059s CPU time, 5.7M memory peak. vm-test-run-timescaledb> server # [ 45.343846] systemd[1]: Finished Firewall. vm-test-run-timescaledb> server # [ 46.890827] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-timescaledb> server # [ 46.910178] systemd[1]: Reached target System Initialization. vm-test-run-timescaledb> server # [ 46.913661] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-timescaledb> server # [ 46.918095] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-timescaledb> server # [ 46.929607] systemd[1]: Reached target Timer Units. vm-test-run-timescaledb> server # [ 46.942007] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-timescaledb> server # [ 46.946136] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-timescaledb> server # [ 46.955095] systemd[1]: Listening on Hostname Service Socket. vm-test-run-timescaledb> server # [ 46.962271] systemd[1]: Reached target Socket Units. vm-test-run-timescaledb> server # [ 46.968167] systemd[1]: Reached target Basic System. vm-test-run-timescaledb> server # [ 46.982598] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-timescaledb> server # [ 47.028168] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 47.081138] systemd[1]: Started Reset console on configuration changes. vm-test-run-timescaledb> server # [ 47.150616] systemd[1]: Starting resolvconf update... vm-test-run-timescaledb> server # [ 47.218299] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-timescaledb> server # [ 48.423436] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 48.446321] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 48.454770] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 48.499692] nsncd[632]: Oct 08 04:32:22.209 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 48.523131] systemd[1]: Starting User Login Management... vm-test-run-timescaledb> server # [ 48.532015] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-timescaledb> server # [ 49.144243] dbus-daemon[635]: dbus[635]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-timescaledb> server # [ 49.805890] systemd[1]: Started D-Bus System Message Bus. vm-test-run-timescaledb> server # [ 50.118006] systemd-logind[651]: New seat seat0. vm-test-run-timescaledb> server # [ 50.142022] systemd[1]: Started User Login Management. vm-test-run-timescaledb> server # [ 50.169486] systemd[1]: Starting linger-users.service... vm-test-run-timescaledb> server # [ 50.579535] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 50.593835] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-timescaledb> server # [ 50.609268] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 50.619741] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-timescaledb> server # [ 50.622125] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 50.683737] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 50.698477] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 50.811093] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 50.821837] systemd[1]: Finished linger-users.service. vm-test-run-timescaledb> server # [ 50.939630] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 51.778608] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 51.800934] nsncd[695]: Oct 08 04:32:25.605 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 51.830189] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 51.835030] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 52.185514] systemd[1]: Finished resolvconf update. vm-test-run-timescaledb> server # [ 52.200492] systemd[1]: Reached target Preparation for Network. vm-test-run-timescaledb> server # [ 52.287043] systemd[1]: Starting DHCP Client... vm-test-run-timescaledb> server # [ 54.171232] dhcpcd[743]: dhcpcd-10.2.4 starting vm-test-run-timescaledb> server # [ 54.278849] dhcpcd[767]: dev: loaded udev vm-test-run-timescaledb> server # [ 54.765409] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-timescaledb> server # [ 55.230789] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-timescaledb> server # [ 55.479840] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-timescaledb> server # [ 55.485049] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-timescaledb> server # [ 55.518673] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-timescaledb> server # [ 55.525611] cfg80211: failed to load regulatory.db vm-test-run-timescaledb> server # [ 56.204018] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-timescaledb> server # [ 56.054261] dhcpcd[767]: eth0: waiting for carrier vm-test-run-timescaledb> server # [ 56.069369] dhcpcd[767]: libudev: received NULL device vm-test-run-timescaledb> server # [ 56.070729] dhcpcd[767]: libudev: received NULL device vm-test-run-timescaledb> server # [ 56.074613] dhcpcd[767]: eth0: carrier acquired vm-test-run-timescaledb> server # [ 56.195156] dhcpcd[767]: DUID 00:01:00:01:32:59:d9:5e:52:54:00:12:34:56 vm-test-run-timescaledb> server # [ 56.201606] dhcpcd[767]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 56.205299] dhcpcd[767]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-timescaledb> server # [ 56.950193] systemd[1]: Found device /dev/hvc0. vm-test-run-timescaledb> server # [ 57.639731] dhcpcd[767]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 57.676197] dhcpcd[767]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 57.699599] dhcpcd[767]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 57.702984] dhcpcd[767]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 57.718725] dhcpcd[767]: eth0: Router Advertisement from fe80::2 vm-test-run-timescaledb> server # [ 57.725957] dhcpcd[767]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-timescaledb> server # [ 57.737742] dhcpcd[767]: eth0: adding route to fec0::/64 vm-test-run-timescaledb> server # [ 57.743140] dhcpcd[767]: eth0: adding default route via fe80::2 vm-test-run-timescaledb> server # [ 57.749319] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-timescaledb> server # [ 57.793028] systemd[1]: Started backdoor.service. vm-test-run-timescaledb> server # connecting to host... vm-test-run-timescaledb> server: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-timescaledb> server: connected to guest root shell vm-test-run-timescaledb> server: (connecting took 59.52 seconds) vm-test-run-timescaledb> server: (finished: waiting for the VM to finish booting, in 59.52 seconds) vm-test-run-timescaledb> server # [ 58.830978] (udev-worker)[783]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-timescaledb> server # [ 58.835050] (udev-worker)[783]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 59.417456] systemd[1]: Found device Virtio network device. vm-test-run-timescaledb> server # [ 59.615343] systemd[1]: Starting Address configuration of eth1... vm-test-run-timescaledb> server # [ 61.000390] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-timescaledb> server # [ 61.062876] network-addresses-eth1-start[813]: adding address 192.168.1.1/24... done vm-test-run-timescaledb> server # [ 61.259135] network-addresses-eth1-start[813]: adding address 2001:db8:1::1/64... done vm-test-run-timescaledb> server # [ 61.394285] (udev-worker)[830]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 61.498323] systemd[1]: Finished Address configuration of eth1. vm-test-run-timescaledb> server # [ 61.546478] systemd[1]: Starting Networking Setup... vm-test-run-timescaledb> server # [ 63.005401] dhcpcd[767]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 63.433264] dhcpcd[767]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 64.086943] dhcpcd[888]: /nix/store/hsj50yr7hr62ql9xaynbihkhfhbgprcn-openresolv-3.17.0/sbin/.resolvconf-wrapped: line 1221: kill: (860) - Operation not permitted vm-test-run-timescaledb> server # [ 64.094543] dhcpcd[888]: clearing stale lock pid 860 vm-test-run-timescaledb> server # [ 64.665212] dhcpcd[767]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 64.672856] dhcpcd[767]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 64.679149] dhcpcd[767]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 64.702755] systemd[1]: Finished Networking Setup. vm-test-run-timescaledb> server # [ 64.704374] systemd[1]: Reached target Network. vm-test-run-timescaledb> server # [ 64.748921] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-timescaledb> server # [ 64.799891] systemd[1]: Starting Permit User Sessions... vm-test-run-timescaledb> server # [ 65.507301] systemd[1]: Finished Permit User Sessions. vm-test-run-timescaledb> server # [ 65.597789] systemd[1]: Started Getty on tty1. vm-test-run-timescaledb> server # [ 65.613595] systemd[1]: Reached target Login Prompts. vm-test-run-timescaledb> server # [ 66.815312] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[938]: Initializing database at /var/lib/postgresql/data vm-test-run-timescaledb> server # [ 68.482627] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: The files belonging to this database system will be owned by user "postgres". vm-test-run-timescaledb> server # [ 68.486395] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: This user must also own the server process. vm-test-run-timescaledb> server # [ 68.626038] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-timescaledb> server # [ 68.627450] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: The default database encoding has accordingly been set to "UTF8". vm-test-run-timescaledb> server # [ 68.628147] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: The default text search configuration will be set to "english". vm-test-run-timescaledb> server # [ 68.630141] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: Data page checksums are enabled. vm-test-run-timescaledb> server # [ 68.639174] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-timescaledb> server # [ 68.687987] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: creating subdirectories ... ok vm-test-run-timescaledb> server # [ 68.712225] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: selecting dynamic shared memory implementation ... posix vm-test-run-timescaledb> server # [ 69.479018] dhcpcd[767]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-timescaledb> server # [ 69.487087] dhcpcd[767]: eth0: adding route to 10.0.2.0/24 vm-test-run-timescaledb> server # [ 69.497156] dhcpcd[767]: eth0: adding default route via 10.0.2.2 vm-test-run-timescaledb> server # [ 70.211929] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: selecting default max_connections ... 100 vm-test-run-timescaledb> server # [ 70.270877] systemd-logind[651]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-timescaledb> server # [ 71.357070] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: selecting default shared_buffers ... 128MB vm-test-run-timescaledb> server # [ 73.875827] systemd[1]: Started DHCP Client. vm-test-run-timescaledb> server # [ 78.426728] mousedev: PS/2 mouse device common for all mice vm-test-run-timescaledb> server # [ 81.755080] systemd-logind[651]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-timescaledb> server # [ 83.229707] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: selecting default time zone ... UTC vm-test-run-timescaledb> server # [ 83.290863] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: creating configuration files ... ok vm-test-run-timescaledb> server # [ 87.866057] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: running bootstrap script ... ok vm-test-run-timescaledb> server # [ 101.363926] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: performing post-bootstrap initialization ... ok vm-test-run-timescaledb> server # [ 104.650583] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: syncing data to disk ... ok vm-test-run-timescaledb> server # [ 104.654435] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-timescaledb> server # [ 104.659838] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: 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.669455] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: Success. You can now start the database server using: vm-test-run-timescaledb> server # [ 104.671093] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[950]: /nix/store/bk54g9x4hp9fnfqyvvkdl7p156ryl73n-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-timescaledb> server # [ 107.034830] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[938]: Validating PostgreSQL configuration... vm-test-run-timescaledb> server # [ 107.487132] 3vzfzwprw5k5g3c2xh0dcr5sm4fn33dq-postgresql-init[1384]: 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 # [ 108.819950] postgres[1386]: 2026-10-08 04:33:22.638 UTC [1386] LOG: pgaudit extension initialized vm-test-run-timescaledb> server # [ 109.997548] postgres[1386]: 2026-10-08 04:33:23.796 UTC [1386] LOG: pgsodium primary server secret key loaded vm-test-run-timescaledb> server # [ 110.558213] postgres[1386]: 2026-10-08 04:33:24.388 UTC [1386] LOG: vault primary server secret key loaded vm-test-run-timescaledb> server # [ 111.062761] postgres[1386]: 2026-10-08 04:33:24.884 UTC [1386] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-timescaledb> server # [ 111.072825] postgres[1386]: 2026-10-08 04:33:24.903 UTC [1386] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-timescaledb> server # [ 111.075023] postgres[1386]: 2026-10-08 04:33:24.906 UTC [1386] LOG: listening on IPv6 address "::", port 5432 vm-test-run-timescaledb> server # [ 111.098795] postgres[1386]: 2026-10-08 04:33:24.929 UTC [1386] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-timescaledb> server # [ 111.275495] postgres[1426]: 2026-10-08 04:33:25.096 UTC [1426] LOG: database system was shut down at 2026-10-08 04:33:14 UTC vm-test-run-timescaledb> server # [ 111.587075] postgres[1386]: 2026-10-08 04:33:25.407 UTC [1386] LOG: database system is ready to accept connections vm-test-run-timescaledb> server # [ 111.686899] postgres[1432]: 2026-10-08 04:33:25.481 UTC [1432] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 111.727490] systemd[1]: Started PostgreSQL Database Server. vm-test-run-timescaledb> server # [ 111.737684] systemd[1]: Starting Supabase Database Initialization... vm-test-run-timescaledb> server # [ 111.800136] postgres[1431]: 2026-10-08 04:33:25.561 UTC [1431] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-timescaledb> server # [ 112.011392] postgres[1386]: 2026-10-08 04:33:25.831 UTC [1386] LOG: background worker "pg_net 0.20.4 worker" (PID 1432) exited with exit code 1 vm-test-run-timescaledb> server # [ 112.243826] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Waiting for PostgreSQL to be ready... vm-test-run-timescaledb> server # [ 112.377881] postgres[1433]: 2026-10-08 04:33:26.184 UTC [1433] LOG: pg_cron scheduler started vm-test-run-timescaledb> server # [ 113.014805] postgres[1451]: ::1 2026-10-08 04:33:26.801 UTC [1451] root@root FATAL: role "root" does not exist vm-test-run-timescaledb> server # [ 113.019550] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: PostgreSQL is ready vm-test-run-timescaledb> server # [ 113.030362] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Creating postgres role... vm-test-run-timescaledb> server # [ 113.158400] postgres[1457]: 2026-10-08 04:33:26.969 UTC [1457] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 113.231860] postgres[1386]: 2026-10-08 04:33:27.058 UTC [1386] LOG: background worker "pg_net 0.20.4 worker" (PID 1457) exited with exit code 1 vm-test-run-timescaledb> server # [ 113.586783] postgres[1463]: ::1 2026-10-08 04:33:27.406 UTC [1463] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-timescaledb> server # [ 113.650036] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1456]: CREATE ROLE vm-test-run-timescaledb> server # [ 114.064742] postgres[1469]: ::1 2026-10-08 04:33:27.887 UTC [1469] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-timescaledb> server # [ 114.102414] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1468]: ALTER DATABASE vm-test-run-timescaledb> server # [ 114.151576] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running init-script: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-timescaledb> server # [ 114.451316] postgres[1472]: ::1 2026-10-08 04:33:28.274 UTC [1472] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-timescaledb> server # [ 114.473460] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: CREATE PUBLICATION vm-test-run-timescaledb> server # [ 114.475522] postgres[1472]: ::1 2026-10-08 04:33:28.299 UTC [1472] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-timescaledb> server # [ 114.479233] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: ALTER ROLE vm-test-run-timescaledb> server # [ 114.481698] postgres[1472]: ::1 2026-10-08 04:33:28.311 UTC [1472] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-timescaledb> server # [ 114.492778] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: CREATE ROLE vm-test-run-timescaledb> server # [ 114.494244] postgres[1472]: ::1 2026-10-08 04:33:28.321 UTC [1472] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-timescaledb> server # [ 114.502355] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: CREATE ROLE vm-test-run-timescaledb> server # [ 114.503152] postgres[1472]: ::1 2026-10-08 04:33:28.333 UTC [1472] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-timescaledb> server # [ 114.514776] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: GRANT ROLE vm-test-run-timescaledb> server # [ 114.515768] postgres[1472]: ::1 2026-10-08 04:33:28.345 UTC [1472] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-timescaledb> server # [ 114.521211] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: GRANT vm-test-run-timescaledb> server # [ 114.523856] postgres[1472]: ::1 2026-10-08 04:33:28.355 UTC [1472] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-timescaledb> server # [ 114.535409] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: CREATE ROLE vm-test-run-timescaledb> server # [ 114.537780] postgres[1472]: ::1 2026-10-08 04:33:28.366 UTC [1472] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-timescaledb> server # [ 114.543692] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: GRANT ROLE vm-test-run-timescaledb> server # [ 114.545681] postgres[1472]: ::1 2026-10-08 04:33:28.374 UTC [1472] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-timescaledb> server # [ 114.558096] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 114.566319] postgres[1472]: ::1 2026-10-08 04:33:28.386 UTC [1472] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-timescaledb> server # [ 117.458699] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 117.475629] postgres[1472]: ::1 2026-10-08 04:33:31.285 UTC [1472] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-timescaledb> server # [ 118.425860] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 118.427598] postgres[1472]: ::1 2026-10-08 04:33:32.258 UTC [1472] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-timescaledb> server # [ 118.435818] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: CREATE ROLE vm-test-run-timescaledb> server # [ 118.443089] postgres[1472]: ::1 2026-10-08 04:33:32.268 UTC [1472] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-timescaledb> server # [ 118.464873] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: CREATE ROLE vm-test-run-timescaledb> server # [ 118.473400] postgres[1472]: ::1 2026-10-08 04:33:32.282 UTC [1472] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-timescaledb> server # [ 118.476528] postgres[1472]: ::1 2026-10-08 04:33:32.297 UTC [1472] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-timescaledb> server # [ 118.478161] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: CREATE ROLE vm-test-run-timescaledb> server # [ 118.481982] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: CREATE ROLE vm-test-run-timescaledb> server # [ 118.488864] postgres[1472]: ::1 2026-10-08 04:33:32.317 UTC [1472] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-timescaledb> server # [ 118.502933] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: GRANT ROLE vm-test-run-timescaledb> server # [ 118.507676] postgres[1472]: ::1 2026-10-08 04:33:32.336 UTC [1472] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-timescaledb> server # [ 118.512915] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: GRANT ROLE vm-test-run-timescaledb> server # [ 118.515553] postgres[1472]: ::1 2026-10-08 04:33:32.346 UTC [1472] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-timescaledb> server # [ 118.526691] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: GRANT ROLE vm-test-run-timescaledb> server # [ 118.529920] postgres[1472]: ::1 2026-10-08 04:33:32.360 UTC [1472] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-timescaledb> server # [ 118.542053] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: GRANT ROLE vm-test-run-timescaledb> server # [ 118.550259] postgres[1472]: ::1 2026-10-08 04:33:32.378 UTC [1472] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 118.563104] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: GRANT vm-test-run-timescaledb> server # [ 118.563963] postgres[1472]: ::1 2026-10-08 04:33:32.395 UTC [1472] 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 # [ 118.583601] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 118.585959] postgres[1472]: ::1 2026-10-08 04:33:32.416 UTC [1472] 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 # [ 118.597602] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 118.599426] postgres[1472]: ::1 2026-10-08 04:33:32.428 UTC [1472] 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 # [ 118.611069] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 118.613430] postgres[1472]: ::1 2026-10-08 04:33:32.440 UTC [1472] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 118.621254] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: GRANT vm-test-run-timescaledb> server # [ 118.622982] postgres[1472]: ::1 2026-10-08 04:33:32.450 UTC [1472] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-timescaledb> server # [ 118.631009] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: ALTER ROLE vm-test-run-timescaledb> server # [ 118.635968] postgres[1472]: ::1 2026-10-08 04:33:32.463 UTC [1472] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 118.643383] postgres[1472]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 118.648332] postgres[1472]: ::1 2026-10-08 04:33:32.475 UTC [1472] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 118.653756] postgres[1472]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 118.654700] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 118.655621] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 118.659838] postgres[1472]: ::1 2026-10-08 04:33:32.485 UTC [1472] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 118.671343] postgres[1472]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 118.678004] postgres[1472]: ::1 2026-10-08 04:33:32.498 UTC [1472] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-timescaledb> server # [ 118.684696] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 118.686224] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: ALTER ROLE vm-test-run-timescaledb> server # [ 118.687407] postgres[1472]: ::1 2026-10-08 04:33:32.511 UTC [1472] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 118.689397] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1470]: ALTER ROLE vm-test-run-timescaledb> server # [ 118.750365] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running init-script: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-timescaledb> server # [ 119.210704] postgres[1509]: ::1 2026-10-08 04:33:33.018 UTC [1509] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 119.258994] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 119.267666] postgres[1509]: ::1 2026-10-08 04:33:33.065 UTC [1509] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-timescaledb> server # [ 119.274706] postgres[1509]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 119.275540] postgres[1509]: id uuid NOT NULL UNIQUE, vm-test-run-timescaledb> server # [ 119.285435] postgres[1509]: aud varchar(255) NULL, vm-test-run-timescaledb> server # [ 119.286878] postgres[1509]: "role" varchar(255) NULL, vm-test-run-timescaledb> server # [ 119.287974] postgres[1509]: email varchar(255) NULL UNIQUE, vm-test-run-timescaledb> server # [ 119.290915] postgres[1509]: encrypted_password varchar(255) NULL, vm-test-run-timescaledb> server # [ 119.304087] postgres[1509]: confirmed_at timestamptz NULL, vm-test-run-timescaledb> server # [ 119.314627] postgres[1509]: invited_at timestamptz NULL, vm-test-run-timescaledb> server # [ 119.315929] postgres[1509]: confirmation_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 119.318202] postgres[1509]: confirmation_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 119.319973] postgres[1509]: recovery_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 119.327059] postgres[1509]: recovery_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 119.328180] postgres[1509]: email_change_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 119.329630] postgres[1509]: email_change varchar(255) NULL, vm-test-run-timescaledb> server # [ 119.337365] postgres[1509]: email_change_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 119.345541] postgres[1509]: last_sign_in_at timestamptz NULL, vm-test-run-timescaledb> server # [ 119.346701] postgres[1509]: raw_app_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 119.347392] postgres[1509]: raw_user_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 119.354356] postgres[1509]: is_super_admin bool NULL, vm-test-run-timescaledb> server # [ 119.356808] postgres[1509]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 119.370229] postgres[1509]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 119.377098] postgres[1509]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 119.378150] postgres[1509]: ); vm-test-run-timescaledb> server # [ 119.534872] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE TABLE vm-test-run-timescaledb> server # [ 119.557827] postgres[1509]: ::1 2026-10-08 04:33:33.378 UTC [1509] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-timescaledb> server # [ 119.641197] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE INDEX vm-test-run-timescaledb> server # [ 119.658726] postgres[1509]: ::1 2026-10-08 04:33:33.480 UTC [1509] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-timescaledb> server # [ 119.728277] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE INDEX vm-test-run-timescaledb> server # [ 119.731934] postgres[1509]: ::1 2026-10-08 04:33:33.552 UTC [1509] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-timescaledb> server # [ 119.750237] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: COMMENT vm-test-run-timescaledb> server # [ 119.754270] postgres[1509]: ::1 2026-10-08 04:33:33.582 UTC [1509] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-timescaledb> server # [ 119.755087] postgres[1509]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 119.755622] postgres[1509]: id bigserial NOT NULL, vm-test-run-timescaledb> server # [ 119.755972] postgres[1509]: "token" varchar(255) NULL, vm-test-run-timescaledb> server # [ 119.761269] postgres[1509]: user_id varchar(255) NULL, vm-test-run-timescaledb> server # [ 119.761811] postgres[1509]: revoked bool NULL, vm-test-run-timescaledb> server # [ 119.762355] postgres[1509]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 119.762886] postgres[1509]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 119.763240] postgres[1509]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 119.763717] postgres[1509]: ); vm-test-run-timescaledb> server # [ 120.024125] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE TABLE vm-test-run-timescaledb> server # [ 120.037004] postgres[1509]: ::1 2026-10-08 04:33:33.866 UTC [1509] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-timescaledb> server # [ 120.074628] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE INDEX vm-test-run-timescaledb> server # [ 120.085727] postgres[1509]: ::1 2026-10-08 04:33:33.913 UTC [1509] 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 # [ 120.125874] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE INDEX vm-test-run-timescaledb> server # [ 120.133448] postgres[1509]: ::1 2026-10-08 04:33:33.961 UTC [1509] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-timescaledb> server # [ 120.173563] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE INDEX vm-test-run-timescaledb> server # [ 120.174538] postgres[1509]: ::1 2026-10-08 04:33:34.004 UTC [1509] 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 # [ 120.189149] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: COMMENT vm-test-run-timescaledb> server # [ 120.198045] postgres[1509]: ::1 2026-10-08 04:33:34.020 UTC [1509] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-timescaledb> server # [ 120.198733] postgres[1509]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 120.199961] postgres[1509]: uuid uuid NULL, vm-test-run-timescaledb> server # [ 120.206131] postgres[1509]: raw_base_config text NULL, vm-test-run-timescaledb> server # [ 120.206837] postgres[1509]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 120.216748] postgres[1509]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 120.219836] postgres[1509]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 120.225756] postgres[1509]: ); vm-test-run-timescaledb> server # [ 120.273337] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE TABLE vm-test-run-timescaledb> server # [ 120.274408] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: COMMENT vm-test-run-timescaledb> server # [ 120.274863] postgres[1509]: ::1 2026-10-08 04:33:34.091 UTC [1509] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-timescaledb> server # [ 120.275366] postgres[1509]: ::1 2026-10-08 04:33:34.101 UTC [1509] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-timescaledb> server # [ 120.276012] postgres[1509]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 120.277126] postgres[1509]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 120.285292] postgres[1509]: payload json NULL, vm-test-run-timescaledb> server # [ 120.286291] postgres[1509]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 120.286968] postgres[1509]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 120.287311] postgres[1509]: ); vm-test-run-timescaledb> server # [ 120.351465] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE TABLE vm-test-run-timescaledb> server # [ 120.353213] postgres[1509]: ::1 2026-10-08 04:33:34.183 UTC [1509] 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 # [ 120.384217] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE INDEX vm-test-run-timescaledb> server # [ 120.389499] postgres[1509]: ::1 2026-10-08 04:33:34.217 UTC [1509] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-timescaledb> server # [ 120.397032] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: COMMENT vm-test-run-timescaledb> server # [ 120.401766] postgres[1509]: ::1 2026-10-08 04:33:34.231 UTC [1509] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-timescaledb> server # [ 120.403057] postgres[1509]: "version" varchar(255) NOT NULL, vm-test-run-timescaledb> server # [ 120.403397] postgres[1509]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-timescaledb> server # [ 120.403684] postgres[1509]: ); vm-test-run-timescaledb> server # [ 120.436996] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE TABLE vm-test-run-timescaledb> server # [ 120.442506] postgres[1509]: ::1 2026-10-08 04:33:34.271 UTC [1509] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-timescaledb> server # [ 120.465361] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: COMMENT vm-test-run-timescaledb> server # [ 120.483276] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: INSERT 0 7 vm-test-run-timescaledb> server # [ 120.486026] postgres[1509]: ::1 2026-10-08 04:33:34.316 UTC [1509] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-timescaledb> server # [ 120.486733] postgres[1509]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-timescaledb> server # [ 120.487271] postgres[1509]: $$ language sql stable; vm-test-run-timescaledb> server # [ 120.500788] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 120.502199] postgres[1509]: ::1 2026-10-08 04:33:34.332 UTC [1509] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-timescaledb> server # [ 120.503399] postgres[1509]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-timescaledb> server # [ 120.510168] postgres[1509]: $$ language sql stable; vm-test-run-timescaledb> server # [ 120.515325] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 120.521152] postgres[1509]: ::1 2026-10-08 04:33:34.347 UTC [1509] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-timescaledb> server # [ 120.523176] postgres[1509]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-timescaledb> server # [ 120.523956] postgres[1509]: $$ language sql stable; vm-test-run-timescaledb> server # [ 120.527348] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 120.530545] postgres[1509]: ::1 2026-10-08 04:33:34.361 UTC [1509] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 120.536251] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: GRANT vm-test-run-timescaledb> server # [ 120.537119] postgres[1509]: ::1 2026-10-08 04:33:34.368 UTC [1509] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 120.545347] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: CREATE ROLE vm-test-run-timescaledb> server # [ 120.547243] postgres[1509]: ::1 2026-10-08 04:33:34.377 UTC [1509] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.558124] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: GRANT vm-test-run-timescaledb> server # [ 120.563435] postgres[1509]: ::1 2026-10-08 04:33:34.391 UTC [1509] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.574389] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: GRANT vm-test-run-timescaledb> server # [ 120.579036] postgres[1509]: ::1 2026-10-08 04:33:34.406 UTC [1509] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.586023] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: GRANT vm-test-run-timescaledb> server # [ 120.590033] postgres[1509]: ::1 2026-10-08 04:33:34.418 UTC [1509] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-timescaledb> server # [ 120.596258] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: ALTER ROLE vm-test-run-timescaledb> server # [ 120.605042] postgres[1509]: ::1 2026-10-08 04:33:34.429 UTC [1509] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.613825] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: ALTER TABLE vm-test-run-timescaledb> server # [ 120.614979] postgres[1509]: ::1 2026-10-08 04:33:34.445 UTC [1509] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.626869] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: ALTER TABLE vm-test-run-timescaledb> server # [ 120.630453] postgres[1509]: ::1 2026-10-08 04:33:34.461 UTC [1509] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.645192] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: ALTER TABLE vm-test-run-timescaledb> server # [ 120.646466] postgres[1509]: ::1 2026-10-08 04:33:34.475 UTC [1509] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.655339] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: ALTER TABLE vm-test-run-timescaledb> server # [ 120.661758] postgres[1509]: ::1 2026-10-08 04:33:34.489 UTC [1509] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 120.673790] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1501]: ALTER TABLE vm-test-run-timescaledb> server # [ 120.722682] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running init-script: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-timescaledb> server # [ 120.954565] postgres[1528]: ::1 2026-10-08 04:33:34.778 UTC [1528] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 120.974737] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1527]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 120.975884] postgres[1528]: ::1 2026-10-08 04:33:34.801 UTC [1528] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 120.985595] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1527]: CREATE ROLE vm-test-run-timescaledb> server # [ 120.990820] postgres[1528]: ::1 2026-10-08 04:33:34.819 UTC [1528] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-timescaledb> server # [ 121.008162] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1527]: ALTER ROLE vm-test-run-timescaledb> server # [ 121.019093] postgres[1528]: ::1 2026-10-08 04:33:34.849 UTC [1528] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-timescaledb> server # [ 121.045527] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1527]: GRANT vm-test-run-timescaledb> server # [ 121.110319] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1527]: DO vm-test-run-timescaledb> server # [ 121.152889] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running init-script: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-timescaledb> server # [ 121.518346] postgres[1534]: ::1 2026-10-08 04:33:35.341 UTC [1534] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-timescaledb> server # [ 121.547080] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: ALTER ROLE vm-test-run-timescaledb> server # [ 121.556443] postgres[1534]: ::1 2026-10-08 04:33:35.366 UTC [1534] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-timescaledb> server # [ 121.560003] postgres[1534]: ::1 2026-10-08 04:33:35.386 UTC [1534] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-timescaledb> server # [ 121.566482] postgres[1534]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 121.567117] postgres[1534]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 121.567715] postgres[1534]: AS $$ vm-test-run-timescaledb> server # [ 121.568334] postgres[1534]: DECLARE vm-test-run-timescaledb> server # [ 121.568832] postgres[1534]: schema_is_cron bool; vm-test-run-timescaledb> server # [ 121.569156] postgres[1534]: BEGIN vm-test-run-timescaledb> server # [ 121.569699] postgres[1534]: schema_is_cron = ( vm-test-run-timescaledb> server # [ 121.569994] postgres[1534]: SELECT n.nspname = 'cron' vm-test-run-timescaledb> server # [ 121.582223] postgres[1534]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 121.588240] postgres[1534]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-timescaledb> server # [ 121.590931] postgres[1534]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 121.595122] postgres[1534]: ); vm-test-run-timescaledb> server # [ 121.595622] postgres[1534]: vm-test-run-timescaledb> server # [ 121.595919] postgres[1534]: IF schema_is_cron vm-test-run-timescaledb> server # [ 121.596191] postgres[1534]: THEN vm-test-run-timescaledb> server # [ 121.601464] postgres[1534]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 121.607876] postgres[1534]: vm-test-run-timescaledb> server # [ 121.621514] postgres[1534]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 121.622255] postgres[1534]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 121.622657] postgres[1534]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 121.622968] postgres[1534]: vm-test-run-timescaledb> server # [ 121.623199] postgres[1534]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 121.623538] postgres[1534]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 121.624169] postgres[1534]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 121.631702] postgres[1534]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 121.637295] postgres[1534]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 121.639082] postgres[1534]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 121.646407] postgres[1534]: vm-test-run-timescaledb> server # [ 121.647098] postgres[1534]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 121.647952] postgres[1534]: vm-test-run-timescaledb> server # [ 121.657502] postgres[1534]: END IF; vm-test-run-timescaledb> server # [ 121.659118] postgres[1534]: vm-test-run-timescaledb> server # [ 121.663103] postgres[1534]: END; vm-test-run-timescaledb> server # [ 121.663843] postgres[1534]: $$; vm-test-run-timescaledb> server # [ 121.665276] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: ALTER ROLE vm-test-run-timescaledb> server # [ 121.665872] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 121.666176] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 121.666682] postgres[1534]: ::1 2026-10-08 04:33:35.452 UTC [1534] 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 # [ 121.669026] postgres[1534]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 121.669867] postgres[1534]: ::1 2026-10-08 04:33:35.479 UTC [1534] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-timescaledb> server # [ 121.670465] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: COMMENT vm-test-run-timescaledb> server # [ 121.671096] postgres[1534]: ::1 2026-10-08 04:33:35.501 UTC [1534] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-timescaledb> server # [ 121.671515] postgres[1534]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 121.676920] postgres[1534]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 121.677561] postgres[1534]: AS $$ vm-test-run-timescaledb> server # [ 121.678023] postgres[1534]: BEGIN vm-test-run-timescaledb> server # [ 121.678323] postgres[1534]: IF EXISTS ( vm-test-run-timescaledb> server # [ 121.678606] postgres[1534]: SELECT 1 vm-test-run-timescaledb> server # [ 121.679417] postgres[1534]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 121.679780] postgres[1534]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 121.680133] postgres[1534]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 121.680433] postgres[1534]: WHERE ext.extname = 'pg_net' vm-test-run-timescaledb> server # [ 121.680687] postgres[1534]: ) vm-test-run-timescaledb> server # [ 121.680922] postgres[1534]: THEN vm-test-run-timescaledb> server # [ 121.681137] postgres[1534]: IF NOT EXISTS ( vm-test-run-timescaledb> server # [ 121.681365] postgres[1534]: SELECT 1 vm-test-run-timescaledb> server # [ 121.681721] postgres[1534]: FROM pg_roles vm-test-run-timescaledb> server # [ 121.682039] postgres[1534]: WHERE rolname = 'supabase_functions_admin' vm-test-run-timescaledb> server # [ 121.694394] postgres[1534]: ) vm-test-run-timescaledb> server # [ 121.706052] postgres[1534]: THEN vm-test-run-timescaledb> server # [ 121.707285] postgres[1534]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 121.716659] postgres[1534]: END IF; vm-test-run-timescaledb> server # [ 121.717939] postgres[1534]: vm-test-run-timescaledb> server # [ 121.720068] postgres[1534]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 121.722049] postgres[1534]: vm-test-run-timescaledb> server # [ 121.722563] postgres[1534]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 121.722937] postgres[1534]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 121.723297] postgres[1534]: vm-test-run-timescaledb> server # [ 121.723805] postgres[1534]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-timescaledb> server # [ 121.724644] postgres[1534]: 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 # [ 121.725505] postgres[1534]: vm-test-run-timescaledb> server # [ 121.725766] postgres[1534]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-timescaledb> server # [ 121.727196] postgres[1534]: 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 # [ 121.727704] postgres[1534]: vm-test-run-timescaledb> server # [ 121.728292] postgres[1534]: 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 # [ 121.729792] postgres[1534]: 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 # [ 121.730873] postgres[1534]: END IF; vm-test-run-timescaledb> server # [ 121.731238] postgres[1534]: END; vm-test-run-timescaledb> server # [ 121.731502] postgres[1534]: $$; vm-test-run-timescaledb> server # [ 121.731918] postgres[1534]: ::1 2026-10-08 04:33:35.526 UTC [1534] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-timescaledb> server # [ 121.733598] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 121.734032] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: COMMENT vm-test-run-timescaledb> server # [ 121.762071] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: DO vm-test-run-timescaledb> server # [ 121.767702] postgres[1534]: ::1 2026-10-08 04:33:35.595 UTC [1534] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-timescaledb> server # [ 121.773733] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: CREATE ROLE vm-test-run-timescaledb> server # [ 121.775076] postgres[1534]: ::1 2026-10-08 04:33:35.606 UTC [1534] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-timescaledb> server # [ 121.790287] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: GRANT vm-test-run-timescaledb> server # [ 121.795781] postgres[1534]: ::1 2026-10-08 04:33:35.623 UTC [1534] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 121.802211] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: GRANT vm-test-run-timescaledb> server # [ 121.807857] postgres[1534]: ::1 2026-10-08 04:33:35.637 UTC [1534] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 121.818645] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: GRANT vm-test-run-timescaledb> server # [ 121.820409] postgres[1534]: ::1 2026-10-08 04:33:35.647 UTC [1534] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 121.884521] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: GRANT vm-test-run-timescaledb> server # [ 121.887460] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: GRANT vm-test-run-timescaledb> server # [ 121.903994] postgres[1534]: ::1 2026-10-08 04:33:35.688 UTC [1534] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 121.916657] postgres[1534]: ::1 2026-10-08 04:33:35.704 UTC [1534] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 121.927162] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: GRANT vm-test-run-timescaledb> server # [ 121.930545] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: GRANT vm-test-run-timescaledb> server # [ 121.931320] postgres[1534]: ::1 2026-10-08 04:33:35.727 UTC [1534] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 121.932141] postgres[1534]: ::1 2026-10-08 04:33:35.732 UTC [1534] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 121.959830] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: GRANT vm-test-run-timescaledb> server # [ 121.969283] postgres[1534]: ::1 2026-10-08 04:33:35.796 UTC [1534] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 122.064552] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: GRANT vm-test-run-timescaledb> server # [ 122.092133] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1532]: DO vm-test-run-timescaledb> server # [ 122.174739] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running pgbouncer auth schema... vm-test-run-timescaledb> server # [ 122.614070] postgres[1549]: ::1 2026-10-08 04:33:36.422 UTC [1549] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-timescaledb> server # [ 122.624951] postgres[1549]: ::1 2026-10-08 04:33:36.445 UTC [1549] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-timescaledb> server # [ 122.642202] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1542]: CREATE ROLE vm-test-run-timescaledb> server # [ 122.647454] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1542]: REVOKE vm-test-run-timescaledb> server # [ 122.661732] postgres[1549]: ::1 2026-10-08 04:33:36.482 UTC [1549] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-timescaledb> server # [ 122.775273] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1542]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 122.777340] postgres[1549]: ::1 2026-10-08 04:33:36.606 UTC [1549] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-timescaledb> server # [ 122.778163] postgres[1549]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-timescaledb> server # [ 122.778545] postgres[1549]: $$ vm-test-run-timescaledb> server # [ 122.778855] postgres[1549]: BEGIN vm-test-run-timescaledb> server # [ 122.779552] postgres[1549]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-timescaledb> server # [ 122.785031] postgres[1549]: vm-test-run-timescaledb> server # [ 122.785781] postgres[1549]: RETURN QUERY vm-test-run-timescaledb> server # [ 122.787879] postgres[1549]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-timescaledb> server # [ 122.799323] postgres[1549]: WHERE usename = p_usename; vm-test-run-timescaledb> server # [ 122.805591] postgres[1549]: END; vm-test-run-timescaledb> server # [ 122.808844] postgres[1549]: $$ LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 122.810422] postgres[1549]: SET search_path = '' vm-test-run-timescaledb> server # [ 122.821342] postgres[1549]: SECURITY DEFINER; vm-test-run-timescaledb> server # [ 122.834305] postgres[1549]: ::1 2026-10-08 04:33:36.631 UTC [1549] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-timescaledb> server # [ 122.835236] postgres[1549]: ::1 2026-10-08 04:33:36.644 UTC [1549] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-timescaledb> server # [ 122.846851] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1542]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 122.847660] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1542]: REVOKE vm-test-run-timescaledb> server # [ 122.861598] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1542]: GRANT vm-test-run-timescaledb> server # [ 122.906908] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running stat extension... vm-test-run-timescaledb> server # [ 123.338010] postgres[1562]: ::1 2026-10-08 04:33:37.153 UTC [1562] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-timescaledb> server # [ 123.354883] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1557]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-timescaledb> server # [ 123.386436] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1557]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 123.390666] postgres[1562]: ::1 2026-10-08 04:33:37.219 UTC [1562] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-timescaledb> server # [ 124.472398] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1557]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 124.539342] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-timescaledb> server # [ 124.950876] postgres[1564]: ::1 2026-10-08 04:33:38.751 UTC [1564] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-timescaledb> server # [ 125.005511] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1563]: GRANT vm-test-run-timescaledb> server # [ 125.011610] postgres[1564]: ::1 2026-10-08 04:33:38.806 UTC [1564] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 125.032106] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1563]: GRANT vm-test-run-timescaledb> server # [ 125.034458] postgres[1564]: ::1 2026-10-08 04:33:38.864 UTC [1564] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 125.047586] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1563]: GRANT vm-test-run-timescaledb> server # [ 125.049419] postgres[1564]: ::1 2026-10-08 04:33:38.879 UTC [1564] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 125.077897] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1563]: GRANT vm-test-run-timescaledb> server # [ 125.079416] postgres[1564]: ::1 2026-10-08 04:33:38.909 UTC [1564] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 125.091848] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1563]: GRANT vm-test-run-timescaledb> server # [ 125.114707] postgres[1564]: ::1 2026-10-08 04:33:38.926 UTC [1564] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 125.124540] postgres[1564]: ::1 2026-10-08 04:33:38.954 UTC [1564] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 125.138195] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1563]: GRANT vm-test-run-timescaledb> server # [ 125.138821] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1563]: GRANT vm-test-run-timescaledb> server # [ 125.140280] postgres[1564]: ::1 2026-10-08 04:33:38.962 UTC [1564] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 125.165576] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1563]: GRANT vm-test-run-timescaledb> server # [ 125.178476] postgres[1564]: ::1 2026-10-08 04:33:39.004 UTC [1564] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 125.255739] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1563]: GRANT vm-test-run-timescaledb> server # [ 125.288122] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1563]: DO vm-test-run-timescaledb> server # [ 125.305472] postgres[1564]: ::1 2026-10-08 04:33:39.126 UTC [1564] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-timescaledb> server # [ 125.339916] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1563]: ALTER ROLE vm-test-run-timescaledb> server # [ 125.389340] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-timescaledb> server # [ 125.940475] postgres[1577]: ::1 2026-10-08 04:33:39.726 UTC [1577] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 125.970280] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: GRANT vm-test-run-timescaledb> server # [ 125.977765] postgres[1577]: ::1 2026-10-08 04:33:39.790 UTC [1577] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 125.988257] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: GRANT vm-test-run-timescaledb> server # [ 125.997084] postgres[1577]: ::1 2026-10-08 04:33:39.826 UTC [1577] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 126.014527] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: GRANT vm-test-run-timescaledb> server # [ 126.015788] postgres[1577]: ::1 2026-10-08 04:33:39.846 UTC [1577] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 126.033330] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: ALTER TABLE vm-test-run-timescaledb> server # [ 126.035447] postgres[1577]: ::1 2026-10-08 04:33:39.865 UTC [1577] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 126.056006] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: ALTER TABLE vm-test-run-timescaledb> server # [ 126.062475] postgres[1577]: ::1 2026-10-08 04:33:39.889 UTC [1577] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 126.075363] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: ALTER TABLE vm-test-run-timescaledb> server # [ 126.081788] postgres[1577]: ::1 2026-10-08 04:33:39.908 UTC [1577] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 126.085339] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: ALTER TABLE vm-test-run-timescaledb> server # [ 126.086073] postgres[1577]: ::1 2026-10-08 04:33:39.917 UTC [1577] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 126.101480] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: ALTER TABLE vm-test-run-timescaledb> server # [ 126.107046] postgres[1577]: ::1 2026-10-08 04:33:39.937 UTC [1577] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 126.124754] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: GRANT vm-test-run-timescaledb> server # [ 126.126463] postgres[1577]: ::1 2026-10-08 04:33:39.956 UTC [1577] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 126.141213] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: GRANT vm-test-run-timescaledb> server # [ 126.142984] postgres[1577]: ::1 2026-10-08 04:33:39.973 UTC [1577] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 126.150301] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: GRANT vm-test-run-timescaledb> server # [ 126.151585] postgres[1577]: ::1 2026-10-08 04:33:39.981 UTC [1577] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 126.170714] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: GRANT vm-test-run-timescaledb> server # [ 126.171892] postgres[1577]: ::1 2026-10-08 04:33:40.002 UTC [1577] 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 # [ 126.191175] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 126.194354] postgres[1577]: ::1 2026-10-08 04:33:40.022 UTC [1577] 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 # [ 126.201802] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 126.203167] postgres[1577]: ::1 2026-10-08 04:33:40.033 UTC [1577] 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 # [ 126.215546] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1574]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 126.315107] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-timescaledb> server # [ 126.747916] postgres[1592]: ::1 2026-10-08 04:33:40.575 UTC [1592] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-timescaledb> server # [ 126.781814] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1586]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 126.808845] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 127.227704] postgres[1597]: ::1 2026-10-08 04:33:41.040 UTC [1597] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-timescaledb> server # [ 127.251644] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1593]: GRANT vm-test-run-timescaledb> server # [ 127.254646] postgres[1597]: ::1 2026-10-08 04:33:41.085 UTC [1597] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 127.271240] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1593]: GRANT vm-test-run-timescaledb> server # [ 127.279139] postgres[1597]: ::1 2026-10-08 04:33:41.110 UTC [1597] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 127.287363] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1593]: GRANT vm-test-run-timescaledb> server # [ 127.294432] postgres[1597]: ::1 2026-10-08 04:33:41.124 UTC [1597] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 127.309348] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1593]: GRANT vm-test-run-timescaledb> server # [ 127.386355] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-timescaledb> server # [ 127.773993] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1599]: DO vm-test-run-timescaledb> server # [ 127.780208] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1599]: DO vm-test-run-timescaledb> server # [ 127.792848] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1599]: DO vm-test-run-timescaledb> server # [ 127.849361] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 128.095780] postgres[1602]: ::1 2026-10-08 04:33:41.920 UTC [1602] 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 # [ 128.119076] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1601]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 128.123680] postgres[1602]: ::1 2026-10-08 04:33:41.945 UTC [1602] 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 # [ 128.129969] postgres[1602]: ::1 2026-10-08 04:33:41.960 UTC [1602] 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 # [ 128.131915] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1601]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 128.140801] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1601]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 128.179800] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-timescaledb> server # [ 128.485113] postgres[1604]: ::1 2026-10-08 04:33:42.308 UTC [1604] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-timescaledb> server # [ 128.511481] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1603]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.569546] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-timescaledb> server # [ 129.065964] postgres[1613]: ::1 2026-10-08 04:33:42.870 UTC [1613] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 129.067242] postgres[1613]: ::1 2026-10-08 04:33:42.896 UTC [1613] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 129.076003] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-timescaledb> server # [ 129.089686] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 129.090471] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-timescaledb> server # [ 129.097671] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: DROP FUNCTION vm-test-run-timescaledb> server # [ 129.099531] postgres[1613]: ::1 2026-10-08 04:33:42.906 UTC [1613] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 129.104441] postgres[1613]: DECLARE vm-test-run-timescaledb> server # [ 129.114207] postgres[1613]: cmd record; vm-test-run-timescaledb> server # [ 129.114826] postgres[1613]: BEGIN vm-test-run-timescaledb> server # [ 129.115765] postgres[1613]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 129.127825] postgres[1613]: LOOP vm-test-run-timescaledb> server # [ 129.133421] postgres[1613]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 129.134464] postgres[1613]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 129.135974] postgres[1613]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 129.148764] postgres[1613]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 129.168634] postgres[1613]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 129.170247] postgres[1613]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 129.170827] postgres[1613]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 129.172126] postgres[1613]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 129.191148] postgres[1613]: , 'CREATE TYPE' vm-test-run-timescaledb> server # [ 129.197468] postgres[1613]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 129.199992] postgres[1613]: , 'COMMENT' vm-test-run-timescaledb> server # [ 129.222329] postgres[1613]: ) vm-test-run-timescaledb> server # [ 129.223314] postgres[1613]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 129.224514] postgres[1613]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 129.253209] postgres[1613]: THEN vm-test-run-timescaledb> server # [ 129.273155] postgres[1613]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 129.274297] postgres[1613]: END IF; vm-test-run-timescaledb> server # [ 129.290701] postgres[1613]: END LOOP; vm-test-run-timescaledb> server # [ 129.299243] postgres[1613]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 129.304006] postgres[1613]: ::1 2026-10-08 04:33:42.954 UTC [1613] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 129.316290] postgres[1613]: DECLARE vm-test-run-timescaledb> server # [ 129.334773] postgres[1613]: obj record; vm-test-run-timescaledb> server # [ 129.337249] postgres[1613]: BEGIN vm-test-run-timescaledb> server # [ 129.338429] postgres[1613]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 129.351267] postgres[1613]: LOOP vm-test-run-timescaledb> server # [ 129.352011] postgres[1613]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 129.358817] postgres[1613]: 'schema' vm-test-run-timescaledb> server # [ 129.360091] postgres[1613]: , 'table' vm-test-run-timescaledb> server # [ 129.360414] postgres[1613]: , 'foreign table' vm-test-run-timescaledb> server # [ 129.375765] postgres[1613]: , 'view' vm-test-run-timescaledb> server # [ 129.383599] postgres[1613]: , 'materialized view' vm-test-run-timescaledb> server # [ 129.391691] postgres[1613]: , 'function' vm-test-run-timescaledb> server # [ 129.398806] postgres[1613]: , 'trigger' vm-test-run-timescaledb> server # [ 129.404258] postgres[1613]: , 'type' vm-test-run-timescaledb> server # [ 129.415232] postgres[1613]: , 'rule' vm-test-run-timescaledb> server # [ 129.422302] postgres[1613]: ) vm-test-run-timescaledb> server # [ 129.429548] postgres[1613]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 129.435833] postgres[1613]: THEN vm-test-run-timescaledb> server # [ 129.446605] postgres[1613]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 129.455655] postgres[1613]: END IF; vm-test-run-timescaledb> server # [ 129.463319] postgres[1613]: END LOOP; vm-test-run-timescaledb> server # [ 129.467760] postgres[1613]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 129.479068] postgres[1613]: ::1 2026-10-08 04:33:42.969 UTC [1613] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 129.490262] postgres[1613]: ::1 2026-10-08 04:33:42.977 UTC [1613] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 129.491871] postgres[1613]: ON ddl_command_end vm-test-run-timescaledb> server # [ 129.495075] postgres[1613]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 129.502108] postgres[1613]: ::1 2026-10-08 04:33:42.991 UTC [1613] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 129.506059] postgres[1613]: ::1 2026-10-08 04:33:42.994 UTC [1613] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 129.513061] postgres[1613]: ON sql_drop vm-test-run-timescaledb> server # [ 129.518843] postgres[1613]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 129.523268] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 129.523949] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 129.533090] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 129.542939] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 129.546235] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 129.553729] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 129.555600] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 129.561321] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1606]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 129.570914] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-timescaledb> server # [ 130.595696] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1623]: DO vm-test-run-timescaledb> server # [ 130.621223] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-timescaledb> server # [ 130.914993] postgres[1634]: ::1 2026-10-08 04:33:44.737 UTC [1634] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-timescaledb> server # [ 130.995915] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 130.998330] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-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 # [ 131.001620] postgres[1634]: ::1 2026-10-08 04:33:44.817 UTC [1634] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-timescaledb> server # [ 131.013338] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: DROP FUNCTION vm-test-run-timescaledb> server # [ 131.018461] postgres[1634]: ::1 2026-10-08 04:33:44.847 UTC [1634] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 131.019784] postgres[1634]: "operationName" text default null, vm-test-run-timescaledb> server # [ 131.029945] postgres[1634]: query text default null, vm-test-run-timescaledb> server # [ 131.031723] postgres[1634]: variables jsonb default null, vm-test-run-timescaledb> server # [ 131.041786] postgres[1634]: extensions jsonb default null vm-test-run-timescaledb> server # [ 131.042528] postgres[1634]: ) vm-test-run-timescaledb> server # [ 131.043068] postgres[1634]: returns jsonb vm-test-run-timescaledb> server # [ 131.044087] postgres[1634]: language plpgsql vm-test-run-timescaledb> server # [ 131.061892] postgres[1634]: as $$ vm-test-run-timescaledb> server # [ 131.063057] postgres[1634]: DECLARE vm-test-run-timescaledb> server # [ 131.063456] postgres[1634]: server_version float; vm-test-run-timescaledb> server # [ 131.070150] postgres[1634]: BEGIN vm-test-run-timescaledb> server # [ 131.071910] postgres[1634]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 131.081415] postgres[1634]: vm-test-run-timescaledb> server # [ 131.082465] postgres[1634]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 131.083331] postgres[1634]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 131.084290] postgres[1634]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 131.084734] postgres[1634]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 131.097037] postgres[1634]: ); vm-test-run-timescaledb> server # [ 131.098069] postgres[1634]: ELSE vm-test-run-timescaledb> server # [ 131.098631] postgres[1634]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 131.099578] postgres[1634]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 131.102025] postgres[1634]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 131.110098] postgres[1634]: ); vm-test-run-timescaledb> server # [ 131.111563] postgres[1634]: END IF; vm-test-run-timescaledb> server # [ 131.112080] postgres[1634]: END; vm-test-run-timescaledb> server # [ 131.115528] postgres[1634]: $$; vm-test-run-timescaledb> server # [ 131.116528] postgres[1634]: ::1 2026-10-08 04:33:44.909 UTC [1634] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 131.117563] postgres[1634]: ::1 2026-10-08 04:33:44.937 UTC [1634] 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 # [ 131.118473] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 131.119078] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: GRANT vm-test-run-timescaledb> server # [ 131.133809] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 131.135658] postgres[1634]: ::1 2026-10-08 04:33:44.959 UTC [1634] 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 # [ 131.142637] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 131.149870] postgres[1634]: ::1 2026-10-08 04:33:44.975 UTC [1634] 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 # [ 131.163522] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 131.170254] postgres[1634]: ::1 2026-10-08 04:33:44.997 UTC [1634] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 131.171555] postgres[1634]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 131.181461] postgres[1634]: ::1 2026-10-08 04:33:45.010 UTC [1634] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 131.183272] postgres[1634]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 131.183734] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 131.191025] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 131.198591] postgres[1634]: ::1 2026-10-08 04:33:45.025 UTC [1634] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 131.202342] postgres[1634]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 131.205859] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 131.213401] postgres[1634]: ::1 2026-10-08 04:33:45.041 UTC [1634] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 131.220992] postgres[1634]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 131.221565] postgres[1634]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 131.222746] postgres[1634]: AS $func$ vm-test-run-timescaledb> server # [ 131.223113] postgres[1634]: DECLARE vm-test-run-timescaledb> server # [ 131.223649] postgres[1634]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 131.229734] postgres[1634]: BEGIN vm-test-run-timescaledb> server # [ 131.238933] postgres[1634]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 131.239503] postgres[1634]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 131.245125] postgres[1634]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 131.246022] postgres[1634]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 131.246560] postgres[1634]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 131.247125] postgres[1634]: ); vm-test-run-timescaledb> server # [ 131.247520] postgres[1634]: vm-test-run-timescaledb> server # [ 131.247858] postgres[1634]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 131.251461] postgres[1634]: THEN vm-test-run-timescaledb> server # [ 131.253547] postgres[1634]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 131.255113] postgres[1634]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 131.258165] postgres[1634]: vm-test-run-timescaledb> server # [ 131.266709] postgres[1634]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 131.273496] postgres[1634]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 131.274772] postgres[1634]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 131.276202] postgres[1634]: vm-test-run-timescaledb> server # [ 131.277842] postgres[1634]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 131.292262] postgres[1634]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 131.294604] postgres[1634]: "operationName" text default null, vm-test-run-timescaledb> server # [ 131.296280] postgres[1634]: query text default null, vm-test-run-timescaledb> server # [ 131.297719] postgres[1634]: variables jsonb default null, vm-test-run-timescaledb> server # [ 131.298140] postgres[1634]: extensions jsonb default null vm-test-run-timescaledb> server # [ 131.299299] postgres[1634]: ) vm-test-run-timescaledb> server # [ 131.303854] postgres[1634]: returns jsonb vm-test-run-timescaledb> server # [ 131.305133] postgres[1634]: language sql vm-test-run-timescaledb> server # [ 131.306415] postgres[1634]: as $$ vm-test-run-timescaledb> server # [ 131.307368] postgres[1634]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-timescaledb> server # [ 131.313125] postgres[1634]: $$; vm-test-run-timescaledb> server # [ 131.313854] postgres[1634]: vm-test-run-timescaledb> server # [ 131.314149] postgres[1634]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 131.314999] postgres[1634]: END IF; vm-test-run-timescaledb> server # [ 131.315550] postgres[1634]: vm-test-run-timescaledb> server # [ 131.315832] postgres[1634]: END; vm-test-run-timescaledb> server # [ 131.316144] postgres[1634]: $func$; vm-test-run-timescaledb> server # [ 131.325646] postgres[1634]: ::1 2026-10-08 04:33:45.069 UTC [1634] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-timescaledb> server # [ 131.326775] postgres[1634]: ::1 2026-10-08 04:33:45.080 UTC [1634] 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 # [ 131.328136] postgres[1634]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-timescaledb> server # [ 131.334733] postgres[1634]: ::1 2026-10-08 04:33:45.093 UTC [1634] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-timescaledb> server # [ 131.336643] postgres[1634]: ::1 2026-10-08 04:33:45.115 UTC [1634] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 131.341306] postgres[1634]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 131.342179] postgres[1634]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 131.356295] postgres[1634]: AS $func$ vm-test-run-timescaledb> server # [ 131.373602] postgres[1634]: DECLARE vm-test-run-timescaledb> server # [ 131.375479] postgres[1634]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 131.382569] postgres[1634]: BEGIN vm-test-run-timescaledb> server # [ 131.383731] postgres[1634]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 131.389483] postgres[1634]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 131.391458] postgres[1634]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 131.398022] postgres[1634]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 131.406319] postgres[1634]: ); vm-test-run-timescaledb> server # [ 131.406908] postgres[1634]: vm-test-run-timescaledb> server # [ 131.407221] postgres[1634]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 131.407630] postgres[1634]: THEN vm-test-run-timescaledb> server # [ 131.417593] postgres[1634]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 131.419423] postgres[1634]: "operationName" text default null, vm-test-run-timescaledb> server # [ 131.424822] postgres[1634]: query text default null, vm-test-run-timescaledb> server # [ 131.426080] postgres[1634]: variables jsonb default null, vm-test-run-timescaledb> server # [ 131.426800] postgres[1634]: extensions jsonb default null vm-test-run-timescaledb> server # [ 131.427128] postgres[1634]: ) vm-test-run-timescaledb> server # [ 131.427605] postgres[1634]: returns jsonb vm-test-run-timescaledb> server # [ 131.433863] postgres[1634]: language plpgsql vm-test-run-timescaledb> server # [ 131.435670] postgres[1634]: as $$ vm-test-run-timescaledb> server # [ 131.449018] postgres[1634]: DECLARE vm-test-run-timescaledb> server # [ 131.449965] postgres[1634]: server_version float; vm-test-run-timescaledb> server # [ 131.450639] postgres[1634]: BEGIN vm-test-run-timescaledb> server # [ 131.450931] postgres[1634]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 131.451551] postgres[1634]: vm-test-run-timescaledb> server # [ 131.451805] postgres[1634]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 131.457449] postgres[1634]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 131.461042] postgres[1634]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 131.463356] postgres[1634]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 131.467541] postgres[1634]: ); vm-test-run-timescaledb> server # [ 131.468205] postgres[1634]: ELSE vm-test-run-timescaledb> server # [ 131.470036] postgres[1634]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 131.470623] postgres[1634]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 131.471521] postgres[1634]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 131.473082] postgres[1634]: ); vm-test-run-timescaledb> server # [ 131.473767] postgres[1634]: END IF; vm-test-run-timescaledb> server # [ 131.474047] postgres[1634]: END; vm-test-run-timescaledb> server # [ 131.474755] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 131.475075] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping vm-test-run-timescaledb> server # [ 131.475883] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.476354] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.478163] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: COMMENT vm-test-run-timescaledb> server # [ 131.478766] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 131.479091] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping vm-test-run-timescaledb> server # [ 131.481767] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.482690] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.483779] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1633]: COMMENT vm-test-run-timescaledb> server # [ 131.489514] postgres[1634]: $$; vm-test-run-timescaledb> server # [ 131.490580] postgres[1634]: END IF; vm-test-run-timescaledb> server # [ 131.491629] postgres[1634]: vm-test-run-timescaledb> server # [ 131.492161] postgres[1634]: END; vm-test-run-timescaledb> server # [ 131.492488] postgres[1634]: $func$; vm-test-run-timescaledb> server # [ 131.498049] postgres[1634]: ::1 2026-10-08 04:33:45.188 UTC [1634] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-timescaledb> server # [ 131.510086] postgres[1634]: ::1 2026-10-08 04:33:45.201 UTC [1634] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-timescaledb> server # [ 131.511932] postgres[1634]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-timescaledb> server # [ 131.515341] postgres[1634]: ::1 2026-10-08 04:33:45.215 UTC [1634] 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 # [ 131.523896] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-timescaledb> server # [ 131.807616] postgres[1640]: ::1 2026-10-08 04:33:45.618 UTC [1640] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 131.819660] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1639]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-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 # [ 131.823315] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1639]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.824350] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1639]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-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 # [ 131.828015] postgres[1640]: ::1 2026-10-08 04:33:45.624 UTC [1640] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 131.829410] postgres[1640]: ::1 2026-10-08 04:33:45.648 UTC [1640] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 131.830048] postgres[1640]: DECLARE vm-test-run-timescaledb> server # [ 131.832198] postgres[1640]: cmd record; vm-test-run-timescaledb> server # [ 131.833976] postgres[1640]: BEGIN vm-test-run-timescaledb> server # [ 131.834808] postgres[1640]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 131.835158] postgres[1640]: LOOP vm-test-run-timescaledb> server # [ 131.835418] postgres[1640]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 131.835873] postgres[1640]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 131.836540] postgres[1640]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 131.839581] postgres[1640]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 131.840294] postgres[1640]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 131.847726] postgres[1640]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 131.856603] postgres[1640]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 131.862484] postgres[1640]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 131.863361] postgres[1640]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-timescaledb> server # [ 131.865901] postgres[1640]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 131.879877] postgres[1640]: , 'COMMENT' vm-test-run-timescaledb> server # [ 131.882711] postgres[1640]: ) vm-test-run-timescaledb> server # [ 131.883705] postgres[1640]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 131.894082] postgres[1640]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 131.894931] postgres[1640]: THEN vm-test-run-timescaledb> server # [ 131.896318] postgres[1640]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 131.902261] postgres[1640]: END IF; vm-test-run-timescaledb> server # [ 131.903233] postgres[1640]: END LOOP; vm-test-run-timescaledb> server # [ 131.905170] postgres[1640]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 131.905775] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1639]: DROP FUNCTION vm-test-run-timescaledb> server # [ 131.912857] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1639]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 131.917100] postgres[1640]: ::1 2026-10-08 04:33:45.745 UTC [1640] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 131.917819] postgres[1640]: DECLARE vm-test-run-timescaledb> server # [ 131.918306] postgres[1640]: obj record; vm-test-run-timescaledb> server # [ 131.918596] postgres[1640]: BEGIN vm-test-run-timescaledb> server # [ 131.918833] postgres[1640]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 131.920361] postgres[1640]: LOOP vm-test-run-timescaledb> server # [ 131.928757] postgres[1640]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 131.929527] postgres[1640]: 'schema' vm-test-run-timescaledb> server # [ 131.929835] postgres[1640]: , 'table' vm-test-run-timescaledb> server # [ 131.930518] postgres[1640]: , 'foreign table' vm-test-run-timescaledb> server # [ 131.932249] postgres[1640]: , 'view' vm-test-run-timescaledb> server # [ 131.932605] postgres[1640]: , 'materialized view' vm-test-run-timescaledb> server # [ 131.934083] postgres[1640]: , 'function' vm-test-run-timescaledb> server # [ 131.935016] postgres[1640]: , 'trigger' vm-test-run-timescaledb> server # [ 131.938137] postgres[1640]: , 'type' vm-test-run-timescaledb> server # [ 131.939205] postgres[1640]: , 'rule' vm-test-run-timescaledb> server # [ 131.939967] postgres[1640]: ) vm-test-run-timescaledb> server # [ 131.942300] postgres[1640]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 131.943268] postgres[1640]: THEN vm-test-run-timescaledb> server # [ 131.944578] postgres[1640]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 131.945957] postgres[1640]: END IF; vm-test-run-timescaledb> server # [ 131.947101] postgres[1640]: END LOOP; vm-test-run-timescaledb> server # [ 131.947538] postgres[1640]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 131.947995] postgres[1640]: ::1 2026-10-08 04:33:45.775 UTC [1640] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 131.951415] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1639]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 131.962577] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1639]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.963770] postgres[1640]: ::1 2026-10-08 04:33:45.793 UTC [1640] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 131.966705] postgres[1640]: ON ddl_command_end vm-test-run-timescaledb> server # [ 131.970077] postgres[1640]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 131.974667] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1639]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.977467] postgres[1640]: ::1 2026-10-08 04:33:45.804 UTC [1640] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 131.982616] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1639]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 131.990973] postgres[1640]: ::1 2026-10-08 04:33:45.820 UTC [1640] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 131.992915] postgres[1640]: ON sql_drop vm-test-run-timescaledb> server # [ 131.995224] postgres[1640]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 132.001487] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1639]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 132.062300] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-timescaledb> server # [ 132.375709] postgres[1642]: ::1 2026-10-08 04:33:46.192 UTC [1642] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-timescaledb> server # [ 132.445630] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1641]: ALTER ROLE vm-test-run-timescaledb> server # [ 132.463204] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-timescaledb> server # [ 132.836071] postgres[1653]: ::1 2026-10-08 04:33:46.653 UTC [1653] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 132.845957] postgres[1653]: returns event_trigger vm-test-run-timescaledb> server # [ 132.846973] postgres[1653]: language plpgsql vm-test-run-timescaledb> server # [ 132.849529] postgres[1653]: AS $func$ vm-test-run-timescaledb> server # [ 132.850353] postgres[1653]: DECLARE vm-test-run-timescaledb> server # [ 132.861555] postgres[1653]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 132.863227] postgres[1653]: BEGIN vm-test-run-timescaledb> server # [ 132.863999] postgres[1653]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 132.865336] postgres[1653]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 132.865961] postgres[1653]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 132.866312] postgres[1653]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 132.866605] postgres[1653]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 132.866869] postgres[1653]: ); vm-test-run-timescaledb> server # [ 132.867311] postgres[1653]: vm-test-run-timescaledb> server # [ 132.867595] postgres[1653]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 132.874630] postgres[1653]: THEN vm-test-run-timescaledb> server # [ 132.881189] postgres[1653]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 132.882785] postgres[1653]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 132.884229] postgres[1653]: vm-test-run-timescaledb> server # [ 132.895232] postgres[1653]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 132.914775] postgres[1653]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 132.921238] postgres[1653]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 132.922883] postgres[1653]: vm-test-run-timescaledb> server # [ 132.923989] postgres[1653]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 132.937167] postgres[1653]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 132.940393] postgres[1653]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 132.947948] postgres[1653]: "operationName" text default null, vm-test-run-timescaledb> server # [ 132.955389] postgres[1653]: query text default null, vm-test-run-timescaledb> server # [ 132.962808] postgres[1653]: variables jsonb default null, vm-test-run-timescaledb> server # [ 132.963336] postgres[1653]: extensions jsonb default null vm-test-run-timescaledb> server # [ 132.965433] postgres[1653]: ) vm-test-run-timescaledb> server # [ 132.967078] postgres[1653]: returns jsonb vm-test-run-timescaledb> server # [ 132.968423] postgres[1653]: language sql vm-test-run-timescaledb> server # [ 132.974389] postgres[1653]: as $$ vm-test-run-timescaledb> server # [ 132.974992] postgres[1653]: -- This changed vm-test-run-timescaledb> server # [ 132.983445] postgres[1653]: select graphql.resolve( vm-test-run-timescaledb> server # [ 132.993905] postgres[1653]: query := query, vm-test-run-timescaledb> server # [ 133.001328] postgres[1653]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 133.003530] postgres[1653]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 133.009742] postgres[1653]: extensions := extensions vm-test-run-timescaledb> server # [ 133.011516] postgres[1653]: ); vm-test-run-timescaledb> server # [ 133.012115] postgres[1653]: $$; vm-test-run-timescaledb> server # [ 133.017104] postgres[1653]: vm-test-run-timescaledb> server # [ 133.018813] postgres[1653]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 133.019213] postgres[1653]: END IF; vm-test-run-timescaledb> server # [ 133.019460] postgres[1653]: vm-test-run-timescaledb> server # [ 133.019835] postgres[1653]: END; vm-test-run-timescaledb> server # [ 133.028092] postgres[1653]: $func$; vm-test-run-timescaledb> server # [ 133.066262] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1647]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 133.067954] postgres[1653]: ::1 2026-10-08 04:33:46.881 UTC [1653] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 133.081591] postgres[1653]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 133.082993] postgres[1653]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 133.090270] postgres[1653]: AS $func$ vm-test-run-timescaledb> server # [ 133.091125] postgres[1653]: DECLARE vm-test-run-timescaledb> server # [ 133.091811] postgres[1653]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 133.092310] postgres[1653]: BEGIN vm-test-run-timescaledb> server # [ 133.098548] postgres[1653]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 133.103369] postgres[1653]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 133.104427] postgres[1653]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 133.115330] postgres[1653]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 133.116137] postgres[1653]: ); vm-test-run-timescaledb> server # [ 133.122429] postgres[1653]: vm-test-run-timescaledb> server # [ 133.122865] postgres[1653]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 133.123208] postgres[1653]: THEN vm-test-run-timescaledb> server # [ 133.123439] postgres[1653]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 133.123707] postgres[1653]: "operationName" text default null, vm-test-run-timescaledb> server # [ 133.123943] postgres[1653]: query text default null, vm-test-run-timescaledb> server # [ 133.124351] postgres[1653]: variables jsonb default null, vm-test-run-timescaledb> server # [ 133.139971] postgres[1653]: extensions jsonb default null vm-test-run-timescaledb> server # [ 133.141266] postgres[1653]: ) vm-test-run-timescaledb> server # [ 133.142280] postgres[1653]: returns jsonb vm-test-run-timescaledb> server # [ 133.142888] postgres[1653]: language plpgsql vm-test-run-timescaledb> server # [ 133.143288] postgres[1653]: as $$ vm-test-run-timescaledb> server # [ 133.143607] postgres[1653]: DECLARE vm-test-run-timescaledb> server # [ 133.143906] postgres[1653]: server_version float; vm-test-run-timescaledb> server # [ 133.145429] postgres[1653]: BEGIN vm-test-run-timescaledb> server # [ 133.146807] postgres[1653]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 133.147566] postgres[1653]: vm-test-run-timescaledb> server # [ 133.147888] postgres[1653]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 133.152956] postgres[1653]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 133.153786] postgres[1653]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 133.154129] postgres[1653]: jsonb_build_object( vm-test-run-timescaledb> server # [ 133.154411] postgres[1653]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 133.154853] postgres[1653]: ) vm-test-run-timescaledb> server # [ 133.155514] postgres[1653]: ) vm-test-run-timescaledb> server # [ 133.166167] postgres[1653]: ); vm-test-run-timescaledb> server # [ 133.167285] postgres[1653]: ELSE vm-test-run-timescaledb> server # [ 133.167889] postgres[1653]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 133.168464] postgres[1653]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 133.174340] postgres[1653]: jsonb_build_object( vm-test-run-timescaledb> server # [ 133.174970] postgres[1653]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 133.175556] postgres[1653]: ) vm-test-run-timescaledb> server # [ 133.175903] postgres[1653]: ) vm-test-run-timescaledb> server # [ 133.177696] postgres[1653]: ); vm-test-run-timescaledb> server # [ 133.179443] postgres[1653]: END IF; vm-test-run-timescaledb> server # [ 133.194656] postgres[1653]: END; vm-test-run-timescaledb> server # [ 133.195309] postgres[1653]: $$; vm-test-run-timescaledb> server # [ 133.199716] postgres[1653]: END IF; vm-test-run-timescaledb> server # [ 133.202076] postgres[1653]: vm-test-run-timescaledb> server # [ 133.202702] postgres[1653]: END; vm-test-run-timescaledb> server # [ 133.203874] postgres[1653]: $func$; vm-test-run-timescaledb> server # [ 133.210482] postgres[1653]: ::1 2026-10-08 04:33:46.949 UTC [1653] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 133.211826] postgres[1653]: "operationName" text default null, vm-test-run-timescaledb> server # [ 133.217820] postgres[1653]: query text default null, vm-test-run-timescaledb> server # [ 133.224950] postgres[1653]: variables jsonb default null, vm-test-run-timescaledb> server # [ 133.225855] postgres[1653]: extensions jsonb default null vm-test-run-timescaledb> server # [ 133.227184] postgres[1653]: ) vm-test-run-timescaledb> server # [ 133.227629] postgres[1653]: returns jsonb vm-test-run-timescaledb> server # [ 133.229846] postgres[1653]: language plpgsql vm-test-run-timescaledb> server # [ 133.230398] postgres[1653]: as $$ vm-test-run-timescaledb> server # [ 133.241074] postgres[1653]: DECLARE vm-test-run-timescaledb> server # [ 133.242357] postgres[1653]: server_version float; vm-test-run-timescaledb> server # [ 133.242804] postgres[1653]: BEGIN vm-test-run-timescaledb> server # [ 133.244315] postgres[1653]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 133.252067] postgres[1653]: vm-test-run-timescaledb> server # [ 133.254670] postgres[1653]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 133.255573] postgres[1653]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 133.255937] postgres[1653]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 133.256396] postgres[1653]: jsonb_build_object( vm-test-run-timescaledb> server # [ 133.265282] postgres[1653]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 133.267657] postgres[1653]: ) vm-test-run-timescaledb> server # [ 133.273499] postgres[1653]: ) vm-test-run-timescaledb> server # [ 133.275070] postgres[1653]: ); vm-test-run-timescaledb> server # [ 133.275910] postgres[1653]: ELSE vm-test-run-timescaledb> server # [ 133.278693] postgres[1653]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 133.279574] postgres[1653]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 133.280285] postgres[1653]: jsonb_build_object( vm-test-run-timescaledb> server # [ 133.280915] postgres[1653]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 133.290894] postgres[1653]: ) vm-test-run-timescaledb> server # [ 133.292512] postgres[1653]: ) vm-test-run-timescaledb> server # [ 133.298434] postgres[1653]: ); vm-test-run-timescaledb> server # [ 133.299920] postgres[1653]: END IF; vm-test-run-timescaledb> server # [ 133.303617] postgres[1653]: END; vm-test-run-timescaledb> server # [ 133.311901] postgres[1653]: $$; vm-test-run-timescaledb> server # [ 133.315619] postgres[1653]: ::1 2026-10-08 04:33:46.997 UTC [1653] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 133.320452] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1647]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 133.326457] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1647]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 133.327589] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1647]: psql:/nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping vm-test-run-timescaledb> server # [ 133.335921] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1647]: DROP EXTENSION vm-test-run-timescaledb> server # [ 134.986378] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1647]: DO vm-test-run-timescaledb> server # [ 135.036771] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql vm-test-run-timescaledb> server # [ 135.546225] postgres[1674]: ::1 2026-10-08 04:33:49.353 UTC [1674] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-timescaledb> server # [ 135.582472] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1669]: GRANT ROLE vm-test-run-timescaledb> server # [ 135.591648] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-timescaledb> server # [ 136.110415] postgres[1684]: ::1 2026-10-08 04:33:49.925 UTC [1684] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 136.112456] postgres[1684]: returns event_trigger vm-test-run-timescaledb> server # [ 136.114396] postgres[1684]: language plpgsql vm-test-run-timescaledb> server # [ 136.115216] postgres[1684]: AS $func$ vm-test-run-timescaledb> server # [ 136.115799] postgres[1684]: DECLARE vm-test-run-timescaledb> server # [ 136.117126] postgres[1684]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 136.117839] postgres[1684]: BEGIN vm-test-run-timescaledb> server # [ 136.120400] postgres[1684]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 136.122280] postgres[1684]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 136.125047] postgres[1684]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 136.125485] postgres[1684]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 136.125859] postgres[1684]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 136.126746] postgres[1684]: ); vm-test-run-timescaledb> server # [ 136.127031] postgres[1684]: vm-test-run-timescaledb> server # [ 136.127323] postgres[1684]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 136.129106] postgres[1684]: THEN vm-test-run-timescaledb> server # [ 136.134272] postgres[1684]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 136.134773] postgres[1684]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 136.135442] postgres[1684]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 136.136785] postgres[1684]: "operationName" text default null, vm-test-run-timescaledb> server # [ 136.137756] postgres[1684]: query text default null, vm-test-run-timescaledb> server # [ 136.144210] postgres[1684]: variables jsonb default null, vm-test-run-timescaledb> server # [ 136.153727] postgres[1684]: extensions jsonb default null vm-test-run-timescaledb> server # [ 136.154332] postgres[1684]: ) vm-test-run-timescaledb> server # [ 136.157113] postgres[1684]: returns jsonb vm-test-run-timescaledb> server # [ 136.158101] postgres[1684]: language sql vm-test-run-timescaledb> server # [ 136.159848] postgres[1684]: as $$ vm-test-run-timescaledb> server # [ 136.161789] postgres[1684]: select graphql.resolve( vm-test-run-timescaledb> server # [ 136.163677] postgres[1684]: query := query, vm-test-run-timescaledb> server # [ 136.164181] postgres[1684]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 136.167695] postgres[1684]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 136.169020] postgres[1684]: extensions := extensions vm-test-run-timescaledb> server # [ 136.170433] postgres[1684]: ); vm-test-run-timescaledb> server # [ 136.171408] postgres[1684]: $$; vm-test-run-timescaledb> server # [ 136.171745] postgres[1684]: vm-test-run-timescaledb> server # [ 136.177918] postgres[1684]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 136.185705] postgres[1684]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 136.187785] postgres[1684]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 136.189617] postgres[1684]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 136.190465] postgres[1684]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 136.191815] postgres[1684]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 136.197667] postgres[1684]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 136.198533] postgres[1684]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 136.199948] postgres[1684]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 136.203320] postgres[1684]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 136.206610] postgres[1684]: END IF; vm-test-run-timescaledb> server # [ 136.207159] postgres[1684]: vm-test-run-timescaledb> server # [ 136.207426] postgres[1684]: END; vm-test-run-timescaledb> server # [ 136.207681] postgres[1684]: $func$; vm-test-run-timescaledb> server # [ 136.292242] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1677]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 136.297889] postgres[1684]: ::1 2026-10-08 04:33:50.121 UTC [1684] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 136.410769] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1677]: DROP EXTENSION vm-test-run-timescaledb> server # [ 138.230924] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1677]: DO vm-test-run-timescaledb> server # [ 138.250968] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-timescaledb> server # [ 139.474964] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1701]: DO vm-test-run-timescaledb> server # [ 140.121228] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1701]: DO vm-test-run-timescaledb> server # [ 140.197297] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-timescaledb> server # [ 140.583933] postgres[1728]: ::1 2026-10-08 04:33:54.407 UTC [1728] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 140.598775] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1725]: ALTER ROLE vm-test-run-timescaledb> server # [ 140.643153] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-timescaledb> server # [ 140.908183] postgres[1730]: ::1 2026-10-08 04:33:54.725 UTC [1730] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-timescaledb> server # [ 140.920210] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1729]: REVOKE ROLE vm-test-run-timescaledb> server # [ 140.952843] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-timescaledb> server # [ 143.559082] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1731]: DO vm-test-run-timescaledb> server # [ 143.615168] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 144.037768] postgres[1762]: ::1 2026-10-08 04:33:57.834 UTC [1762] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-timescaledb> server # [ 144.067397] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1760]: GRANT ROLE vm-test-run-timescaledb> server # [ 144.094454] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-timescaledb> server # [ 144.391424] postgres[1764]: ::1 2026-10-08 04:33:58.217 UTC [1764] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 144.429214] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1763]: GRANT vm-test-run-timescaledb> server # [ 144.438200] postgres[1764]: ::1 2026-10-08 04:33:58.262 UTC [1764] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 144.465593] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1763]: GRANT vm-test-run-timescaledb> server # [ 144.469080] postgres[1764]: ::1 2026-10-08 04:33:58.299 UTC [1764] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 144.477547] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1763]: GRANT vm-test-run-timescaledb> server # [ 144.478374] postgres[1764]: ::1 2026-10-08 04:33:58.309 UTC [1764] 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 # [ 144.493426] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1763]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 144.497726] postgres[1764]: ::1 2026-10-08 04:33:58.326 UTC [1764] 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 # [ 144.506798] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1763]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 144.512175] postgres[1764]: ::1 2026-10-08 04:33:58.338 UTC [1764] 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 # [ 144.518989] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1763]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 144.550455] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-timescaledb> server # [ 144.831306] postgres[1766]: ::1 2026-10-08 04:33:58.656 UTC [1766] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-timescaledb> server # [ 144.847381] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1765]: GRANT ROLE vm-test-run-timescaledb> server # [ 144.890662] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 145.155682] postgres[1768]: ::1 2026-10-08 04:33:58.978 UTC [1768] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-timescaledb> server # [ 145.214437] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1767]: GRANT ROLE vm-test-run-timescaledb> server # [ 145.221359] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-timescaledb> server # [ 145.632143] postgres[1775]: ::1 2026-10-08 04:33:59.437 UTC [1775] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-timescaledb> server # [ 145.659126] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1769]: ALTER ROLE vm-test-run-timescaledb> server # [ 145.667881] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1769]: ALTER ROLE vm-test-run-timescaledb> server # [ 145.678995] postgres[1775]: ::1 2026-10-08 04:33:59.472 UTC [1775] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-timescaledb> server # [ 145.685422] postgres[1775]: ::1 2026-10-08 04:33:59.493 UTC [1775] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-timescaledb> server # [ 145.693891] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1769]: ALTER ROLE vm-test-run-timescaledb> server # [ 145.737756] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1769]: DO vm-test-run-timescaledb> server # [ 145.800655] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 146.378468] postgres[1784]: ::1 2026-10-08 04:34:00.168 UTC [1784] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-timescaledb> server # [ 146.389443] postgres[1784]: ::1 2026-10-08 04:34:00.220 UTC [1784] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-timescaledb> server # [ 146.409065] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1781]: GRANT ROLE vm-test-run-timescaledb> server # [ 146.414739] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1781]: REVOKE ROLE vm-test-run-timescaledb> server # [ 146.473246] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-timescaledb> server # [ 146.878159] postgres[1798]: ::1 2026-10-08 04:34:00.694 UTC [1798] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 146.879610] postgres[1798]: returns event_trigger vm-test-run-timescaledb> server # [ 146.889753] postgres[1798]: language plpgsql vm-test-run-timescaledb> server # [ 146.890600] postgres[1798]: AS $func$ vm-test-run-timescaledb> server # [ 146.892852] postgres[1798]: DECLARE vm-test-run-timescaledb> server # [ 146.893873] postgres[1798]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 146.894585] postgres[1798]: BEGIN vm-test-run-timescaledb> server # [ 146.894902] postgres[1798]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 146.895211] postgres[1798]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 146.895613] postgres[1798]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 146.895903] postgres[1798]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 146.899075] postgres[1798]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 146.900560] postgres[1798]: ); vm-test-run-timescaledb> server # [ 146.901845] postgres[1798]: vm-test-run-timescaledb> server # [ 146.902535] postgres[1798]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 146.903245] postgres[1798]: THEN vm-test-run-timescaledb> server # [ 146.904069] postgres[1798]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 146.906024] postgres[1798]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 146.907092] postgres[1798]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 146.907463] postgres[1798]: "operationName" text default null, vm-test-run-timescaledb> server # [ 146.907875] postgres[1798]: query text default null, vm-test-run-timescaledb> server # [ 146.909374] postgres[1798]: variables jsonb default null, vm-test-run-timescaledb> server # [ 146.910678] postgres[1798]: extensions jsonb default null vm-test-run-timescaledb> server # [ 146.911452] postgres[1798]: ) vm-test-run-timescaledb> server # [ 146.911758] postgres[1798]: returns jsonb vm-test-run-timescaledb> server # [ 146.913113] postgres[1798]: language sql vm-test-run-timescaledb> server # [ 146.914158] postgres[1798]: as $$ vm-test-run-timescaledb> server # [ 146.914491] postgres[1798]: select graphql.resolve( vm-test-run-timescaledb> server # [ 146.914962] postgres[1798]: query := query, vm-test-run-timescaledb> server # [ 146.915249] postgres[1798]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 146.917269] postgres[1798]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 146.917731] postgres[1798]: extensions := extensions vm-test-run-timescaledb> server # [ 146.918064] postgres[1798]: ); vm-test-run-timescaledb> server # [ 146.918600] postgres[1798]: $$; vm-test-run-timescaledb> server # [ 146.919259] postgres[1798]: vm-test-run-timescaledb> server # [ 146.919712] postgres[1798]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 146.920168] postgres[1798]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 146.921868] postgres[1798]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 146.923312] postgres[1798]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 146.924162] postgres[1798]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 146.926102] postgres[1798]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 146.927195] postgres[1798]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 146.929176] postgres[1798]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 146.930987] postgres[1798]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 146.934376] postgres[1798]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 146.935077] postgres[1798]: vm-test-run-timescaledb> server # [ 146.935359] postgres[1798]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-timescaledb> server # [ 146.937945] postgres[1798]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-timescaledb> server # [ 146.939140] postgres[1798]: grant usage on schema graphql to postgres with grant option; vm-test-run-timescaledb> server # [ 146.940315] postgres[1798]: END IF; vm-test-run-timescaledb> server # [ 146.941376] postgres[1798]: vm-test-run-timescaledb> server # [ 146.942034] postgres[1798]: END; vm-test-run-timescaledb> server # [ 146.943833] postgres[1798]: $func$; vm-test-run-timescaledb> server # [ 146.974484] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1792]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 146.985755] postgres[1798]: ::1 2026-10-08 04:34:00.803 UTC [1798] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 147.023171] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1792]: DROP EXTENSION vm-test-run-timescaledb> server # [ 148.727850] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1792]: DO vm-test-run-timescaledb> server # [ 148.773832] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-timescaledb> server # [ 149.267581] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1808]: DO vm-test-run-timescaledb> server # [ 149.282078] postgres[1815]: ::1 2026-10-08 04:34:03.093 UTC [1815] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-timescaledb> server # [ 149.283050] postgres[1815]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 149.284355] postgres[1815]: AS $$ vm-test-run-timescaledb> server # [ 149.287645] postgres[1815]: BEGIN vm-test-run-timescaledb> server # [ 149.290190] postgres[1815]: IF EXISTS ( vm-test-run-timescaledb> server # [ 149.291620] postgres[1815]: SELECT vm-test-run-timescaledb> server # [ 149.298597] postgres[1815]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 149.299431] postgres[1815]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 149.300357] postgres[1815]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 149.300881] postgres[1815]: WHERE ext.extname = 'pg_cron' vm-test-run-timescaledb> server # [ 149.302220] postgres[1815]: ) vm-test-run-timescaledb> server # [ 149.302594] postgres[1815]: THEN vm-test-run-timescaledb> server # [ 149.303509] postgres[1815]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 149.309935] postgres[1815]: vm-test-run-timescaledb> server # [ 149.310494] postgres[1815]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 149.310881] postgres[1815]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 149.311224] postgres[1815]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 149.311934] postgres[1815]: vm-test-run-timescaledb> server # [ 149.312885] postgres[1815]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 149.313537] postgres[1815]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 149.313874] postgres[1815]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 149.314353] postgres[1815]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 149.314654] postgres[1815]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 149.315142] postgres[1815]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 149.321440] postgres[1815]: vm-test-run-timescaledb> server # [ 149.322384] postgres[1815]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 149.322863] postgres[1815]: revoke all on table cron.job from postgres; vm-test-run-timescaledb> server # [ 149.323882] postgres[1815]: grant select on table cron.job to postgres with grant option; vm-test-run-timescaledb> server # [ 149.329564] postgres[1815]: END IF; vm-test-run-timescaledb> server # [ 149.330035] postgres[1815]: END; vm-test-run-timescaledb> server # [ 149.330398] postgres[1815]: $$; vm-test-run-timescaledb> server # [ 149.343144] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1808]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 149.343955] postgres[1815]: ::1 2026-10-08 04:34:03.175 UTC [1815] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-timescaledb> server # [ 149.365429] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1808]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 149.366488] postgres[1815]: ::1 2026-10-08 04:34:03.197 UTC [1815] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-timescaledb> server # [ 149.393794] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1808]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 149.395403] postgres[1815]: ::1 2026-10-08 04:34:03.222 UTC [1815] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-timescaledb> server # [ 149.407348] postgres[1815]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-timescaledb> server # [ 149.424850] postgres[1815]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 149.427693] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1808]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 149.460011] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-timescaledb> server # [ 149.907088] postgres[1830]: ::1 2026-10-08 04:34:03.723 UTC [1830] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-timescaledb> server # [ 149.963540] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1824]: ALTER ROLE vm-test-run-timescaledb> server # [ 149.984543] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-timescaledb> server # [ 150.363841] postgres[1832]: ::1 2026-10-08 04:34:04.186 UTC [1832] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-timescaledb> server # [ 150.390060] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1831]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 150.391287] postgres[1832]: ::1 2026-10-08 04:34:04.221 UTC [1832] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-timescaledb> server # [ 150.398516] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1831]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 150.407449] postgres[1832]: ::1 2026-10-08 04:34:04.227 UTC [1832] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-timescaledb> server # [ 150.409350] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1831]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 150.463787] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 150.754897] postgres[1834]: ::1 2026-10-08 04:34:04.577 UTC [1834] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-timescaledb> server # [ 150.770143] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1833]: GRANT ROLE vm-test-run-timescaledb> server # [ 150.807899] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-timescaledb> server # [ 151.938401] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1835]: DO vm-test-run-timescaledb> server # [ 151.982865] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-timescaledb> server # [ 152.511584] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1842]: DO vm-test-run-timescaledb> server # [ 152.522523] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1842]: DO vm-test-run-timescaledb> server # [ 152.579284] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-timescaledb> server # [ 152.969717] postgres[1861]: ::1 2026-10-08 04:34:06.772 UTC [1861] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-timescaledb> server # [ 152.996771] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1855]: ALTER ROLE vm-test-run-timescaledb> server # [ 152.998054] postgres[1861]: ::1 2026-10-08 04:34:06.813 UTC [1861] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-timescaledb> server # [ 153.009616] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1855]: ALTER ROLE vm-test-run-timescaledb> server # [ 153.012010] postgres[1861]: ::1 2026-10-08 04:34:06.838 UTC [1861] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-timescaledb> server # [ 153.025474] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1855]: ALTER ROLE vm-test-run-timescaledb> server # [ 153.070061] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-timescaledb> server # [ 153.495625] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1865]: DO vm-test-run-timescaledb> server # [ 153.537109] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-timescaledb> server # [ 153.937793] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1871]: DO vm-test-run-timescaledb> server # [ 153.980420] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-timescaledb> server # [ 154.351354] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1873]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 154.356067] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1873]: DO vm-test-run-timescaledb> server # [ 154.422728] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-timescaledb> server # [ 154.706075] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1875]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 154.712340] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1875]: GRANT vm-test-run-timescaledb> server # [ 154.761537] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-timescaledb> server # [ 155.075383] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1877]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 155.150316] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1877]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 155.157558] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1877]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 155.241853] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 155.810832] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1885]: DO vm-test-run-timescaledb> server # [ 155.911326] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-timescaledb> server # [ 156.442690] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1898]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 156.461451] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1898]: GRANT vm-test-run-timescaledb> server # [ 156.490206] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-timescaledb> server # [ 156.853479] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1906]: REVOKE ROLE vm-test-run-timescaledb> server # [ 156.883098] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1906]: DO vm-test-run-timescaledb> server # [ 156.894276] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1906]: DO vm-test-run-timescaledb> server # [ 156.913032] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1906]: REVOKE ROLE vm-test-run-timescaledb> server # [ 156.929535] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1906]: REVOKE vm-test-run-timescaledb> server # [ 156.966240] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1906]: DO vm-test-run-timescaledb> server # [ 157.021905] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 157.308202] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1909]: DO vm-test-run-timescaledb> server # [ 157.361834] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 157.803535] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1913]: DO vm-test-run-timescaledb> server # [ 157.834271] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 158.293046] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1917]: DO vm-test-run-timescaledb> server # [ 158.373606] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-timescaledb> server # [ 158.787524] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1919]: ALTER ROLE vm-test-run-timescaledb> server # [ 158.832953] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-timescaledb> server # [ 159.310876] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1931]: GRANT ROLE vm-test-run-timescaledb> server # [ 159.402495] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1931]: DO vm-test-run-timescaledb> server # [ 159.474219] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-timescaledb> server # [ 160.058353] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1946]: GRANT vm-test-run-timescaledb> server # [ 160.073364] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-timescaledb> server # [ 160.455950] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1949]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 160.456846] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1949]: REVOKE vm-test-run-timescaledb> server # [ 160.471201] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1949]: REVOKE vm-test-run-timescaledb> server # [ 160.482863] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1949]: GRANT vm-test-run-timescaledb> server # [ 160.538614] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-timescaledb> server # [ 160.829727] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1951]: DO vm-test-run-timescaledb> server # [ 160.878680] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-timescaledb> server # [ 161.147197] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1953]: ALTER ROLE vm-test-run-timescaledb> server # [ 161.189047] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-timescaledb> server # [ 161.856076] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1955]: DROP EXTENSION vm-test-run-timescaledb> server # [ 161.919116] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-timescaledb> server # [ 162.633408] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1968]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 162.635348] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1968]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 162.663981] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1968]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 162.730116] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running migration: /nix/store/mr5g4dffa9ddlvnr1z78p6vddsij51ik-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-timescaledb> server # [ 163.081956] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1980]: DO vm-test-run-timescaledb> server # [ 163.114769] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1980]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 163.168932] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Running postgresql schema... vm-test-run-timescaledb> server # [ 163.462663] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER DATABASE vm-test-run-timescaledb> server # [ 163.467741] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER DATABASE vm-test-run-timescaledb> server # [ 163.639154] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER ROLE vm-test-run-timescaledb> server # [ 163.726818] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER ROLE vm-test-run-timescaledb> server # [ 163.801632] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER ROLE vm-test-run-timescaledb> server # [ 163.902898] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER ROLE vm-test-run-timescaledb> server # [ 164.005972] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER ROLE vm-test-run-timescaledb> server # [ 164.074500] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER ROLE vm-test-run-timescaledb> server # [ 164.160901] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER ROLE vm-test-run-timescaledb> server # [ 164.246815] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER ROLE vm-test-run-timescaledb> server # [ 164.318594] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER ROLE vm-test-run-timescaledb> server # [ 164.332694] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1985]: ALTER ROLE vm-test-run-timescaledb> server # [ 164.395825] 1q9npbcmdss296g46zmk3v0k1c4khipk-supabase-db-init[1436]: Database initialization complete vm-test-run-timescaledb> server # [ 164.431001] systemd[1]: Finished Supabase Database Initialization. vm-test-run-timescaledb> server # [ 164.444218] systemd[1]: Reached target Multi-User System. vm-test-run-timescaledb> server # [ 164.453241] systemd[1]: Startup finished in 16.274s (kernel) + 2min 28.174s (userspace) = 2min 44.449s. vm-test-run-timescaledb> server: (finished: waiting for unit supabase-db-init.service, in 166.70 seconds) vm-test-run-timescaledb> subtest: Verify PostgreSQL 15 is our custom build vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT version();" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT version();", in 0.53 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.49 seconds) vm-test-run-timescaledb> (finished: subtest: Verify PostgreSQL 15 is our custom build, in 1.02 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.56 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.84 seconds) vm-test-run-timescaledb> (finished: subtest: Verify ansible config loaded, in 1.40 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.76 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.58 seconds) vm-test-run-timescaledb> (finished: subtest: Verify init scripts and migrations ran, in 1.34 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.57 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.9.1' CASCADE;" vm-test-run-timescaledb> server # WARNING: vm-test-run-timescaledb> server # WELCOME TO vm-test-run-timescaledb> server # _____ _ _ ____________ vm-test-run-timescaledb> server # |_ _(_) | | | _ \ ___ \ vm-test-run-timescaledb> server # | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ / vm-test-run-timescaledb> server # | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \ vm-test-run-timescaledb> server # | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ / vm-test-run-timescaledb> server # |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/ vm-test-run-timescaledb> server # Running version 2.9.1 vm-test-run-timescaledb> server # For more information on TimescaleDB, please visit the following links: vm-test-run-timescaledb> server # vm-test-run-timescaledb> server # 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started vm-test-run-timescaledb> server # 2. API reference documentation: https://docs.timescale.com/api/latest vm-test-run-timescaledb> server # 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts vm-test-run-timescaledb> server # vm-test-run-timescaledb> server # Note: Please enable telemetry to help us improve our product by running: ALTER DATABASE "postgres" SET timescaledb.telemetry_level = 'basic'; vm-test-run-timescaledb> server # vm-test-run-timescaledb> server # [ 176.959555] postgres[2067]: [local] 2026-10-08 04:34:30.776 UTC [2067] supabase_admin@postgres WARNING: vm-test-run-timescaledb> server # [ 176.979061] postgres[2067]: WELCOME TO vm-test-run-timescaledb> server # [ 176.979941] postgres[2067]: _____ _ _ ____________ vm-test-run-timescaledb> server # [ 176.981225] postgres[2067]: |_ _(_) | | | _ \ ___ \ vm-test-run-timescaledb> server # [ 176.996332] postgres[2067]: | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ / vm-test-run-timescaledb> server # [ 176.999026] postgres[2067]: | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \ vm-test-run-timescaledb> server # [ 177.009330] postgres[2067]: | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ / vm-test-run-timescaledb> server # [ 177.010784] postgres[2067]: |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/ vm-test-run-timescaledb> server # [ 177.011795] postgres[2067]: Running version 2.9.1 vm-test-run-timescaledb> server # [ 177.013862] postgres[2067]: For more information on TimescaleDB, please visit the following links: vm-test-run-timescaledb> server # [ 177.015140] postgres[2067]: vm-test-run-timescaledb> server # [ 177.020889] postgres[2067]: 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started vm-test-run-timescaledb> server # [ 177.036824] postgres[2067]: 2. API reference documentation: https://docs.timescale.com/api/latest vm-test-run-timescaledb> server # [ 177.037999] postgres[2067]: 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts vm-test-run-timescaledb> server # [ 177.039532] postgres[2067]: vm-test-run-timescaledb> server # [ 177.039933] postgres[2067]: 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 # [ 177.045890] postgres[2067]: vm-test-run-timescaledb> server # [ 177.046434] postgres[2067]: [local] 2026-10-08 04:34:30.776 UTC [2067] 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 7.11 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 # [ 177.690982] postgres[2133]: 2026-10-08 04:34:31.511 UTC [2133] LOG: job 2 threw an error vm-test-run-timescaledb> server # [ 177.712239] postgres[2133]: 2026-10-08 04:34:31.543 UTC [2133] ERROR: functionality not supported under the current "apache" license vm-test-run-timescaledb> server # [ 177.722062] postgres[2133]: 2026-10-08 04:34:31.543 UTC [2133] HINT: Upgrade your license to 'timescale' to use this free community feature. vm-test-run-timescaledb> server # [ 177.793375] postgres[1386]: 2026-10-08 04:34:31.614 UTC [1386] LOG: background worker "Error Log Retention Policy [2]" (PID 2133) 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.80 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 # [ 178.878615] postgres[2124]: 2026-10-08 04:34:32.700 UTC [2124] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 178.911184] postgres[1386]: 2026-10-08 04:34:32.739 UTC [1386] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2124) exited with exit code 1 vm-test-run-timescaledb> server # [ 181.555466] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 vm-test-run-timescaledb> server # [ 186.573594] postgres[2139]: 2026-10-08 04:34:40.394 UTC [2139] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 186.619176] postgres[1386]: 2026-10-08 04:34:40.441 UTC [1386] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2139) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "ALTER EXTENSION timescaledb UPDATE TO '2.16.1';" , in 9.11 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" vm-test-run-timescaledb> server # [ 187.382761] postgres[2206]: 2026-10-08 04:34:41.192 UTC [2206] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 187.391244] postgres[2206]: 2026-10-08 04:34:41.208 UTC [2206] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 187.393556] postgres[2206]: 2026-10-08 04:34:41.208 UTC [2206] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 187.429200] postgres[1386]: 2026-10-08 04:34:41.259 UTC [1386] LOG: background worker "Job History Log Retention Policy [3]" (PID 2206) exited with exit code 1 vm-test-run-timescaledb> server # [ 187.748913] systemd[1]: Starting Virtual Console Setup... 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.80 seconds) vm-test-run-timescaledb> (finished: subtest: Check upgrade path with postgresql 15, in 18.38 seconds) vm-test-run-timescaledb> subtest: Check the install of the last version of the extension vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" vm-test-run-timescaledb> server # [ 188.053734] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 188.069477] systemd[1]: Stopped Virtual Console Setup. vm-test-run-timescaledb> server # [ 188.126611] systemd[1]: Starting Virtual Console Setup... vm-test-run-timescaledb> server # [ 188.618627] postgres[2202]: 2026-10-08 04:34:42.441 UTC [2202] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 188.673578] postgres[1386]: 2026-10-08 04:34:42.498 UTC [1386] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2202) 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 2.20 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 # [ 191.363334] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-timescaledb> server # [ 192.334003] systemd[1]: Finished Virtual Console Setup. vm-test-run-timescaledb> server # [ 194.356676] systemd-logind[651]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" , in 5.59 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" vm-test-run-timescaledb> server # [ 195.935299] postgres[2266]: 2026-10-08 04:34:49.750 UTC [2266] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 195.939652] postgres[2266]: 2026-10-08 04:34:49.765 UTC [2266] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 195.942194] postgres[2266]: 2026-10-08 04:34:49.765 UTC [2266] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 195.991262] postgres[1386]: 2026-10-08 04:34:49.817 UTC [1386] LOG: background worker "Job History Log Retention Policy [3]" (PID 2266) 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.48 seconds) vm-test-run-timescaledb> (finished: subtest: Check the install of the last version of the extension, in 8.26 seconds) vm-test-run-timescaledb> (finished: run the VM test script, in 197.24 seconds) vm-test-run-timescaledb> test script finished in 197.52s vm-test-run-timescaledb> cleanup vm-test-run-timescaledb> kill machine (pid 9) vm-test-run-timescaledb> qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13) vm-test-run-timescaledb> vde_switch: EOF data port: Interrupted system call vm-test-run-timescaledb> kill vlan (pid 7) vm-test-run-timescaledb> (finished: cleanup, in 0.00 seconds) vm-test-run-timescaledb> vde_switch: Caught signal 15, cleaning up and exiting