these 12 derivations will be built: /nix/store/kwwiya284f50wn1i847nvk0f1cfw7jp9-processed-postgresql-config-15.drv /nix/store/n5finpph2l4qriwzd9vv26xz6dlysx78-postgresql-init.drv /nix/store/pfshf17j3mnqxlj0pjhwi669n3vxqnvg-unit-postgresql.service.drv /nix/store/px0vqisw5kqf8gyarnnxhcgxgprr3ra1-system-units.drv /nix/store/q4b4zy3bjlm8nc4mzhvxil03ga82j5a2-etc.drv /nix/store/5df0qwjx420mvapb1mf5qg3qflm3qqjf-activate.drv /nix/store/rbiafm92il5npybbd4c9a82hlsw4wimk-nixos-system-server-test.drv /nix/store/lsci2ph3k8hfm8pzxf6cqmml88zlbnsc-closure-info.drv /nix/store/zvnq4ykahh3wws9y6q5v619jn0i00iy6-run-nixos-vm.drv /nix/store/420gz6xginmdlmnsms7hl7sz2aagbxan-nixos-vm.drv /nix/store/7xyxx1a7xjzyi44jsb580rcgrlz5xbi7-nixos-test-driver-timescaledb.drv /nix/store/d4pbi8dx21yys1n4ck5xyfyaix961zzd-vm-test-run-timescaledb.drv building '/nix/store/kwwiya284f50wn1i847nvk0f1cfw7jp9-processed-postgresql-config-15.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/kwwiya284f50wn1i847nvk0f1cfw7jp9-processed-postgresql-config-15.drv' building '/nix/store/n5finpph2l4qriwzd9vv26xz6dlysx78-postgresql-init.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/n5finpph2l4qriwzd9vv26xz6dlysx78-postgresql-init.drv' building '/nix/store/pfshf17j3mnqxlj0pjhwi669n3vxqnvg-unit-postgresql.service.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/pfshf17j3mnqxlj0pjhwi669n3vxqnvg-unit-postgresql.service.drv' building '/nix/store/px0vqisw5kqf8gyarnnxhcgxgprr3ra1-system-units.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/px0vqisw5kqf8gyarnnxhcgxgprr3ra1-system-units.drv' building '/nix/store/q4b4zy3bjlm8nc4mzhvxil03ga82j5a2-etc.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/q4b4zy3bjlm8nc4mzhvxil03ga82j5a2-etc.drv' building '/nix/store/7xyxx1a7xjzyi44jsb580rcgrlz5xbi7-nixos-test-driver-timescaledb.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/7xyxx1a7xjzyi44jsb580rcgrlz5xbi7-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/d4pbi8dx21yys1n4ck5xyfyaix961zzd-vm-test-run-timescaledb.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/d4pbi8dx21yys1n4ck5xyfyaix961zzd-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.XpH4gRksmV', 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: 13404cd2-21a6-455f-9d3e-087a26b4a60a 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.20 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/z5hs78i44rv9q8aviydr7al3418x5y07-nixos-system-server-test/init regInfo=/nix/store/ak6d740jqnijxba0pgwygydkl6fiixk1-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-timescaledb> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/ak6d740jqnijxba0pgwygydkl6fiixk1-closure-info/registration", will be passed to user space. vm-test-run-timescaledb> server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-timescaledb> server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-timescaledb> server # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-timescaledb> server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 vm-test-run-timescaledb> server # [ 0.000000] Policy zone: Normal vm-test-run-timescaledb> server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-timescaledb> server # [ 0.000000] software IO TLB: area num 2. vm-test-run-timescaledb> server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) vm-test-run-timescaledb> server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm-test-run-timescaledb> server # [ 0.000000] allocated 8388608 bytes of page_ext vm-test-run-timescaledb> server # [ 0.000000] ftrace: allocating 72257 entries in 283 pages vm-test-run-timescaledb> server # [ 0.000000] ftrace: allocated 283 pages with 5 groups vm-test-run-timescaledb> server # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. vm-test-run-timescaledb> server # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-timescaledb> server # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-timescaledb> server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm-test-run-timescaledb> server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-timescaledb> server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-timescaledb> server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-timescaledb> server # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-timescaledb> server # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-timescaledb> server # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-timescaledb> server # [ 0.000000] GICv3: GICv3 features: 16 PPIs vm-test-run-timescaledb> server # [ 0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 vm-test-run-timescaledb> server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-timescaledb> server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-timescaledb> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100ae0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-timescaledb> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100af0000 (flat, esz 8, psz 64K, shr 1) vm-test-run-timescaledb> server # [ 0.000000] GICv3: using LPI property table @0x0000000100b00000 vm-test-run-timescaledb> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b10000 vm-test-run-timescaledb> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-timescaledb> server # [ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (virt). vm-test-run-timescaledb> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-timescaledb> server # [ 0.000038] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-timescaledb> server # [ 0.003161] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-timescaledb> server # [ 0.012490] Console: colour dummy device 80x25 vm-test-run-timescaledb> server # [ 0.013764] printk: legacy console [tty0] enabled vm-test-run-timescaledb> server # [ 0.018868] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-timescaledb> server # [ 0.019239] pid_max: default: 32768 minimum: 301 vm-test-run-timescaledb> server # [ 0.021344] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-timescaledb> server # [ 0.022625] landlock: Up and running. vm-test-run-timescaledb> server # [ 0.022672] Yama: becoming mindful. vm-test-run-timescaledb> server # [ 0.025417] LSM support for eBPF active vm-test-run-timescaledb> server # [ 0.028217] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.028881] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.056613] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-timescaledb> server # [ 0.066790] rcu: Hierarchical SRCU implementation. vm-test-run-timescaledb> server # [ 0.066884] rcu: Max phase no-delay instances is 1000. vm-test-run-timescaledb> server # [ 0.069019] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-timescaledb> server # [ 0.075451] fsl-mc MSI: its@8080000 domain created vm-test-run-timescaledb> server # [ 0.077297] EFI services will not be available. vm-test-run-timescaledb> server # [ 0.078849] smp: Bringing up secondary CPUs ... vm-test-run-timescaledb> server # [ 0.082816] Detected PIPT I-cache on CPU1 vm-test-run-timescaledb> server # [ 0.083948] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-timescaledb> server # [ 0.084730] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000 vm-test-run-timescaledb> server # [ 0.086623] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-timescaledb> server # [ 0.089712] smp: Brought up 1 node, 2 CPUs vm-test-run-timescaledb> server # [ 0.089831] SMP: Total of 2 processors activated. vm-test-run-timescaledb> server # [ 0.089867] CPU: All CPU(s) started at EL1 vm-test-run-timescaledb> server # [ 0.090019] CPU features: detected: Branch Target Identification vm-test-run-timescaledb> server # [ 0.090070] CPU features: detected: 32-bit EL0 Support vm-test-run-timescaledb> server # [ 0.090100] CPU features: detected: 32-bit EL1 Support vm-test-run-timescaledb> server # [ 0.090125] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-timescaledb> server # [ 0.090156] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-timescaledb> server # [ 0.090195] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-timescaledb> server # [ 0.090248] CPU features: detected: Common not Private translations vm-test-run-timescaledb> server # [ 0.090268] CPU features: detected: CRC32 instructions vm-test-run-timescaledb> server # [ 0.090286] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-timescaledb> server # [ 0.090309] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-timescaledb> server # [ 0.090329] CPU features: detected: Data independent timing control (DIT) vm-test-run-timescaledb> server # [ 0.090349] CPU features: detected: E0PD vm-test-run-timescaledb> server # [ 0.090365] CPU features: detected: Enhanced Counter Virtualization vm-test-run-timescaledb> server # [ 0.090384] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-timescaledb> server # [ 0.090405] CPU features: detected: Enhanced Privileged Access Never vm-test-run-timescaledb> server # [ 0.090424] CPU features: detected: Enhanced Virtualization Traps vm-test-run-timescaledb> server # [ 0.090443] CPU features: detected: Fine Grained Traps vm-test-run-timescaledb> server # [ 0.090495] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.090577] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-timescaledb> server # [ 0.090621] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-timescaledb> server # [ 0.090642] CPU features: detected: LSE atomic instructions vm-test-run-timescaledb> server # [ 0.090660] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-timescaledb> server # [ 0.090681] CPU features: detected: Privileged Access Never vm-test-run-timescaledb> server # [ 0.090699] CPU features: detected: RAS Extension Support vm-test-run-timescaledb> server # [ 0.090717] CPU features: detected: Random Number Generator vm-test-run-timescaledb> server # [ 0.090736] CPU features: detected: Speculation barrier (SB) vm-test-run-timescaledb> server # [ 0.090758] CPU features: detected: Stage-2 Force Write-Back vm-test-run-timescaledb> server # [ 0.090777] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-timescaledb> server # [ 0.090800] CPU features: detected: TLB range maintenance instructions vm-test-run-timescaledb> server # [ 0.090819] CPU features: detected: WFx with timeout vm-test-run-timescaledb> server # [ 0.090856] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-timescaledb> server # [ 0.090878] CPU features: detected: Scalable Vector Extension vm-test-run-timescaledb> server # [ 0.094843] alternatives: applying system-wide alternatives vm-test-run-timescaledb> server # [ 0.112459] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-timescaledb> server # [ 0.113003] SVE: maximum available vector length 256 bytes per vector vm-test-run-timescaledb> server # [ 0.113088] SVE: default vector length 64 bytes per vector vm-test-run-timescaledb> server # [ 0.124707] Memory: 3922868K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-timescaledb> server # [ 0.147193] devtmpfs: initialized vm-test-run-timescaledb> server # [ 0.174218] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-timescaledb> server # [ 0.174640] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.176580] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-timescaledb> server # [ 0.176627] 0 pages in range for non-PLT usage vm-test-run-timescaledb> server # [ 0.176658] 509248 pages in range for PLT usage vm-test-run-timescaledb> server # [ 0.178952] pinctrl core: initialized pinctrl subsystem vm-test-run-timescaledb> server # [ 0.187763] DMI not present or invalid. vm-test-run-timescaledb> server # [ 0.209602] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-timescaledb> server # [ 0.221721] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-timescaledb> server # [ 0.222782] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-timescaledb> server # [ 0.224030] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-timescaledb> server # [ 0.224276] audit: initializing netlink subsys (disabled) vm-test-run-timescaledb> server # [ 0.226682] audit: type=2000 audit(0.124:1): state=initialized audit_enabled=0 res=1 vm-test-run-timescaledb> server # [ 0.231154] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-timescaledb> server # [ 0.231206] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-timescaledb> server # [ 0.231258] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-timescaledb> server # [ 0.231283] thermal_sys: Registered thermal governor 'user_space' vm-test-run-timescaledb> server # [ 0.231309] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-timescaledb> server # [ 0.232026] cpuidle: using governor ladder vm-test-run-timescaledb> server # [ 0.232330] cpuidle: using governor menu vm-test-run-timescaledb> server # [ 0.234369] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-timescaledb> server # [ 0.235179] ASID allocator initialised with 65536 entries vm-test-run-timescaledb> server # [ 0.242315] Serial: AMBA PL011 UART driver vm-test-run-timescaledb> server # [ 0.284119] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-timescaledb> server # [ 0.285002] printk: legacy console [ttyAMA0] enabled vm-test-run-timescaledb> server # [ 0.315640] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.315802] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-timescaledb> server # [ 0.315890] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.316295] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-timescaledb> server # [ 0.316911] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.316999] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-timescaledb> server # [ 0.317086] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.317214] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-timescaledb> server # [ 0.329111] fbcon: Taking over console vm-test-run-timescaledb> server # [ 0.329763] ACPI: Interpreter disabled. vm-test-run-timescaledb> server # [ 0.337135] iommu: Default domain type: Translated vm-test-run-timescaledb> server # [ 0.337300] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-timescaledb> server # [ 0.358778] SCSI subsystem initialized vm-test-run-timescaledb> server # [ 0.361343] usbcore: registered new interface driver usbfs vm-test-run-timescaledb> server # [ 0.361629] usbcore: registered new interface driver hub vm-test-run-timescaledb> server # [ 0.362147] usbcore: registered new device driver usb vm-test-run-timescaledb> server # [ 0.364711] pps_core: LinuxPPS API ver. 1 registered vm-test-run-timescaledb> server # [ 0.364814] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-timescaledb> server # [ 0.365325] PTP clock support registered vm-test-run-timescaledb> server # [ 0.366869] EDAC MC: Ver: 3.0.0 vm-test-run-timescaledb> server # [ 0.369223] scmi_core: SCMI protocol bus registered vm-test-run-timescaledb> server # [ 0.371723] FPGA manager framework vm-test-run-timescaledb> server # [ 0.373050] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-timescaledb> server # [ 0.380031] vgaarb: loaded vm-test-run-timescaledb> server # [ 0.383678] clocksource: Switched to clocksource arch_sys_counter vm-test-run-timescaledb> server # [ 0.386050] VFS: Disk quotas dquot_6.6.0 vm-test-run-timescaledb> server # [ 0.386245] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-timescaledb> server # [ 0.388770] netfs: FS-Cache loaded vm-test-run-timescaledb> server # [ 0.390450] pnp: PnP ACPI: disabled vm-test-run-timescaledb> server # [ 0.409018] NET: Registered PF_INET protocol family vm-test-run-timescaledb> server # [ 0.410150] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-timescaledb> server # [ 0.506486] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.506894] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.507285] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.509118] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-timescaledb> server # [ 0.509798] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-timescaledb> server # [ 0.511418] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-timescaledb> server # [ 0.512188] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.512958] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.514424] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-timescaledb> server # [ 0.514865] NET: Registered PF_XDP protocol family vm-test-run-timescaledb> server # [ 0.515170] PCI: CLS 0 bytes, default 64 vm-test-run-timescaledb> server # [ 0.518172] Trying to unpack rootfs image as initramfs... vm-test-run-timescaledb> server # [ 0.529599] kvm [1]: HYP mode not available vm-test-run-timescaledb> server # [ 0.618941] Initialise system trusted keyrings vm-test-run-timescaledb> server # [ 0.620923] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-timescaledb> server # [ 0.624234] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-timescaledb> server # [ 0.625498] 9p: Installing v9fs 9p2000 file system support vm-test-run-timescaledb> server # [ 0.675852] Key type asymmetric registered vm-test-run-timescaledb> server # [ 0.676063] Asymmetric key parser 'x509' registered vm-test-run-timescaledb> server # [ 0.676820] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-timescaledb> server # [ 0.678460] io scheduler mq-deadline registered vm-test-run-timescaledb> server # [ 0.678624] io scheduler kyber registered vm-test-run-timescaledb> server # [ 0.702918] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-timescaledb> server # [ 0.708162] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-timescaledb> server # [ 0.712553] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-timescaledb> server # [ 0.713194] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-timescaledb> server # [ 0.714075] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-timescaledb> server # [ 0.714748] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-timescaledb> server # [ 0.715253] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-timescaledb> server # [ 0.716664] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-timescaledb> server # [ 0.718010] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-timescaledb> server # [ 0.718354] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-timescaledb> server # [ 0.718858] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.719307] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.719429] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.721383] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.724145] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.724740] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.724887] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.725106] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.725246] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.726316] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.726664] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.726939] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.727334] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.728772] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.729051] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.729279] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.729691] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.730543] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.730858] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.730947] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.731366] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.732508] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.732750] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.732865] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.732977] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.733767] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.734242] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-timescaledb> server # [ 0.734468] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.734584] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.735135] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.735378] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.735518] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.736416] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.736543] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.737628] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.737837] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.737955] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.738362] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.738827] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.739139] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.740487] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.740920] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.741565] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.741979] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.742214] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.742315] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.742752] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.742885] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.742973] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.743071] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.745239] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.745503] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.745848] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.746407] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.746807] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.747093] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.747361] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.747821] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.748269] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.749396] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.749681] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.749816] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.750246] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.750682] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-timescaledb> server # [ 0.750796] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-timescaledb> server # [ 0.750894] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-timescaledb> server # [ 0.750991] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-timescaledb> server # [ 0.751088] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-timescaledb> server # [ 0.751188] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-timescaledb> server # [ 0.751287] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-timescaledb> server # [ 0.751380] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-timescaledb> server # [ 0.751475] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-timescaledb> server # [ 0.752422] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-timescaledb> server # [ 0.752601] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-timescaledb> server # [ 0.752706] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-timescaledb> server # [ 0.752814] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-timescaledb> server # [ 0.752925] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-timescaledb> server # [ 0.753161] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-timescaledb> server # [ 0.753308] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-timescaledb> server # [ 0.753400] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-timescaledb> server # [ 0.753489] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-timescaledb> server # [ 0.753693] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-timescaledb> server # [ 0.753799] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-timescaledb> server # [ 0.753893] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-timescaledb> server # [ 0.754557] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.755117] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.755343] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.756513] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.804232] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.808842] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.811754] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.814054] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.815947] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.818709] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.820995] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.824276] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.826037] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.828208] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.830083] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.846824] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-timescaledb> server # [ 0.855760] msm_serial: driver initialized vm-test-run-timescaledb> server # [ 0.857221] SuperH (H)SCI(F) driver initialized vm-test-run-timescaledb> server # [ 0.857606] STM32 USART driver initialized vm-test-run-timescaledb> server # [ 0.905562] Freeing initrd memory: 10684K vm-test-run-timescaledb> server # [ 0.908834] loop: module loaded vm-test-run-timescaledb> server # [ 0.910580] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-timescaledb> server # [ 0.914923] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-timescaledb> server # [ 0.928217] megasas: 07.727.03.00-rc1 vm-test-run-timescaledb> server # [ 0.934525] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-timescaledb> server # [ 0.938151] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 0.938930] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 0.941910] Using buffer write method vm-test-run-timescaledb> server # [ 0.943174] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-timescaledb> server # [ 0.946607] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 0.947067] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 0.950607] Using buffer write method vm-test-run-timescaledb> server # [ 0.950866] Concatenating MTD devices: vm-test-run-timescaledb> server # [ 0.950954] (0): "0.flash" vm-test-run-timescaledb> server # [ 0.951013] (1): "0.flash" vm-test-run-timescaledb> server # [ 0.951067] into device "0.flash" vm-test-run-timescaledb> server # [ 0.975309] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-timescaledb> server # [ 0.988562] thunder_xcv, ver 1.0 vm-test-run-timescaledb> server # [ 0.988811] thunder_bgx, ver 1.0 vm-test-run-timescaledb> server # [ 0.989434] nicpf, ver 1.0 vm-test-run-timescaledb> server # [ 0.993878] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-timescaledb> server # [ 0.994081] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-timescaledb> server # [ 0.994442] hclge is initializing vm-test-run-timescaledb> server # [ 0.994965] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 0.995080] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-timescaledb> server # [ 0.995503] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 0.995945] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-timescaledb> server # [ 0.997201] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-timescaledb> server # [ 0.997298] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-timescaledb> server # [ 0.997720] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-timescaledb> server # [ 0.997816] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-timescaledb> server # [ 0.999310] sky2: driver version 1.30 vm-test-run-timescaledb> server # [ 1.008475] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-timescaledb> server # [ 1.008683] usbcore: registered new interface driver usb-storage vm-test-run-timescaledb> server # [ 1.009503] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-timescaledb> server # [ 1.010076] usbcore: registered new interface driver usbserial_generic vm-test-run-timescaledb> server # [ 1.010740] usbserial: USB Serial support registered for generic vm-test-run-timescaledb> server # [ 1.013667] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-timescaledb> server # [ 1.022640] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-timescaledb> server # [ 1.023298] rtc-pl031 9010000.pl031: setting system clock to 2026-10-07T19:31:11 UTC (1791401471) vm-test-run-timescaledb> server # [ 1.025939] i2c_dev: i2c /dev entries driver vm-test-run-timescaledb> server # [ 1.028308] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-timescaledb> server # [ 1.036740] hub 1-0:1.0: USB hub found vm-test-run-timescaledb> server # [ 1.038445] hub 1-0:1.0: 6 ports detected vm-test-run-timescaledb> server # [ 1.044857] sdhci: Secure Digital Host Controller Interface driver vm-test-run-timescaledb> server # [ 1.045009] sdhci: Copyright(c) Pierre Ossman vm-test-run-timescaledb> server # [ 1.047027] Synopsys Designware Multimedia Card Interface Driver vm-test-run-timescaledb> server # [ 1.050940] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-timescaledb> server # [ 1.058230] hid: raw HID events driver (C) Jiri Kosina vm-test-run-timescaledb> server # [ 1.060456] usbcore: registered new interface driver usbhid vm-test-run-timescaledb> server # [ 1.060588] usbhid: USB HID core driver vm-test-run-timescaledb> server # [ 1.068619] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-timescaledb> server # [ 1.081548] drop_monitor: Initializing network drop monitor service vm-test-run-timescaledb> server # [ 1.083733] NET: Registered PF_INET6 protocol family vm-test-run-timescaledb> server # [ 1.101133] Segment Routing with IPv6 vm-test-run-timescaledb> server # [ 1.101727] In-situ OAM (IOAM) with IPv6 vm-test-run-timescaledb> server # [ 1.102681] NET: Registered PF_PACKET protocol family vm-test-run-timescaledb> server # [ 1.105123] 9pnet: Installing 9P2000 support vm-test-run-timescaledb> server # [ 1.111022] Key type dns_resolver registered vm-test-run-timescaledb> server # [ 1.143566] registered taskstats version 1 vm-test-run-timescaledb> server # [ 1.146455] Loading compiled-in X.509 certificates vm-test-run-timescaledb> server # [ 1.197785] Demotion targets for Node 0: null vm-test-run-timescaledb> server # [ 1.200586] Key type .fscrypt registered vm-test-run-timescaledb> server # [ 1.200716] Key type fscrypt-provisioning registered vm-test-run-timescaledb> server # [ 1.210410] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-timescaledb> server # [ 1.250320] clk: Disabling unused clocks vm-test-run-timescaledb> server # [ 1.251191] PM: genpd: Disabling unused power domains vm-test-run-timescaledb> server # [ 1.251517] ALSA device list: vm-test-run-timescaledb> server # [ 1.252939] No soundcards found. vm-test-run-timescaledb> server # [ 1.292936] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-timescaledb> server # [ 1.332689] Freeing unused kernel memory: 4416K vm-test-run-timescaledb> server # [ 1.334677] Run /init as init process vm-test-run-timescaledb> server # [ 1.522339] 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.676735] 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.812440] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-timescaledb> server # [ 1.982879] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-timescaledb> server # [ 2.063481] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 vm-test-run-timescaledb> server # [ 2.086904] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 vm-test-run-timescaledb> server # [ 2.140089] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-timescaledb> server # [ 2.141800] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-timescaledb> server # [ 2.141833] [drm] features: -context_init vm-test-run-timescaledb> server # [ 2.144532] [drm] number of scanouts: 1 vm-test-run-timescaledb> server # [ 2.145550] [drm] number of cap sets: 0 vm-test-run-timescaledb> server # [ 2.156243] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-timescaledb> server # [ 2.189574] Console: switching to colour frame buffer device 160x50 vm-test-run-timescaledb> server # [ 2.200504] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-timescaledb> server # [ 4.795129] EXT4-fs (vda): mounted filesystem 13404cd2-21a6-455f-9d3e-087a26b4a60a r/w with ordered data mode. Quota mode: none. vm-test-run-timescaledb> server # [ 6.998296] EXT4-fs (vda): re-mounted 13404cd2-21a6-455f-9d3e-087a26b4a60a. vm-test-run-timescaledb> server # [ 7.015064] booting system configuration /nix/store/z5hs78i44rv9q8aviydr7al3418x5y07-nixos-system-server-test vm-test-run-timescaledb> server # [ 17.507119] 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.518345] systemd[1]: Detected virtualization qemu. vm-test-run-timescaledb> server # [ 17.523082] systemd[1]: Detected architecture arm64. vm-test-run-timescaledb> server # [ 17.527847] systemd[1]: Detected first boot. vm-test-run-timescaledb> server # [ 17.562007] systemd[1]: Initializing machine ID from random generator. vm-test-run-timescaledb> server # [ 17.595323] systemd[1]: Hostname set to . vm-test-run-timescaledb> server # [ 18.846311] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-timescaledb> server # [ 20.072656] systemd[1]: Applying preset policy. vm-test-run-timescaledb> server # [ 23.171440] systemd[1]: Populated /etc with preset unit settings. vm-test-run-timescaledb> server # [ 26.958089] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-timescaledb> server # [ 27.206854] systemd[1]: Created slice Slice /system/getty. vm-test-run-timescaledb> server # [ 27.222042] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-timescaledb> server # [ 27.234574] systemd[1]: Created slice User and Session Slice. vm-test-run-timescaledb> server # [ 27.244192] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-timescaledb> server # [ 27.249504] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-timescaledb> server # [ 27.256381] systemd[1]: Expecting device /dev/hvc0... vm-test-run-timescaledb> server # [ 27.261589] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-timescaledb> server # [ 27.266607] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-timescaledb> server # [ 27.273084] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-timescaledb> server # [ 27.277462] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-timescaledb> server # [ 27.282492] systemd[1]: Reached target Path Units. vm-test-run-timescaledb> server # [ 27.288166] systemd[1]: Reached target Remote File Systems. vm-test-run-timescaledb> server # [ 27.292903] systemd[1]: Reached target Slice Units. vm-test-run-timescaledb> server # [ 27.298201] systemd[1]: Reached target Swaps. vm-test-run-timescaledb> server # [ 27.336278] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-timescaledb> server # [ 27.366752] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-timescaledb> server # [ 27.380519] systemd[1]: Listening on Journal Audit Socket. vm-test-run-timescaledb> server # [ 27.387136] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-timescaledb> server # [ 27.393890] systemd[1]: Listening on Journal Sockets. vm-test-run-timescaledb> server # [ 27.403026] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-timescaledb> server # [ 27.409478] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 27.415454] systemd[1]: Listening on udev Control Socket. vm-test-run-timescaledb> server # [ 27.422300] systemd[1]: Listening on udev Kernel Socket. vm-test-run-timescaledb> server # [ 27.481598] systemd[1]: Mounting Huge Pages File System... vm-test-run-timescaledb> server # [ 27.525784] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-timescaledb> server # [ 27.570243] systemd[1]: Mounting Kernel Debug File System... vm-test-run-timescaledb> server # [ 27.637138] systemd[1]: Mounting Kernel Trace File System... vm-test-run-timescaledb> server # [ 27.773013] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-timescaledb> server # [ 27.897810] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-timescaledb> server # [ 27.912846] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-timescaledb> server # [ 28.038613] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-timescaledb> server # [ 28.062200] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-timescaledb> server # [ 28.093526] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-timescaledb> server # [ 28.207616] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-timescaledb> server # [ 28.223953] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-timescaledb> server # [ 28.243383] 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 # [ 28.413609] systemd[1]: Starting Journal Service... vm-test-run-timescaledb> server # [ 28.510426] systemd[1]: Starting Load Kernel Modules... vm-test-run-timescaledb> server # [ 28.593627] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-timescaledb> server # [ 28.666696] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-timescaledb> server # [ 28.673750] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 28.757735] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-timescaledb> server # [ 28.840807] systemd[1]: Mounted Huge Pages File System. vm-test-run-timescaledb> server # [ 28.860393] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-timescaledb> server # [ 28.883283] systemd[1]: Mounted Kernel Debug File System. vm-test-run-timescaledb> server # [ 28.898169] systemd[1]: Mounted Kernel Trace File System. vm-test-run-timescaledb> server # [ 28.925494] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-timescaledb> server # [ 28.950900] systemd[1]: Mounted Kernel Configuration File System. 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.055045] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-timescaledb> server # [ 29.501920] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 29.517254] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-timescaledb> server # [ 29.989600] EXT4-fs (vda): re-mounted 13404cd2-21a6-455f-9d3e-087a26b4a60a. vm-test-run-timescaledb> server # [ 30.032322] fuse: init (API version 7.41) vm-test-run-timescaledb> server # [ 30.045098] systemd[1]: Finished Load Kernel Modules. vm-test-run-timescaledb> server # [ 30.130504] systemd[1]: Starting Firewall... vm-test-run-timescaledb> server # [ 30.192596] systemd[1]: Starting Apply Kernel Variables... vm-test-run-timescaledb> server # [ 30.207839] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 30.224714] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-timescaledb> server # [ 30.248932] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-timescaledb> server # [ 30.308959] systemd[1]: Mounting FUSE Control File System... vm-test-run-timescaledb> server # [ 30.318521] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-timescaledb> server # [ 30.388503] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-timescaledb> server # [ 30.395404] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 30.635873] systemd[1]: Mounted FUSE Control File System. vm-test-run-timescaledb> server # [ 30.775428] systemd-journald[396]: Collecting audit messages is enabled. vm-test-run-timescaledb> server # [ 31.462433] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-timescaledb> server # [ 31.477039] systemd[1]: Reached target First Boot Complete. vm-test-run-timescaledb> server # [ 31.893156] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-timescaledb> server # [ 31.964542] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-timescaledb> server # [ 31.994696] systemd[1]: Finished Apply Kernel Variables. vm-test-run-timescaledb> server # [ 32.233288] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-timescaledb> server # [ 33.022412] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-timescaledb> server # [ 33.061229] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-timescaledb> server # [ 33.110947] systemd[1]: Mounting /run/wrappers... vm-test-run-timescaledb> server # [ 33.152850] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-timescaledb> server # [ 33.610890] systemd[1]: Mounted /run/wrappers. vm-test-run-timescaledb> server # [ 33.624722] systemd[1]: Reached target Local File Systems. vm-test-run-timescaledb> server # [ 33.660578] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-timescaledb> server # [ 33.716238] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-timescaledb> server # [ 33.719624] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-timescaledb> server # [ 33.567791] systemd-modules-load[397]: Module 'atkbd' is built in vm-test-run-timescaledb> server # [ 33.786646] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-timescaledb> server # [ 33.614326] systemd-modules-load[397]: Module 'loop' is built in vm-test-run-timescaledb> server # [ 33.802040] systemd[1]: Started Journal Service. vm-test-run-timescaledb> server # [ 33.675855] systemd-oomd[398]: No swap; memory pressure usage will be degraded vm-test-run-timescaledb> server # [ 33.758833] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-timescaledb> server # [ 34.882316] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-timescaledb> server # [ 35.075628] systemd-journald[396]: Received client request to flush runtime journal. vm-test-run-timescaledb> server # [ 35.411251] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-timescaledb> server # [ 35.491213] systemd-udevd[424]: Using default interface naming scheme 'v258'. vm-test-run-timescaledb> server # [ 35.525275] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-timescaledb> server # [ 35.555710] systemd[1]: Starting Create System Files and Directories... vm-test-run-timescaledb> server # [ 37.585144] systemd[1]: Finished Create System Files and Directories. vm-test-run-timescaledb> server # [ 37.640473] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-timescaledb> server # [ 37.698860] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-timescaledb> server # [ 37.843797] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-timescaledb> server # [ 38.940570] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-timescaledb> server # [ 40.078485] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-timescaledb> server # [ 40.111901] systemd[1]: Starting Update is Completed... vm-test-run-timescaledb> server # [ 41.087244] systemd[1]: Finished Update is Completed. vm-test-run-timescaledb> server # [ 45.647472] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 45.668602] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-timescaledb> server # [ 45.673539] systemd[1]: suid-sgid-wrappers.service: Consumed 3.224s CPU time, 5.6M memory peak. vm-test-run-timescaledb> server # [ 48.449720] systemd[1]: Finished Firewall. vm-test-run-timescaledb> server # [ 50.243237] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-timescaledb> server # [ 50.262325] systemd[1]: Reached target System Initialization. vm-test-run-timescaledb> server # [ 50.273054] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-timescaledb> server # [ 50.276327] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-timescaledb> server # [ 50.292783] systemd[1]: Reached target Timer Units. vm-test-run-timescaledb> server # [ 50.299045] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-timescaledb> server # [ 50.303152] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-timescaledb> server # [ 50.310689] systemd[1]: Listening on Hostname Service Socket. vm-test-run-timescaledb> server # [ 50.322030] systemd[1]: Reached target Socket Units. vm-test-run-timescaledb> server # [ 50.325727] systemd[1]: Reached target Basic System. vm-test-run-timescaledb> server # [ 50.338836] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-timescaledb> server # [ 50.378643] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 50.438294] systemd[1]: Started Reset console on configuration changes. vm-test-run-timescaledb> server # [ 50.515694] systemd[1]: Starting resolvconf update... vm-test-run-timescaledb> server # [ 50.601401] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-timescaledb> server # [ 51.966763] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-timescaledb> server # [ 52.102788] nsncd[631]: Oct 07 19:32:02.694 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 52.120494] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 52.135025] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 52.144234] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 52.210551] systemd[1]: Starting User Login Management... vm-test-run-timescaledb> server # [ 52.280375] dbus-daemon[634]: dbus[634]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-timescaledb> server # [ 52.894014] systemd[1]: Started D-Bus System Message Bus. vm-test-run-timescaledb> server # [ 53.830185] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 53.835957] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-timescaledb> server # [ 53.849892] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 53.884943] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-timescaledb> server # [ 53.894686] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 53.932949] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 53.948356] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 54.087751] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 54.114690] systemd-logind[653]: New seat seat0. vm-test-run-timescaledb> server # [ 54.208825] systemd[1]: Started User Login Management. vm-test-run-timescaledb> server # [ 54.256721] systemd[1]: Starting linger-users.service... vm-test-run-timescaledb> server # [ 54.946763] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 54.961823] systemd[1]: Finished linger-users.service. vm-test-run-timescaledb> server # [ 55.109604] nsncd[690]: Oct 07 19:32:05.739 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 55.117459] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 55.129448] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 55.143260] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 55.744400] systemd[1]: Finished resolvconf update. vm-test-run-timescaledb> server # [ 55.769158] systemd[1]: Reached target Preparation for Network. vm-test-run-timescaledb> server # [ 55.805751] systemd[1]: Starting DHCP Client... vm-test-run-timescaledb> server # [ 57.582133] dhcpcd[742]: dhcpcd-10.2.4 starting vm-test-run-timescaledb> server # [ 57.659248] dhcpcd[766]: dev: loaded udev vm-test-run-timescaledb> server # [ 58.140144] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-timescaledb> server # [ 58.609529] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-timescaledb> server # [ 58.885942] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-timescaledb> server # [ 58.891239] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-timescaledb> server # [ 58.925670] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-timescaledb> server # [ 58.940045] cfg80211: failed to load regulatory.db vm-test-run-timescaledb> server: Guest root shell did not produce any data yet... vm-test-run-timescaledb> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-timescaledb> server # [ 59.646022] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-timescaledb> server # [ 59.482236] dhcpcd[766]: eth0: waiting for carrier vm-test-run-timescaledb> server # [ 59.494123] dhcpcd[766]: libudev: received NULL device vm-test-run-timescaledb> server # [ 59.499995] dhcpcd[766]: libudev: received NULL device vm-test-run-timescaledb> server # [ 59.507770] dhcpcd[766]: eth0: carrier acquired vm-test-run-timescaledb> server # [ 59.623814] dhcpcd[766]: DUID 00:01:00:01:32:59:5a:ba:52:54:00:12:34:56 vm-test-run-timescaledb> server # [ 59.629167] dhcpcd[766]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 59.633105] dhcpcd[766]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-timescaledb> server # [ 60.579972] systemd[1]: Found device /dev/hvc0. vm-test-run-timescaledb> server # [ 60.951457] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-timescaledb> server # [ 60.975800] systemd[1]: Started backdoor.service. vm-test-run-timescaledb> server # [ 61.126755] dhcpcd[766]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 61.139054] dhcpcd[766]: eth0: Router Advertisement from fe80::2 vm-test-run-timescaledb> server # [ 61.149949] dhcpcd[766]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-timescaledb> server # [ 61.153071] dhcpcd[766]: eth0: adding route to fec0::/64 vm-test-run-timescaledb> server # [ 61.162965] dhcpcd[766]: eth0: adding default route via fe80::2 vm-test-run-timescaledb> server # [ 61.215809] dhcpcd[766]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 61.218957] dhcpcd[766]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 61.241377] dhcpcd[766]: eth0: probing address 10.0.2.15/24 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 62.96 seconds) vm-test-run-timescaledb> server: (finished: waiting for the VM to finish booting, in 62.96 seconds) vm-test-run-timescaledb> server # [ 62.161647] (udev-worker)[784]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 62.251243] (udev-worker)[788]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-timescaledb> server # [ 62.269655] (udev-worker)[788]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 62.958319] dhcpcd[766]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 63.002013] systemd[1]: Found device Virtio network device. vm-test-run-timescaledb> server # [ 63.071883] systemd[1]: Starting Address configuration of eth1... vm-test-run-timescaledb> server # [ 63.974813] dhcpcd[766]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 64.322850] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-timescaledb> server # [ 64.383724] network-addresses-eth1-start[817]: adding address 192.168.1.1/24... done vm-test-run-timescaledb> server # [ 64.551287] network-addresses-eth1-start[817]: adding address 2001:db8:1::1/64... done vm-test-run-timescaledb> server # [ 64.811066] systemd[1]: Finished Address configuration of eth1. vm-test-run-timescaledb> server # [ 64.907189] systemd[1]: Starting Networking Setup... vm-test-run-timescaledb> server # [ 65.053657] dhcpcd[766]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 65.054631] dhcpcd[766]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 65.055109] dhcpcd[766]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 67.033658] dhcpcd[766]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-timescaledb> server # [ 67.042347] dhcpcd[766]: eth0: adding route to 10.0.2.0/24 vm-test-run-timescaledb> server # [ 67.048238] dhcpcd[766]: eth0: adding default route via 10.0.2.2 vm-test-run-timescaledb> server # [ 67.546578] systemd[1]: Finished Networking Setup. vm-test-run-timescaledb> server # [ 67.566677] systemd[1]: Reached target Network. vm-test-run-timescaledb> server # [ 67.603629] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-timescaledb> server # [ 67.689385] systemd[1]: Starting Permit User Sessions... vm-test-run-timescaledb> server # [ 68.635411] systemd[1]: Finished Permit User Sessions. vm-test-run-timescaledb> server # [ 68.691666] systemd[1]: Started Getty on tty1. vm-test-run-timescaledb> server # [ 68.703223] systemd[1]: Reached target Login Prompts. vm-test-run-timescaledb> server # [ 69.882366] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[961]: Initializing database at /var/lib/postgresql/data vm-test-run-timescaledb> server # [ 71.686938] systemd[1]: Started DHCP Client. vm-test-run-timescaledb> server # [ 71.799535] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: The files belonging to this database system will be owned by user "postgres". vm-test-run-timescaledb> server # [ 71.805929] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: This user must also own the server process. vm-test-run-timescaledb> server # [ 71.905079] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-timescaledb> server # [ 71.906574] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: The default database encoding has accordingly been set to "UTF8". vm-test-run-timescaledb> server # [ 71.907197] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: The default text search configuration will be set to "english". vm-test-run-timescaledb> server # [ 71.907679] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: Data page checksums are enabled. vm-test-run-timescaledb> server # [ 71.908084] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-timescaledb> server # [ 71.949333] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: creating subdirectories ... ok vm-test-run-timescaledb> server # [ 71.971521] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: selecting dynamic shared memory implementation ... posix vm-test-run-timescaledb> server # [ 73.223114] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: selecting default max_connections ... 100 vm-test-run-timescaledb> server # [ 73.814883] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: selecting default shared_buffers ... 128MB vm-test-run-timescaledb> server # [ 83.141880] systemd-logind[653]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-timescaledb> server # [ 86.150580] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: selecting default time zone ... UTC vm-test-run-timescaledb> server # [ 86.206586] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: creating configuration files ... ok vm-test-run-timescaledb> server # [ 91.385282] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: running bootstrap script ... ok vm-test-run-timescaledb> server # [ 92.373367] mousedev: PS/2 mouse device common for all mice vm-test-run-timescaledb> server # [ 96.497427] systemd-logind[653]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-timescaledb> server # [ 105.915413] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: performing post-bootstrap initialization ... ok vm-test-run-timescaledb> server # [ 108.743348] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: syncing data to disk ... ok vm-test-run-timescaledb> server # [ 108.754566] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-timescaledb> server # [ 108.761164] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: 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 # [ 108.770267] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: Success. You can now start the database server using: vm-test-run-timescaledb> server # [ 108.775815] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[976]: /nix/store/2bhdbvpk81xy3mkfgqrpc719ip588cba-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-timescaledb> server # [ 110.377717] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[961]: Validating PostgreSQL configuration... vm-test-run-timescaledb> server # [ 111.051791] 6sn1lvrylkdppzzwa910vl3ymwjn1zwg-postgresql-init[1361]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault vm-test-run-timescaledb> server # [ 112.465715] postgres[1374]: 2026-10-07 19:33:03.092 UTC [1374] LOG: pgaudit extension initialized vm-test-run-timescaledb> server # [ 113.318781] postgres[1374]: 2026-10-07 19:33:03.974 UTC [1374] LOG: pgsodium primary server secret key loaded vm-test-run-timescaledb> server # [ 113.945623] postgres[1374]: 2026-10-07 19:33:04.582 UTC [1374] LOG: vault primary server secret key loaded vm-test-run-timescaledb> server # [ 114.721863] postgres[1374]: 2026-10-07 19:33:05.377 UTC [1374] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-timescaledb> server # [ 114.747818] postgres[1374]: 2026-10-07 19:33:05.400 UTC [1374] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-timescaledb> server # [ 114.757553] postgres[1374]: 2026-10-07 19:33:05.409 UTC [1374] LOG: listening on IPv6 address "::", port 5432 vm-test-run-timescaledb> server # [ 114.795291] postgres[1374]: 2026-10-07 19:33:05.446 UTC [1374] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-timescaledb> server # [ 115.067997] postgres[1415]: 2026-10-07 19:33:05.706 UTC [1415] LOG: database system was shut down at 2026-10-07 19:32:56 UTC vm-test-run-timescaledb> server # [ 115.575902] postgres[1424]: 2026-10-07 19:33:06.221 UTC [1424] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-timescaledb> server # [ 115.608305] postgres[1374]: 2026-10-07 19:33:06.223 UTC [1374] LOG: database system is ready to accept connections vm-test-run-timescaledb> server # [ 115.689122] postgres[1426]: 2026-10-07 19:33:06.245 UTC [1426] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 115.692343] systemd[1]: Started PostgreSQL Database Server. vm-test-run-timescaledb> server # [ 115.758051] systemd[1]: Starting Supabase Database Initialization... vm-test-run-timescaledb> server # [ 115.913155] postgres[1374]: 2026-10-07 19:33:06.567 UTC [1374] LOG: background worker "pg_net 0.20.4 worker" (PID 1426) exited with exit code 1 vm-test-run-timescaledb> server # [ 116.099878] postgres[1429]: 2026-10-07 19:33:06.743 UTC [1429] LOG: pg_cron scheduler started vm-test-run-timescaledb> server # [ 116.131042] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Waiting for PostgreSQL to be ready... vm-test-run-timescaledb> server # [ 116.700618] postgres[1439]: ::1 2026-10-07 19:33:07.335 UTC [1439] root@root FATAL: role "root" does not exist vm-test-run-timescaledb> server # [ 116.760911] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: PostgreSQL is ready vm-test-run-timescaledb> server # [ 116.765244] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Creating postgres role... vm-test-run-timescaledb> server # [ 117.028724] postgres[1443]: 2026-10-07 19:33:07.674 UTC [1443] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 117.134366] postgres[1374]: 2026-10-07 19:33:07.784 UTC [1374] LOG: background worker "pg_net 0.20.4 worker" (PID 1443) exited with exit code 1 vm-test-run-timescaledb> server # [ 117.331251] postgres[1444]: ::1 2026-10-07 19:33:07.977 UTC [1444] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-timescaledb> server # [ 117.381997] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1442]: CREATE ROLE vm-test-run-timescaledb> server # [ 117.771785] postgres[1447]: ::1 2026-10-07 19:33:08.413 UTC [1447] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-timescaledb> server # [ 117.874137] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: ALTER DATABASE vm-test-run-timescaledb> server # [ 117.916839] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-timescaledb> server # [ 118.402375] postgres[1460]: ::1 2026-10-07 19:33:09.032 UTC [1460] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-timescaledb> server # [ 118.453955] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: CREATE PUBLICATION vm-test-run-timescaledb> server # [ 118.457987] postgres[1460]: ::1 2026-10-07 19:33:09.092 UTC [1460] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-timescaledb> server # [ 118.459309] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: ALTER ROLE vm-test-run-timescaledb> server # [ 118.466173] postgres[1460]: ::1 2026-10-07 19:33:09.118 UTC [1460] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-timescaledb> server # [ 118.474707] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: CREATE ROLE vm-test-run-timescaledb> server # [ 118.481881] postgres[1460]: ::1 2026-10-07 19:33:09.137 UTC [1460] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-timescaledb> server # [ 118.493324] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: CREATE ROLE vm-test-run-timescaledb> server # [ 118.495378] postgres[1460]: ::1 2026-10-07 19:33:09.145 UTC [1460] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-timescaledb> server # [ 118.510418] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: GRANT ROLE vm-test-run-timescaledb> server # [ 118.511783] postgres[1460]: ::1 2026-10-07 19:33:09.167 UTC [1460] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-timescaledb> server # [ 118.528333] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: GRANT vm-test-run-timescaledb> server # [ 118.535523] postgres[1460]: ::1 2026-10-07 19:33:09.182 UTC [1460] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-timescaledb> server # [ 118.559260] postgres[1460]: ::1 2026-10-07 19:33:09.191 UTC [1460] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-timescaledb> server # [ 118.587110] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: CREATE ROLE vm-test-run-timescaledb> server # [ 118.597746] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: GRANT ROLE vm-test-run-timescaledb> server # [ 118.599434] postgres[1460]: ::1 2026-10-07 19:33:09.230 UTC [1460] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-timescaledb> server # [ 118.617678] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 118.622158] postgres[1460]: ::1 2026-10-07 19:33:09.275 UTC [1460] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-timescaledb> server # [ 121.795028] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 121.810754] postgres[1460]: ::1 2026-10-07 19:33:12.425 UTC [1460] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-timescaledb> server # [ 123.062350] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 123.066606] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: CREATE ROLE vm-test-run-timescaledb> server # [ 123.090533] postgres[1460]: ::1 2026-10-07 19:33:13.714 UTC [1460] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-timescaledb> server # [ 123.091788] postgres[1460]: ::1 2026-10-07 19:33:13.726 UTC [1460] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-timescaledb> server # [ 123.093130] postgres[1460]: ::1 2026-10-07 19:33:13.738 UTC [1460] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-timescaledb> server # [ 123.095733] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: CREATE ROLE vm-test-run-timescaledb> server # [ 123.099224] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: CREATE ROLE vm-test-run-timescaledb> server # [ 123.101681] postgres[1460]: ::1 2026-10-07 19:33:13.747 UTC [1460] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-timescaledb> server # [ 123.111493] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: CREATE ROLE vm-test-run-timescaledb> server # [ 123.119994] postgres[1460]: ::1 2026-10-07 19:33:13.770 UTC [1460] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-timescaledb> server # [ 123.129926] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: GRANT ROLE vm-test-run-timescaledb> server # [ 123.130898] postgres[1460]: ::1 2026-10-07 19:33:13.783 UTC [1460] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-timescaledb> server # [ 123.139378] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: GRANT ROLE vm-test-run-timescaledb> server # [ 123.146039] postgres[1460]: ::1 2026-10-07 19:33:13.797 UTC [1460] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-timescaledb> server # [ 123.151106] postgres[1460]: ::1 2026-10-07 19:33:13.805 UTC [1460] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-timescaledb> server # [ 123.155478] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: GRANT ROLE vm-test-run-timescaledb> server # [ 123.161727] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: GRANT ROLE vm-test-run-timescaledb> server # [ 123.168733] postgres[1460]: ::1 2026-10-07 19:33:13.822 UTC [1460] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.175641] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: GRANT vm-test-run-timescaledb> server # [ 123.182358] postgres[1460]: ::1 2026-10-07 19:33:13.836 UTC [1460] 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 # [ 123.218013] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 123.224500] postgres[1460]: ::1 2026-10-07 19:33:13.877 UTC [1460] 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 # [ 123.234139] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 123.238968] postgres[1460]: ::1 2026-10-07 19:33:13.894 UTC [1460] 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 # [ 123.253164] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 123.254588] postgres[1460]: ::1 2026-10-07 19:33:13.906 UTC [1460] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.264753] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: GRANT vm-test-run-timescaledb> server # [ 123.272801] postgres[1460]: ::1 2026-10-07 19:33:13.923 UTC [1460] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-timescaledb> server # [ 123.284452] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: ALTER ROLE vm-test-run-timescaledb> server # [ 123.289921] postgres[1460]: ::1 2026-10-07 19:33:13.937 UTC [1460] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 123.297654] postgres[1460]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.306911] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 123.308233] postgres[1460]: ::1 2026-10-07 19:33:13.964 UTC [1460] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 123.313653] postgres[1460]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.323368] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 123.326072] postgres[1460]: ::1 2026-10-07 19:33:13.977 UTC [1460] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 123.326663] postgres[1460]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 123.330685] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 123.333600] postgres[1460]: ::1 2026-10-07 19:33:13.988 UTC [1460] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-timescaledb> server # [ 123.350745] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: ALTER ROLE vm-test-run-timescaledb> server # [ 123.355866] postgres[1460]: ::1 2026-10-07 19:33:14.002 UTC [1460] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 123.365106] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1455]: ALTER ROLE vm-test-run-timescaledb> server # [ 123.422876] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-timescaledb> server # [ 123.680884] postgres[1503]: ::1 2026-10-07 19:33:14.333 UTC [1503] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 123.696247] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 123.698145] postgres[1503]: ::1 2026-10-07 19:33:14.346 UTC [1503] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-timescaledb> server # [ 123.699697] postgres[1503]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 123.700097] postgres[1503]: id uuid NOT NULL UNIQUE, vm-test-run-timescaledb> server # [ 123.700674] postgres[1503]: aud varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.701507] postgres[1503]: "role" varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.702849] postgres[1503]: email varchar(255) NULL UNIQUE, vm-test-run-timescaledb> server # [ 123.703214] postgres[1503]: encrypted_password varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.703467] postgres[1503]: confirmed_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.703875] postgres[1503]: invited_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.704303] postgres[1503]: confirmation_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.705316] postgres[1503]: confirmation_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.706407] postgres[1503]: recovery_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.706761] postgres[1503]: recovery_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.707465] postgres[1503]: email_change_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.707929] postgres[1503]: email_change varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.709682] postgres[1503]: email_change_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.711442] postgres[1503]: last_sign_in_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.712105] postgres[1503]: raw_app_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 123.713513] postgres[1503]: raw_user_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 123.714147] postgres[1503]: is_super_admin bool NULL, vm-test-run-timescaledb> server # [ 123.714609] postgres[1503]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.714889] postgres[1503]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.715120] postgres[1503]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 123.715352] postgres[1503]: ); vm-test-run-timescaledb> server # [ 123.833575] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE TABLE vm-test-run-timescaledb> server # [ 123.839186] postgres[1503]: ::1 2026-10-07 19:33:14.494 UTC [1503] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-timescaledb> server # [ 123.885608] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE INDEX vm-test-run-timescaledb> server # [ 123.891066] postgres[1503]: ::1 2026-10-07 19:33:14.546 UTC [1503] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-timescaledb> server # [ 123.925601] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE INDEX vm-test-run-timescaledb> server # [ 123.926574] postgres[1503]: ::1 2026-10-07 19:33:14.582 UTC [1503] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-timescaledb> server # [ 123.934734] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: COMMENT vm-test-run-timescaledb> server # [ 123.941204] postgres[1503]: ::1 2026-10-07 19:33:14.592 UTC [1503] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-timescaledb> server # [ 123.942194] postgres[1503]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 123.942536] postgres[1503]: id bigserial NOT NULL, vm-test-run-timescaledb> server # [ 123.942828] postgres[1503]: "token" varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.943084] postgres[1503]: user_id varchar(255) NULL, vm-test-run-timescaledb> server # [ 123.943406] postgres[1503]: revoked bool NULL, vm-test-run-timescaledb> server # [ 123.943738] postgres[1503]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.949441] postgres[1503]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 123.950905] postgres[1503]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 123.951937] postgres[1503]: ); vm-test-run-timescaledb> server # [ 124.025387] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE TABLE vm-test-run-timescaledb> server # [ 124.026646] postgres[1503]: ::1 2026-10-07 19:33:14.682 UTC [1503] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-timescaledb> server # [ 124.053853] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE INDEX vm-test-run-timescaledb> server # [ 124.057758] postgres[1503]: ::1 2026-10-07 19:33:14.711 UTC [1503] 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 # [ 124.089579] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE INDEX vm-test-run-timescaledb> server # [ 124.094430] postgres[1503]: ::1 2026-10-07 19:33:14.748 UTC [1503] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-timescaledb> server # [ 124.127228] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE INDEX vm-test-run-timescaledb> server # [ 124.134363] postgres[1503]: ::1 2026-10-07 19:33:14.784 UTC [1503] 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 # [ 124.140804] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: COMMENT vm-test-run-timescaledb> server # [ 124.145990] postgres[1503]: ::1 2026-10-07 19:33:14.801 UTC [1503] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-timescaledb> server # [ 124.147148] postgres[1503]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 124.147899] postgres[1503]: uuid uuid NULL, vm-test-run-timescaledb> server # [ 124.149607] postgres[1503]: raw_base_config text NULL, vm-test-run-timescaledb> server # [ 124.150059] postgres[1503]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 124.150757] postgres[1503]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 124.153638] postgres[1503]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 124.154261] postgres[1503]: ); vm-test-run-timescaledb> server # [ 124.229787] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE TABLE vm-test-run-timescaledb> server # [ 124.230664] postgres[1503]: ::1 2026-10-07 19:33:14.886 UTC [1503] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-timescaledb> server # [ 124.235662] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: COMMENT vm-test-run-timescaledb> server # [ 124.242086] postgres[1503]: ::1 2026-10-07 19:33:14.892 UTC [1503] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-timescaledb> server # [ 124.242947] postgres[1503]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 124.243593] postgres[1503]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 124.244575] postgres[1503]: payload json NULL, vm-test-run-timescaledb> server # [ 124.246018] postgres[1503]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 124.246419] postgres[1503]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 124.246710] postgres[1503]: ); vm-test-run-timescaledb> server # [ 124.341263] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE TABLE vm-test-run-timescaledb> server # [ 124.342859] postgres[1503]: ::1 2026-10-07 19:33:14.993 UTC [1503] 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 # [ 124.381432] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE INDEX vm-test-run-timescaledb> server # [ 124.389478] postgres[1503]: ::1 2026-10-07 19:33:15.042 UTC [1503] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-timescaledb> server # [ 124.402676] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: COMMENT vm-test-run-timescaledb> server # [ 124.413788] postgres[1503]: ::1 2026-10-07 19:33:15.063 UTC [1503] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-timescaledb> server # [ 124.415126] postgres[1503]: "version" varchar(255) NOT NULL, vm-test-run-timescaledb> server # [ 124.415940] postgres[1503]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-timescaledb> server # [ 124.420288] postgres[1503]: ); vm-test-run-timescaledb> server # [ 124.459500] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE TABLE vm-test-run-timescaledb> server # [ 124.469803] postgres[1503]: ::1 2026-10-07 19:33:15.120 UTC [1503] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-timescaledb> server # [ 124.501441] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: COMMENT vm-test-run-timescaledb> server # [ 124.557379] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: INSERT 0 7 vm-test-run-timescaledb> server # [ 124.565486] postgres[1503]: ::1 2026-10-07 19:33:15.212 UTC [1503] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-timescaledb> server # [ 124.574182] postgres[1503]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-timescaledb> server # [ 124.590560] postgres[1503]: $$ language sql stable; vm-test-run-timescaledb> server # [ 124.599243] postgres[1503]: ::1 2026-10-07 19:33:15.251 UTC [1503] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-timescaledb> server # [ 124.606958] postgres[1503]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-timescaledb> server # [ 124.615081] postgres[1503]: $$ language sql stable; vm-test-run-timescaledb> server # [ 124.622340] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 124.651734] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 124.653900] postgres[1503]: ::1 2026-10-07 19:33:15.309 UTC [1503] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-timescaledb> server # [ 124.655260] postgres[1503]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-timescaledb> server # [ 124.655955] postgres[1503]: $$ language sql stable; vm-test-run-timescaledb> server # [ 124.681319] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 124.698802] postgres[1503]: ::1 2026-10-07 19:33:15.334 UTC [1503] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.715610] postgres[1503]: ::1 2026-10-07 19:33:15.361 UTC [1503] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 124.747793] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: GRANT vm-test-run-timescaledb> server # [ 124.761071] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: CREATE ROLE vm-test-run-timescaledb> server # [ 124.762388] postgres[1503]: ::1 2026-10-07 19:33:15.387 UTC [1503] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.763438] postgres[1503]: ::1 2026-10-07 19:33:15.403 UTC [1503] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.763960] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: GRANT vm-test-run-timescaledb> server # [ 124.771755] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: GRANT vm-test-run-timescaledb> server # [ 124.782055] postgres[1503]: ::1 2026-10-07 19:33:15.423 UTC [1503] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.784231] postgres[1503]: ::1 2026-10-07 19:33:15.434 UTC [1503] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-timescaledb> server # [ 124.795938] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: GRANT vm-test-run-timescaledb> server # [ 124.799303] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: ALTER ROLE vm-test-run-timescaledb> server # [ 124.809805] postgres[1503]: ::1 2026-10-07 19:33:15.449 UTC [1503] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.818357] postgres[1503]: ::1 2026-10-07 19:33:15.473 UTC [1503] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.819742] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: ALTER TABLE vm-test-run-timescaledb> server # [ 124.838225] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: ALTER TABLE vm-test-run-timescaledb> server # [ 124.846043] postgres[1503]: ::1 2026-10-07 19:33:15.491 UTC [1503] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.858143] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: ALTER TABLE vm-test-run-timescaledb> server # [ 124.864029] postgres[1503]: ::1 2026-10-07 19:33:15.518 UTC [1503] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.890233] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: ALTER TABLE vm-test-run-timescaledb> server # [ 124.898758] postgres[1503]: ::1 2026-10-07 19:33:15.550 UTC [1503] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 124.945427] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1502]: ALTER TABLE vm-test-run-timescaledb> server # [ 125.022479] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-timescaledb> server # [ 125.485888] postgres[1523]: ::1 2026-10-07 19:33:16.137 UTC [1523] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 125.529591] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1520]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 125.530727] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1520]: CREATE ROLE vm-test-run-timescaledb> server # [ 125.531389] postgres[1523]: ::1 2026-10-07 19:33:16.164 UTC [1523] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 125.532190] postgres[1523]: ::1 2026-10-07 19:33:16.181 UTC [1523] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-timescaledb> server # [ 125.545319] postgres[1523]: ::1 2026-10-07 19:33:16.198 UTC [1523] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-timescaledb> server # [ 125.547490] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1520]: ALTER ROLE vm-test-run-timescaledb> server # [ 125.561663] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1520]: GRANT vm-test-run-timescaledb> server # [ 125.649934] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1520]: DO vm-test-run-timescaledb> server # [ 125.713655] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-timescaledb> server # [ 126.054969] postgres[1531]: ::1 2026-10-07 19:33:16.702 UTC [1531] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-timescaledb> server # [ 126.073897] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: ALTER ROLE vm-test-run-timescaledb> server # [ 126.075454] postgres[1531]: ::1 2026-10-07 19:33:16.724 UTC [1531] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-timescaledb> server # [ 126.081059] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: ALTER ROLE vm-test-run-timescaledb> server # [ 126.082079] postgres[1531]: ::1 2026-10-07 19:33:16.734 UTC [1531] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-timescaledb> server # [ 126.083724] postgres[1531]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 126.084781] postgres[1531]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 126.085612] postgres[1531]: AS $$ vm-test-run-timescaledb> server # [ 126.086392] postgres[1531]: DECLARE vm-test-run-timescaledb> server # [ 126.087020] postgres[1531]: schema_is_cron bool; vm-test-run-timescaledb> server # [ 126.088065] postgres[1531]: BEGIN vm-test-run-timescaledb> server # [ 126.091765] postgres[1531]: schema_is_cron = ( vm-test-run-timescaledb> server # [ 126.098114] postgres[1531]: SELECT n.nspname = 'cron' vm-test-run-timescaledb> server # [ 126.098898] postgres[1531]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 126.100292] postgres[1531]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-timescaledb> server # [ 126.102559] postgres[1531]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 126.107577] postgres[1531]: ); vm-test-run-timescaledb> server # [ 126.109023] postgres[1531]: vm-test-run-timescaledb> server # [ 126.109739] postgres[1531]: IF schema_is_cron vm-test-run-timescaledb> server # [ 126.110677] postgres[1531]: THEN vm-test-run-timescaledb> server # [ 126.111087] postgres[1531]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 126.111408] postgres[1531]: vm-test-run-timescaledb> server # [ 126.113231] postgres[1531]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 126.114766] postgres[1531]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 126.115879] postgres[1531]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 126.117565] postgres[1531]: vm-test-run-timescaledb> server # [ 126.118289] postgres[1531]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 126.119061] postgres[1531]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 126.119613] postgres[1531]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 126.120871] postgres[1531]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 126.122110] postgres[1531]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 126.123020] postgres[1531]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 126.123779] postgres[1531]: vm-test-run-timescaledb> server # [ 126.124361] postgres[1531]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 126.125920] postgres[1531]: vm-test-run-timescaledb> server # [ 126.126921] postgres[1531]: END IF; vm-test-run-timescaledb> server # [ 126.127278] postgres[1531]: vm-test-run-timescaledb> server # [ 126.127521] postgres[1531]: END; vm-test-run-timescaledb> server # [ 126.128653] postgres[1531]: $$; vm-test-run-timescaledb> server # [ 126.130490] postgres[1531]: ::1 2026-10-07 19:33:16.762 UTC [1531] 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 # [ 126.131603] postgres[1531]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 126.132935] postgres[1531]: ::1 2026-10-07 19:33:16.782 UTC [1531] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-timescaledb> server # [ 126.135541] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.136275] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 126.142773] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: COMMENT vm-test-run-timescaledb> server # [ 126.143704] postgres[1531]: ::1 2026-10-07 19:33:16.799 UTC [1531] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-timescaledb> server # [ 126.144267] postgres[1531]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 126.161353] postgres[1531]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 126.163261] postgres[1531]: AS $$ vm-test-run-timescaledb> server # [ 126.163590] postgres[1531]: BEGIN vm-test-run-timescaledb> server # [ 126.174835] postgres[1531]: IF EXISTS ( vm-test-run-timescaledb> server # [ 126.176026] postgres[1531]: SELECT 1 vm-test-run-timescaledb> server # [ 126.181851] postgres[1531]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 126.182996] postgres[1531]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 126.188924] postgres[1531]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 126.189727] postgres[1531]: WHERE ext.extname = 'pg_net' vm-test-run-timescaledb> server # [ 126.190368] postgres[1531]: ) vm-test-run-timescaledb> server # [ 126.191780] postgres[1531]: THEN vm-test-run-timescaledb> server # [ 126.195980] postgres[1531]: IF NOT EXISTS ( vm-test-run-timescaledb> server # [ 126.202855] postgres[1531]: SELECT 1 vm-test-run-timescaledb> server # [ 126.203713] postgres[1531]: FROM pg_roles vm-test-run-timescaledb> server # [ 126.209184] postgres[1531]: WHERE rolname = 'supabase_functions_admin' vm-test-run-timescaledb> server # [ 126.210102] postgres[1531]: ) vm-test-run-timescaledb> server # [ 126.210600] postgres[1531]: THEN vm-test-run-timescaledb> server # [ 126.211285] postgres[1531]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 126.211947] postgres[1531]: END IF; vm-test-run-timescaledb> server # [ 126.217607] postgres[1531]: vm-test-run-timescaledb> server # [ 126.217999] postgres[1531]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.218663] postgres[1531]: vm-test-run-timescaledb> server # [ 126.219302] postgres[1531]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 126.220031] postgres[1531]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 126.226103] postgres[1531]: vm-test-run-timescaledb> server # [ 126.227222] postgres[1531]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-timescaledb> server # [ 126.227612] postgres[1531]: 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 # [ 126.227925] postgres[1531]: vm-test-run-timescaledb> server # [ 126.228223] postgres[1531]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-timescaledb> server # [ 126.233825] postgres[1531]: 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 # [ 126.234647] postgres[1531]: vm-test-run-timescaledb> server # [ 126.235127] postgres[1531]: 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 # [ 126.235914] postgres[1531]: 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 # [ 126.241393] postgres[1531]: END IF; vm-test-run-timescaledb> server # [ 126.242829] postgres[1531]: END; vm-test-run-timescaledb> server # [ 126.243213] postgres[1531]: $$; vm-test-run-timescaledb> server # [ 126.243683] postgres[1531]: ::1 2026-10-07 19:33:16.818 UTC [1531] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-timescaledb> server # [ 126.244095] postgres[1531]: ::1 2026-10-07 19:33:16.855 UTC [1531] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-timescaledb> server # [ 126.249419] postgres[1531]: ::1 2026-10-07 19:33:16.867 UTC [1531] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-timescaledb> server # [ 126.250145] postgres[1531]: ::1 2026-10-07 19:33:16.883 UTC [1531] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 126.250529] postgres[1531]: ::1 2026-10-07 19:33:16.892 UTC [1531] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 126.251304] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.253621] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: COMMENT vm-test-run-timescaledb> server # [ 126.254021] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: DO vm-test-run-timescaledb> server # [ 126.254289] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: CREATE ROLE vm-test-run-timescaledb> server # [ 126.254736] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: GRANT vm-test-run-timescaledb> server # [ 126.255854] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: GRANT vm-test-run-timescaledb> server # [ 126.265227] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: GRANT vm-test-run-timescaledb> server # [ 126.266027] postgres[1531]: ::1 2026-10-07 19:33:16.902 UTC [1531] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 126.266769] postgres[1531]: ::1 2026-10-07 19:33:16.917 UTC [1531] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 126.268298] postgres[1531]: ::1 2026-10-07 19:33:16.921 UTC [1531] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 126.276063] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: GRANT vm-test-run-timescaledb> server # [ 126.278437] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: GRANT vm-test-run-timescaledb> server # [ 126.279461] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: GRANT vm-test-run-timescaledb> server # [ 126.279952] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: GRANT vm-test-run-timescaledb> server # [ 126.283856] postgres[1531]: ::1 2026-10-07 19:33:16.929 UTC [1531] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 126.289589] postgres[1531]: ::1 2026-10-07 19:33:16.934 UTC [1531] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 126.299546] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: GRANT vm-test-run-timescaledb> server # [ 126.303310] postgres[1531]: ::1 2026-10-07 19:33:16.952 UTC [1531] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 126.334871] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: GRANT vm-test-run-timescaledb> server # [ 126.354555] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1527]: DO vm-test-run-timescaledb> server # [ 126.405041] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running pgbouncer auth schema... vm-test-run-timescaledb> server # [ 126.647480] postgres[1533]: ::1 2026-10-07 19:33:17.298 UTC [1533] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-timescaledb> server # [ 126.681807] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1532]: CREATE ROLE vm-test-run-timescaledb> server # [ 126.683652] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1532]: REVOKE vm-test-run-timescaledb> server # [ 126.689106] postgres[1533]: ::1 2026-10-07 19:33:17.314 UTC [1533] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-timescaledb> server # [ 126.690199] postgres[1533]: ::1 2026-10-07 19:33:17.334 UTC [1533] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-timescaledb> server # [ 126.755086] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1532]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 126.759105] postgres[1533]: ::1 2026-10-07 19:33:17.415 UTC [1533] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-timescaledb> server # [ 126.760854] postgres[1533]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-timescaledb> server # [ 126.761648] postgres[1533]: $$ vm-test-run-timescaledb> server # [ 126.771333] postgres[1533]: BEGIN vm-test-run-timescaledb> server # [ 126.777895] postgres[1533]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-timescaledb> server # [ 126.779269] postgres[1533]: vm-test-run-timescaledb> server # [ 126.785410] postgres[1533]: RETURN QUERY vm-test-run-timescaledb> server # [ 126.787030] postgres[1533]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-timescaledb> server # [ 126.787817] postgres[1533]: WHERE usename = p_usename; vm-test-run-timescaledb> server # [ 126.801098] postgres[1533]: END; vm-test-run-timescaledb> server # [ 126.801914] postgres[1533]: $$ LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 126.802978] postgres[1533]: SET search_path = '' vm-test-run-timescaledb> server # [ 126.810914] postgres[1533]: SECURITY DEFINER; vm-test-run-timescaledb> server # [ 126.811665] postgres[1533]: ::1 2026-10-07 19:33:17.453 UTC [1533] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-timescaledb> server # [ 126.819060] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1532]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.823347] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1532]: REVOKE vm-test-run-timescaledb> server # [ 126.827323] postgres[1533]: ::1 2026-10-07 19:33:17.472 UTC [1533] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-timescaledb> server # [ 126.842019] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1532]: GRANT vm-test-run-timescaledb> server # [ 126.889404] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running stat extension... vm-test-run-timescaledb> server # [ 127.256034] postgres[1539]: ::1 2026-10-07 19:33:17.894 UTC [1539] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-timescaledb> server # [ 127.282740] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1537]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-timescaledb> server # [ 127.283734] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1537]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 127.299980] postgres[1539]: ::1 2026-10-07 19:33:17.938 UTC [1539] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-timescaledb> server # [ 129.034955] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1537]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 129.108278] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-timescaledb> server # [ 129.491648] postgres[1565]: ::1 2026-10-07 19:33:20.138 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-timescaledb> server # [ 129.527605] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.534114] postgres[1565]: ::1 2026-10-07 19:33:20.174 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 129.550063] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.557983] postgres[1565]: ::1 2026-10-07 19:33:20.209 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 129.574578] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.578317] postgres[1565]: ::1 2026-10-07 19:33:20.232 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 129.611353] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.622150] postgres[1565]: ::1 2026-10-07 19:33:20.270 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 129.635141] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.642216] postgres[1565]: ::1 2026-10-07 19:33:20.295 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 129.648071] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.652251] postgres[1565]: ::1 2026-10-07 19:33:20.307 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 129.654906] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.657170] postgres[1565]: ::1 2026-10-07 19:33:20.312 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 129.667036] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.668039] postgres[1565]: ::1 2026-10-07 19:33:20.322 UTC [1565] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 129.693231] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1564]: GRANT vm-test-run-timescaledb> server # [ 129.719520] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1564]: DO vm-test-run-timescaledb> server # [ 129.720368] postgres[1565]: ::1 2026-10-07 19:33:20.373 UTC [1565] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-timescaledb> server # [ 129.726778] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1564]: ALTER ROLE vm-test-run-timescaledb> server # [ 129.769271] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-timescaledb> server # [ 130.011415] postgres[1567]: ::1 2026-10-07 19:33:20.656 UTC [1567] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 130.019467] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: GRANT vm-test-run-timescaledb> server # [ 130.025384] postgres[1567]: ::1 2026-10-07 19:33:20.677 UTC [1567] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 130.033260] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: GRANT vm-test-run-timescaledb> server # [ 130.035216] postgres[1567]: ::1 2026-10-07 19:33:20.691 UTC [1567] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 130.045232] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: GRANT vm-test-run-timescaledb> server # [ 130.047215] postgres[1567]: ::1 2026-10-07 19:33:20.703 UTC [1567] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 130.059464] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: ALTER TABLE vm-test-run-timescaledb> server # [ 130.062026] postgres[1567]: ::1 2026-10-07 19:33:20.718 UTC [1567] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 130.074525] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: ALTER TABLE vm-test-run-timescaledb> server # [ 130.076427] postgres[1567]: ::1 2026-10-07 19:33:20.732 UTC [1567] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 130.089054] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: ALTER TABLE vm-test-run-timescaledb> server # [ 130.090245] postgres[1567]: ::1 2026-10-07 19:33:20.743 UTC [1567] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 130.098220] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: ALTER TABLE vm-test-run-timescaledb> server # [ 130.103122] postgres[1567]: ::1 2026-10-07 19:33:20.756 UTC [1567] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 130.110235] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: ALTER TABLE vm-test-run-timescaledb> server # [ 130.113415] postgres[1567]: ::1 2026-10-07 19:33:20.768 UTC [1567] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 130.121155] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: GRANT vm-test-run-timescaledb> server # [ 130.123394] postgres[1567]: ::1 2026-10-07 19:33:20.779 UTC [1567] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 130.138771] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: GRANT vm-test-run-timescaledb> server # [ 130.139743] postgres[1567]: ::1 2026-10-07 19:33:20.794 UTC [1567] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 130.150729] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: GRANT vm-test-run-timescaledb> server # [ 130.154148] postgres[1567]: ::1 2026-10-07 19:33:20.807 UTC [1567] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 130.164949] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: GRANT vm-test-run-timescaledb> server # [ 130.165845] postgres[1567]: ::1 2026-10-07 19:33:20.821 UTC [1567] 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 # [ 130.176109] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 130.182427] postgres[1567]: ::1 2026-10-07 19:33:20.832 UTC [1567] 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 # [ 130.187598] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 130.190462] postgres[1567]: ::1 2026-10-07 19:33:20.844 UTC [1567] 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 # [ 130.210299] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1566]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 130.262516] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-timescaledb> server # [ 130.559480] postgres[1569]: ::1 2026-10-07 19:33:21.199 UTC [1569] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-timescaledb> server # [ 130.586487] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1568]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 130.631737] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 131.145466] postgres[1582]: ::1 2026-10-07 19:33:21.783 UTC [1582] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-timescaledb> server # [ 131.150529] postgres[1582]: ::1 2026-10-07 19:33:21.804 UTC [1582] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 131.171347] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1574]: GRANT vm-test-run-timescaledb> server # [ 131.175952] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1574]: GRANT vm-test-run-timescaledb> server # [ 131.180513] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1574]: GRANT vm-test-run-timescaledb> server # [ 131.181113] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1574]: GRANT vm-test-run-timescaledb> server # [ 131.181610] postgres[1582]: ::1 2026-10-07 19:33:21.814 UTC [1582] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 131.182778] postgres[1582]: ::1 2026-10-07 19:33:21.825 UTC [1582] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 131.274554] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-timescaledb> server # [ 131.869344] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1587]: DO vm-test-run-timescaledb> server # [ 131.871584] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1587]: DO vm-test-run-timescaledb> server # [ 131.893067] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1587]: DO vm-test-run-timescaledb> server # [ 131.950040] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 132.367055] postgres[1599]: ::1 2026-10-07 19:33:23.017 UTC [1599] 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 # [ 132.404841] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 132.407986] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 132.409564] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 132.410645] postgres[1599]: ::1 2026-10-07 19:33:23.046 UTC [1599] 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 # [ 132.412026] postgres[1599]: ::1 2026-10-07 19:33:23.054 UTC [1599] 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 # [ 132.464085] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-timescaledb> server # [ 132.727691] postgres[1601]: ::1 2026-10-07 19:33:23.374 UTC [1601] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-timescaledb> server # [ 132.751302] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1600]: ALTER ROLE vm-test-run-timescaledb> server # [ 132.831246] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-timescaledb> server # [ 133.194988] postgres[1607]: ::1 2026-10-07 19:33:23.827 UTC [1607] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 133.202134] postgres[1607]: ::1 2026-10-07 19:33:23.851 UTC [1607] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 133.214606] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-timescaledb> server # [ 133.216346] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 133.223724] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-timescaledb> server # [ 133.233580] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: DROP FUNCTION vm-test-run-timescaledb> server # [ 133.234716] postgres[1607]: ::1 2026-10-07 19:33:23.882 UTC [1607] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 133.245104] postgres[1607]: DECLARE vm-test-run-timescaledb> server # [ 133.246095] postgres[1607]: cmd record; vm-test-run-timescaledb> server # [ 133.246578] postgres[1607]: BEGIN vm-test-run-timescaledb> server # [ 133.246826] postgres[1607]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 133.247661] postgres[1607]: LOOP vm-test-run-timescaledb> server # [ 133.247941] postgres[1607]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 133.262637] postgres[1607]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 133.263280] postgres[1607]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 133.277662] postgres[1607]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 133.278335] postgres[1607]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 133.278944] postgres[1607]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 133.279587] postgres[1607]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 133.280252] postgres[1607]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 133.294281] postgres[1607]: , 'CREATE TYPE' vm-test-run-timescaledb> server # [ 133.294714] postgres[1607]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 133.295516] postgres[1607]: , 'COMMENT' vm-test-run-timescaledb> server # [ 133.296308] postgres[1607]: ) vm-test-run-timescaledb> server # [ 133.296590] postgres[1607]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 133.309341] postgres[1607]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 133.310296] postgres[1607]: THEN vm-test-run-timescaledb> server # [ 133.310670] postgres[1607]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 133.311283] postgres[1607]: END IF; vm-test-run-timescaledb> server # [ 133.312365] postgres[1607]: END LOOP; vm-test-run-timescaledb> server # [ 133.330112] postgres[1607]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 133.331453] postgres[1607]: ::1 2026-10-07 19:33:23.937 UTC [1607] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 133.336047] postgres[1607]: DECLARE vm-test-run-timescaledb> server # [ 133.338183] postgres[1607]: obj record; vm-test-run-timescaledb> server # [ 133.338891] postgres[1607]: BEGIN vm-test-run-timescaledb> server # [ 133.339224] postgres[1607]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 133.339799] postgres[1607]: LOOP vm-test-run-timescaledb> server # [ 133.347369] postgres[1607]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 133.355688] postgres[1607]: 'schema' vm-test-run-timescaledb> server # [ 133.362466] postgres[1607]: , 'table' vm-test-run-timescaledb> server # [ 133.362954] postgres[1607]: , 'foreign table' vm-test-run-timescaledb> server # [ 133.363500] postgres[1607]: , 'view' vm-test-run-timescaledb> server # [ 133.363919] postgres[1607]: , 'materialized view' vm-test-run-timescaledb> server # [ 133.375430] postgres[1607]: , 'function' vm-test-run-timescaledb> server # [ 133.389902] postgres[1607]: , 'trigger' vm-test-run-timescaledb> server # [ 133.390519] postgres[1607]: , 'type' vm-test-run-timescaledb> server # [ 133.391460] postgres[1607]: , 'rule' vm-test-run-timescaledb> server # [ 133.392101] postgres[1607]: ) vm-test-run-timescaledb> server # [ 133.397830] postgres[1607]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 133.398383] postgres[1607]: THEN vm-test-run-timescaledb> server # [ 133.398729] postgres[1607]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 133.399008] postgres[1607]: END IF; vm-test-run-timescaledb> server # [ 133.399263] postgres[1607]: END LOOP; vm-test-run-timescaledb> server # [ 133.399474] postgres[1607]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 133.399684] postgres[1607]: ::1 2026-10-07 19:33:23.954 UTC [1607] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 133.399984] postgres[1607]: ::1 2026-10-07 19:33:23.960 UTC [1607] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 133.405837] postgres[1607]: ON ddl_command_end vm-test-run-timescaledb> server # [ 133.406271] postgres[1607]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 133.406533] postgres[1607]: ::1 2026-10-07 19:33:23.978 UTC [1607] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 133.407048] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 133.407306] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 133.407536] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 133.413812] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 133.421561] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 133.422256] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping vm-test-run-timescaledb> server # [ 133.423211] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 133.423727] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1605]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 133.438346] postgres[1607]: ::1 2026-10-07 19:33:23.999 UTC [1607] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 133.441541] postgres[1607]: ON sql_drop vm-test-run-timescaledb> server # [ 133.442172] postgres[1607]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 133.442861] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-timescaledb> server # [ 134.612933] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1608]: DO vm-test-run-timescaledb> server # [ 134.711377] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-timescaledb> server # [ 135.388391] postgres[1633]: ::1 2026-10-07 19:33:26.018 UTC [1633] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-timescaledb> server # [ 135.499867] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 135.507070] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping vm-test-run-timescaledb> server # [ 135.517801] postgres[1633]: ::1 2026-10-07 19:33:26.149 UTC [1633] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-timescaledb> server # [ 135.518626] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: DROP FUNCTION vm-test-run-timescaledb> server # [ 135.527812] postgres[1633]: ::1 2026-10-07 19:33:26.178 UTC [1633] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 135.535673] postgres[1633]: "operationName" text default null, vm-test-run-timescaledb> server # [ 135.543956] postgres[1633]: query text default null, vm-test-run-timescaledb> server # [ 135.549442] postgres[1633]: variables jsonb default null, vm-test-run-timescaledb> server # [ 135.550087] postgres[1633]: extensions jsonb default null vm-test-run-timescaledb> server # [ 135.556764] postgres[1633]: ) vm-test-run-timescaledb> server # [ 135.558767] postgres[1633]: returns jsonb vm-test-run-timescaledb> server # [ 135.559246] postgres[1633]: language plpgsql vm-test-run-timescaledb> server # [ 135.559545] postgres[1633]: as $$ vm-test-run-timescaledb> server # [ 135.560003] postgres[1633]: DECLARE vm-test-run-timescaledb> server # [ 135.573649] postgres[1633]: server_version float; vm-test-run-timescaledb> server # [ 135.574108] postgres[1633]: BEGIN vm-test-run-timescaledb> server # [ 135.575083] postgres[1633]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 135.586330] postgres[1633]: vm-test-run-timescaledb> server # [ 135.587444] postgres[1633]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 135.603388] postgres[1633]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.606930] postgres[1633]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 135.607492] postgres[1633]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 135.609924] postgres[1633]: ); vm-test-run-timescaledb> server # [ 135.610432] postgres[1633]: ELSE vm-test-run-timescaledb> server # [ 135.610781] postgres[1633]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.611068] postgres[1633]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 135.611842] postgres[1633]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 135.614177] postgres[1633]: ); vm-test-run-timescaledb> server # [ 135.615009] postgres[1633]: END IF; vm-test-run-timescaledb> server # [ 135.615299] postgres[1633]: END; vm-test-run-timescaledb> server # [ 135.615514] postgres[1633]: $$; vm-test-run-timescaledb> server # [ 135.616782] postgres[1633]: ::1 2026-10-07 19:33:26.256 UTC [1633] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.618443] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 135.634804] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: GRANT vm-test-run-timescaledb> server # [ 135.643458] postgres[1633]: ::1 2026-10-07 19:33:26.291 UTC [1633] 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 # [ 135.657127] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.658787] postgres[1633]: ::1 2026-10-07 19:33:26.314 UTC [1633] 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 # [ 135.670070] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.670994] postgres[1633]: ::1 2026-10-07 19:33:26.327 UTC [1633] 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 # [ 135.682643] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.683528] postgres[1633]: ::1 2026-10-07 19:33:26.339 UTC [1633] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 135.684416] postgres[1633]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.697147] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.702862] postgres[1633]: ::1 2026-10-07 19:33:26.357 UTC [1633] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 135.710288] postgres[1633]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.718020] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.718854] postgres[1633]: ::1 2026-10-07 19:33:26.373 UTC [1633] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 135.725517] postgres[1633]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.731717] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.746161] postgres[1633]: ::1 2026-10-07 19:33:26.400 UTC [1633] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 135.753847] postgres[1633]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 135.754758] postgres[1633]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 135.757573] postgres[1633]: AS $func$ vm-test-run-timescaledb> server # [ 135.760240] postgres[1633]: DECLARE vm-test-run-timescaledb> server # [ 135.762369] postgres[1633]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 135.765038] postgres[1633]: BEGIN vm-test-run-timescaledb> server # [ 135.765596] postgres[1633]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 135.765894] postgres[1633]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 135.766155] postgres[1633]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 135.766412] postgres[1633]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 135.767291] postgres[1633]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 135.767742] postgres[1633]: ); vm-test-run-timescaledb> server # [ 135.773891] postgres[1633]: vm-test-run-timescaledb> server # [ 135.774657] postgres[1633]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 135.775016] postgres[1633]: THEN vm-test-run-timescaledb> server # [ 135.775910] postgres[1633]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.782256] postgres[1633]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.783465] postgres[1633]: vm-test-run-timescaledb> server # [ 135.784328] postgres[1633]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.787894] postgres[1633]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.789149] postgres[1633]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.789765] postgres[1633]: vm-test-run-timescaledb> server # [ 135.790145] postgres[1633]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 135.790847] postgres[1633]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 135.791145] postgres[1633]: "operationName" text default null, vm-test-run-timescaledb> server # [ 135.791969] postgres[1633]: query text default null, vm-test-run-timescaledb> server # [ 135.793500] postgres[1633]: variables jsonb default null, vm-test-run-timescaledb> server # [ 135.794132] postgres[1633]: extensions jsonb default null vm-test-run-timescaledb> server # [ 135.795244] postgres[1633]: ) vm-test-run-timescaledb> server # [ 135.795864] postgres[1633]: returns jsonb vm-test-run-timescaledb> server # [ 135.797746] postgres[1633]: language sql vm-test-run-timescaledb> server # [ 135.798194] postgres[1633]: as $$ vm-test-run-timescaledb> server # [ 135.798852] postgres[1633]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-timescaledb> server # [ 135.799955] postgres[1633]: $$; vm-test-run-timescaledb> server # [ 135.801026] postgres[1633]: vm-test-run-timescaledb> server # [ 135.801303] postgres[1633]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 135.801607] postgres[1633]: END IF; vm-test-run-timescaledb> server # [ 135.802037] postgres[1633]: vm-test-run-timescaledb> server # [ 135.802294] postgres[1633]: END; vm-test-run-timescaledb> server # [ 135.802856] postgres[1633]: $func$; vm-test-run-timescaledb> server # [ 135.803301] postgres[1633]: ::1 2026-10-07 19:33:26.450 UTC [1633] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-timescaledb> server # [ 135.804062] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 135.805986] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping vm-test-run-timescaledb> server # [ 135.810136] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 135.813397] postgres[1633]: ::1 2026-10-07 19:33:26.468 UTC [1633] 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 # [ 135.815279] postgres[1633]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-timescaledb> server # [ 135.825389] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 135.826378] postgres[1633]: ::1 2026-10-07 19:33:26.478 UTC [1633] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-timescaledb> server # [ 135.837845] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: COMMENT vm-test-run-timescaledb> server # [ 135.846368] postgres[1633]: ::1 2026-10-07 19:33:26.498 UTC [1633] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 135.847552] postgres[1633]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 135.857323] postgres[1633]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 135.858018] postgres[1633]: AS $func$ vm-test-run-timescaledb> server # [ 135.858315] postgres[1633]: DECLARE vm-test-run-timescaledb> server # [ 135.858554] postgres[1633]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 135.858809] postgres[1633]: BEGIN vm-test-run-timescaledb> server # [ 135.859042] postgres[1633]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 135.859310] postgres[1633]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 135.859550] postgres[1633]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 135.865416] postgres[1633]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 135.866305] postgres[1633]: ); vm-test-run-timescaledb> server # [ 135.866797] postgres[1633]: vm-test-run-timescaledb> server # [ 135.867085] postgres[1633]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 135.872994] postgres[1633]: THEN vm-test-run-timescaledb> server # [ 135.874694] postgres[1633]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 135.875479] postgres[1633]: "operationName" text default null, vm-test-run-timescaledb> server # [ 135.882040] postgres[1633]: query text default null, vm-test-run-timescaledb> server # [ 135.882495] postgres[1633]: variables jsonb default null, vm-test-run-timescaledb> server # [ 135.884107] postgres[1633]: extensions jsonb default null vm-test-run-timescaledb> server # [ 135.889629] postgres[1633]: ) vm-test-run-timescaledb> server # [ 135.894191] postgres[1633]: returns jsonb vm-test-run-timescaledb> server # [ 135.895213] postgres[1633]: language plpgsql vm-test-run-timescaledb> server # [ 135.901209] postgres[1633]: as $$ vm-test-run-timescaledb> server # [ 135.906468] postgres[1633]: DECLARE vm-test-run-timescaledb> server # [ 135.907204] postgres[1633]: server_version float; vm-test-run-timescaledb> server # [ 135.908364] postgres[1633]: BEGIN vm-test-run-timescaledb> server # [ 135.913712] postgres[1633]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 135.914118] postgres[1633]: vm-test-run-timescaledb> server # [ 135.914341] postgres[1633]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 135.915409] postgres[1633]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.922626] postgres[1633]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 135.923472] postgres[1633]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 135.924346] postgres[1633]: ); vm-test-run-timescaledb> server # [ 135.924635] postgres[1633]: ELSE vm-test-run-timescaledb> server # [ 135.924870] postgres[1633]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 135.925109] postgres[1633]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 135.930167] postgres[1633]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 135.931548] postgres[1633]: ); vm-test-run-timescaledb> server # [ 135.937933] postgres[1633]: END IF; vm-test-run-timescaledb> server # [ 135.938973] postgres[1633]: END; vm-test-run-timescaledb> server # [ 135.939687] postgres[1633]: $$; vm-test-run-timescaledb> server # [ 135.945159] postgres[1633]: END IF; vm-test-run-timescaledb> server # [ 135.947502] postgres[1633]: vm-test-run-timescaledb> server # [ 135.948100] postgres[1633]: END; vm-test-run-timescaledb> server # [ 135.952835] postgres[1633]: $func$; vm-test-run-timescaledb> server # [ 135.962259] postgres[1633]: ::1 2026-10-07 19:33:26.570 UTC [1633] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-timescaledb> server # [ 135.973788] postgres[1633]: ::1 2026-10-07 19:33:26.575 UTC [1633] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-timescaledb> server # [ 135.975994] postgres[1633]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-timescaledb> server # [ 135.986743] postgres[1633]: ::1 2026-10-07 19:33:26.590 UTC [1633] 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 # [ 135.995696] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 135.998369] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping vm-test-run-timescaledb> server # [ 136.004006] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 136.011903] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 136.015249] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1624]: COMMENT vm-test-run-timescaledb> server # [ 136.039026] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-timescaledb> server # [ 136.250911] postgres[1637]: ::1 2026-10-07 19:33:26.897 UTC [1637] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 136.257546] postgres[1637]: ::1 2026-10-07 19:33:26.902 UTC [1637] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 136.266867] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1636]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping vm-test-run-timescaledb> server # [ 136.269119] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1636]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 136.269658] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1636]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping vm-test-run-timescaledb> server # [ 136.273498] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1636]: DROP FUNCTION vm-test-run-timescaledb> server # [ 136.277059] postgres[1637]: ::1 2026-10-07 19:33:26.931 UTC [1637] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 136.278015] postgres[1637]: DECLARE vm-test-run-timescaledb> server # [ 136.278320] postgres[1637]: cmd record; vm-test-run-timescaledb> server # [ 136.278561] postgres[1637]: BEGIN vm-test-run-timescaledb> server # [ 136.279045] postgres[1637]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 136.279591] postgres[1637]: LOOP vm-test-run-timescaledb> server # [ 136.280067] postgres[1637]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 136.289556] postgres[1637]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 136.290798] postgres[1637]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 136.291267] postgres[1637]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 136.291695] postgres[1637]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 136.291965] postgres[1637]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 136.292452] postgres[1637]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 136.298754] postgres[1637]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 136.299171] postgres[1637]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-timescaledb> server # [ 136.299846] postgres[1637]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 136.305728] postgres[1637]: , 'COMMENT' vm-test-run-timescaledb> server # [ 136.306341] postgres[1637]: ) vm-test-run-timescaledb> server # [ 136.306657] postgres[1637]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 136.307363] postgres[1637]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 136.307711] postgres[1637]: THEN vm-test-run-timescaledb> server # [ 136.307974] postgres[1637]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 136.311311] postgres[1637]: END IF; vm-test-run-timescaledb> server # [ 136.313348] postgres[1637]: END LOOP; vm-test-run-timescaledb> server # [ 136.315248] postgres[1637]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 136.343918] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1636]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 136.353439] postgres[1637]: ::1 2026-10-07 19:33:27.004 UTC [1637] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 136.354602] postgres[1637]: DECLARE vm-test-run-timescaledb> server # [ 136.354947] postgres[1637]: obj record; vm-test-run-timescaledb> server # [ 136.357566] postgres[1637]: BEGIN vm-test-run-timescaledb> server # [ 136.359149] postgres[1637]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 136.359975] postgres[1637]: LOOP vm-test-run-timescaledb> server # [ 136.362961] postgres[1637]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 136.364316] postgres[1637]: 'schema' vm-test-run-timescaledb> server # [ 136.366259] postgres[1637]: , 'table' vm-test-run-timescaledb> server # [ 136.366810] postgres[1637]: , 'foreign table' vm-test-run-timescaledb> server # [ 136.367107] postgres[1637]: , 'view' vm-test-run-timescaledb> server # [ 136.367354] postgres[1637]: , 'materialized view' vm-test-run-timescaledb> server # [ 136.367589] postgres[1637]: , 'function' vm-test-run-timescaledb> server # [ 136.367802] postgres[1637]: , 'trigger' vm-test-run-timescaledb> server # [ 136.368021] postgres[1637]: , 'type' vm-test-run-timescaledb> server # [ 136.368275] postgres[1637]: , 'rule' vm-test-run-timescaledb> server # [ 136.368766] postgres[1637]: ) vm-test-run-timescaledb> server # [ 136.370253] postgres[1637]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 136.371352] postgres[1637]: THEN vm-test-run-timescaledb> server # [ 136.371627] postgres[1637]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 136.372244] postgres[1637]: END IF; vm-test-run-timescaledb> server # [ 136.374639] postgres[1637]: END LOOP; vm-test-run-timescaledb> server # [ 136.375086] postgres[1637]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 136.391973] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1636]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 136.393960] postgres[1637]: ::1 2026-10-07 19:33:27.047 UTC [1637] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 136.407172] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1636]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 136.411753] postgres[1637]: ::1 2026-10-07 19:33:27.062 UTC [1637] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 136.415347] postgres[1637]: ON ddl_command_end vm-test-run-timescaledb> server # [ 136.415733] postgres[1637]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 136.421050] postgres[1637]: ::1 2026-10-07 19:33:27.071 UTC [1637] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 136.422634] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1636]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 136.430492] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1636]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 136.435624] postgres[1637]: ::1 2026-10-07 19:33:27.089 UTC [1637] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 136.438904] postgres[1637]: ON sql_drop vm-test-run-timescaledb> server # [ 136.443543] postgres[1637]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 136.454668] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1636]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 136.493866] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-timescaledb> server # [ 136.743890] postgres[1639]: ::1 2026-10-07 19:33:27.394 UTC [1639] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-timescaledb> server # [ 136.756105] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1638]: ALTER ROLE vm-test-run-timescaledb> server # [ 136.810945] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-timescaledb> server # [ 137.185978] postgres[1645]: ::1 2026-10-07 19:33:27.839 UTC [1645] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 137.188980] postgres[1645]: returns event_trigger vm-test-run-timescaledb> server # [ 137.190626] postgres[1645]: language plpgsql vm-test-run-timescaledb> server # [ 137.191990] postgres[1645]: AS $func$ vm-test-run-timescaledb> server # [ 137.193506] postgres[1645]: DECLARE vm-test-run-timescaledb> server # [ 137.195252] postgres[1645]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 137.197543] postgres[1645]: BEGIN vm-test-run-timescaledb> server # [ 137.198327] postgres[1645]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 137.198971] postgres[1645]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 137.199483] postgres[1645]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 137.201128] postgres[1645]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 137.201600] postgres[1645]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 137.202242] postgres[1645]: ); vm-test-run-timescaledb> server # [ 137.202824] postgres[1645]: vm-test-run-timescaledb> server # [ 137.203666] postgres[1645]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 137.206546] postgres[1645]: THEN vm-test-run-timescaledb> server # [ 137.207587] postgres[1645]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.209265] postgres[1645]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.209912] postgres[1645]: vm-test-run-timescaledb> server # [ 137.211508] postgres[1645]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.214806] postgres[1645]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.218376] postgres[1645]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.222257] postgres[1645]: vm-test-run-timescaledb> server # [ 137.223948] postgres[1645]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 137.224559] postgres[1645]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 137.231970] postgres[1645]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 137.241858] postgres[1645]: "operationName" text default null, vm-test-run-timescaledb> server # [ 137.242558] postgres[1645]: query text default null, vm-test-run-timescaledb> server # [ 137.243235] postgres[1645]: variables jsonb default null, vm-test-run-timescaledb> server # [ 137.243890] postgres[1645]: extensions jsonb default null vm-test-run-timescaledb> server # [ 137.244611] postgres[1645]: ) vm-test-run-timescaledb> server # [ 137.251541] postgres[1645]: returns jsonb vm-test-run-timescaledb> server # [ 137.252396] postgres[1645]: language sql vm-test-run-timescaledb> server # [ 137.255524] postgres[1645]: as $$ vm-test-run-timescaledb> server # [ 137.263285] postgres[1645]: -- This changed vm-test-run-timescaledb> server # [ 137.266321] postgres[1645]: select graphql.resolve( vm-test-run-timescaledb> server # [ 137.274890] postgres[1645]: query := query, vm-test-run-timescaledb> server # [ 137.298492] postgres[1645]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 137.299772] postgres[1645]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 137.305232] postgres[1645]: extensions := extensions vm-test-run-timescaledb> server # [ 137.306576] postgres[1645]: ); vm-test-run-timescaledb> server # [ 137.307120] postgres[1645]: $$; vm-test-run-timescaledb> server # [ 137.307395] postgres[1645]: vm-test-run-timescaledb> server # [ 137.307627] postgres[1645]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 137.307913] postgres[1645]: END IF; vm-test-run-timescaledb> server # [ 137.308189] postgres[1645]: vm-test-run-timescaledb> server # [ 137.312273] postgres[1645]: END; vm-test-run-timescaledb> server # [ 137.314631] postgres[1645]: $func$; vm-test-run-timescaledb> server # [ 137.404832] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1642]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 137.406126] postgres[1645]: ::1 2026-10-07 19:33:28.044 UTC [1645] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 137.414549] postgres[1645]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 137.415809] postgres[1645]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 137.426450] postgres[1645]: AS $func$ vm-test-run-timescaledb> server # [ 137.433933] postgres[1645]: DECLARE vm-test-run-timescaledb> server # [ 137.436108] postgres[1645]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 137.456911] postgres[1645]: BEGIN vm-test-run-timescaledb> server # [ 137.457726] postgres[1645]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 137.458740] postgres[1645]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 137.459666] postgres[1645]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 137.474571] postgres[1645]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 137.477271] postgres[1645]: ); vm-test-run-timescaledb> server # [ 137.478660] postgres[1645]: vm-test-run-timescaledb> server # [ 137.493284] postgres[1645]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 137.493967] postgres[1645]: THEN vm-test-run-timescaledb> server # [ 137.494687] postgres[1645]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 137.495137] postgres[1645]: "operationName" text default null, vm-test-run-timescaledb> server # [ 137.495446] postgres[1645]: query text default null, vm-test-run-timescaledb> server # [ 137.496389] postgres[1645]: variables jsonb default null, vm-test-run-timescaledb> server # [ 137.501970] postgres[1645]: extensions jsonb default null vm-test-run-timescaledb> server # [ 137.507197] postgres[1645]: ) vm-test-run-timescaledb> server # [ 137.517173] postgres[1645]: returns jsonb vm-test-run-timescaledb> server # [ 137.518646] postgres[1645]: language plpgsql vm-test-run-timescaledb> server # [ 137.518989] postgres[1645]: as $$ vm-test-run-timescaledb> server # [ 137.519818] postgres[1645]: DECLARE vm-test-run-timescaledb> server # [ 137.525887] postgres[1645]: server_version float; vm-test-run-timescaledb> server # [ 137.526958] postgres[1645]: BEGIN vm-test-run-timescaledb> server # [ 137.527341] postgres[1645]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 137.527659] postgres[1645]: vm-test-run-timescaledb> server # [ 137.527891] postgres[1645]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 137.533624] postgres[1645]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 137.542476] postgres[1645]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 137.543364] postgres[1645]: jsonb_build_object( vm-test-run-timescaledb> server # [ 137.543730] postgres[1645]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 137.544039] postgres[1645]: ) vm-test-run-timescaledb> server # [ 137.544662] postgres[1645]: ) vm-test-run-timescaledb> server # [ 137.552680] postgres[1645]: ); vm-test-run-timescaledb> server # [ 137.557301] postgres[1645]: ELSE vm-test-run-timescaledb> server # [ 137.557667] postgres[1645]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 137.558534] postgres[1645]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 137.559023] postgres[1645]: jsonb_build_object( vm-test-run-timescaledb> server # [ 137.559799] postgres[1645]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 137.573747] postgres[1645]: ) vm-test-run-timescaledb> server # [ 137.575835] postgres[1645]: ) vm-test-run-timescaledb> server # [ 137.586498] postgres[1645]: ); vm-test-run-timescaledb> server # [ 137.591074] postgres[1645]: END IF; vm-test-run-timescaledb> server # [ 137.592231] postgres[1645]: END; vm-test-run-timescaledb> server # [ 137.597578] postgres[1645]: $$; vm-test-run-timescaledb> server # [ 137.605681] postgres[1645]: END IF; vm-test-run-timescaledb> server # [ 137.606890] postgres[1645]: vm-test-run-timescaledb> server # [ 137.607200] postgres[1645]: END; vm-test-run-timescaledb> server # [ 137.607735] postgres[1645]: $func$; vm-test-run-timescaledb> server # [ 137.627882] postgres[1645]: ::1 2026-10-07 19:33:28.146 UTC [1645] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 137.649165] postgres[1645]: "operationName" text default null, vm-test-run-timescaledb> server # [ 137.651950] postgres[1645]: query text default null, vm-test-run-timescaledb> server # [ 137.661703] postgres[1645]: variables jsonb default null, vm-test-run-timescaledb> server # [ 137.664387] postgres[1645]: extensions jsonb default null vm-test-run-timescaledb> server # [ 137.675345] postgres[1645]: ) vm-test-run-timescaledb> server # [ 137.683074] postgres[1645]: returns jsonb vm-test-run-timescaledb> server # [ 137.689485] postgres[1645]: language plpgsql vm-test-run-timescaledb> server # [ 137.691736] postgres[1645]: as $$ vm-test-run-timescaledb> server # [ 137.697084] postgres[1645]: DECLARE vm-test-run-timescaledb> server # [ 137.698097] postgres[1645]: server_version float; vm-test-run-timescaledb> server # [ 137.698508] postgres[1645]: BEGIN vm-test-run-timescaledb> server # [ 137.700044] postgres[1645]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 137.706966] postgres[1645]: vm-test-run-timescaledb> server # [ 137.717211] postgres[1645]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 137.720183] postgres[1645]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 137.726258] postgres[1645]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 137.736669] postgres[1645]: jsonb_build_object( vm-test-run-timescaledb> server # [ 137.743448] postgres[1645]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 137.756351] postgres[1645]: ) vm-test-run-timescaledb> server # [ 137.760350] postgres[1645]: ) vm-test-run-timescaledb> server # [ 137.763842] postgres[1645]: ); vm-test-run-timescaledb> server # [ 137.770881] postgres[1645]: ELSE vm-test-run-timescaledb> server # [ 137.774942] postgres[1645]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 137.784205] postgres[1645]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 137.791768] postgres[1645]: jsonb_build_object( vm-test-run-timescaledb> server # [ 137.799025] postgres[1645]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 137.804286] postgres[1645]: ) vm-test-run-timescaledb> server # [ 137.810203] postgres[1645]: ) vm-test-run-timescaledb> server # [ 137.814655] postgres[1645]: ); vm-test-run-timescaledb> server # [ 137.817475] postgres[1645]: END IF; vm-test-run-timescaledb> server # [ 137.818704] postgres[1645]: END; vm-test-run-timescaledb> server # [ 137.827002] postgres[1645]: $$; vm-test-run-timescaledb> server # [ 137.831162] postgres[1645]: ::1 2026-10-07 19:33:28.195 UTC [1645] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 137.841071] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1642]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 137.843860] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1642]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 137.847132] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1642]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping vm-test-run-timescaledb> server # [ 137.857663] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1642]: DROP EXTENSION vm-test-run-timescaledb> server # [ 139.643271] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1642]: DO vm-test-run-timescaledb> server # [ 139.679440] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql vm-test-run-timescaledb> server # [ 139.912181] postgres[1671]: ::1 2026-10-07 19:33:30.561 UTC [1671] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-timescaledb> server # [ 139.978620] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1670]: GRANT ROLE vm-test-run-timescaledb> server # [ 139.979783] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-timescaledb> server # [ 140.216864] postgres[1673]: ::1 2026-10-07 19:33:30.868 UTC [1673] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 140.217642] postgres[1673]: returns event_trigger vm-test-run-timescaledb> server # [ 140.219058] postgres[1673]: language plpgsql vm-test-run-timescaledb> server # [ 140.220058] postgres[1673]: AS $func$ vm-test-run-timescaledb> server # [ 140.221547] postgres[1673]: DECLARE vm-test-run-timescaledb> server # [ 140.222644] postgres[1673]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 140.223722] postgres[1673]: BEGIN vm-test-run-timescaledb> server # [ 140.224903] postgres[1673]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 140.226852] postgres[1673]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 140.227254] postgres[1673]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 140.229093] postgres[1673]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 140.229717] postgres[1673]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 140.230408] postgres[1673]: ); vm-test-run-timescaledb> server # [ 140.231497] postgres[1673]: vm-test-run-timescaledb> server # [ 140.231960] postgres[1673]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 140.233491] postgres[1673]: THEN vm-test-run-timescaledb> server # [ 140.234601] postgres[1673]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 140.235645] postgres[1673]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 140.237535] postgres[1673]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 140.238666] postgres[1673]: "operationName" text default null, vm-test-run-timescaledb> server # [ 140.238995] postgres[1673]: query text default null, vm-test-run-timescaledb> server # [ 140.239345] postgres[1673]: variables jsonb default null, vm-test-run-timescaledb> server # [ 140.239736] postgres[1673]: extensions jsonb default null vm-test-run-timescaledb> server # [ 140.241129] postgres[1673]: ) vm-test-run-timescaledb> server # [ 140.242010] postgres[1673]: returns jsonb vm-test-run-timescaledb> server # [ 140.242383] postgres[1673]: language sql vm-test-run-timescaledb> server # [ 140.242655] postgres[1673]: as $$ vm-test-run-timescaledb> server # [ 140.242956] postgres[1673]: select graphql.resolve( vm-test-run-timescaledb> server # [ 140.243266] postgres[1673]: query := query, vm-test-run-timescaledb> server # [ 140.244275] postgres[1673]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 140.246356] postgres[1673]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 140.247963] postgres[1673]: extensions := extensions vm-test-run-timescaledb> server # [ 140.249253] postgres[1673]: ); vm-test-run-timescaledb> server # [ 140.249763] postgres[1673]: $$; vm-test-run-timescaledb> server # [ 140.250042] postgres[1673]: vm-test-run-timescaledb> server # [ 140.250603] postgres[1673]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 140.251047] postgres[1673]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 140.251696] postgres[1673]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 140.252040] postgres[1673]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 140.252834] postgres[1673]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 140.253361] postgres[1673]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 140.253668] postgres[1673]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 140.253991] postgres[1673]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 140.254514] postgres[1673]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 140.255906] postgres[1673]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 140.257551] postgres[1673]: END IF; vm-test-run-timescaledb> server # [ 140.259087] postgres[1673]: vm-test-run-timescaledb> server # [ 140.259538] postgres[1673]: END; vm-test-run-timescaledb> server # [ 140.261436] postgres[1673]: $func$; vm-test-run-timescaledb> server # [ 140.330196] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1672]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 140.331377] postgres[1673]: ::1 2026-10-07 19:33:30.977 UTC [1673] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 140.454739] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1672]: DROP EXTENSION vm-test-run-timescaledb> server # [ 142.231406] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1672]: DO vm-test-run-timescaledb> server # [ 142.291665] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-timescaledb> server # [ 143.262126] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1698]: DO vm-test-run-timescaledb> server # [ 144.086392] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1698]: DO vm-test-run-timescaledb> server # [ 144.150110] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-timescaledb> server # [ 144.594472] postgres[1719]: ::1 2026-10-07 19:33:35.237 UTC [1719] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 144.623004] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1714]: ALTER ROLE vm-test-run-timescaledb> server # [ 144.697507] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-timescaledb> server # [ 145.149477] postgres[1730]: ::1 2026-10-07 19:33:35.790 UTC [1730] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-timescaledb> server # [ 145.167467] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1728]: REVOKE ROLE vm-test-run-timescaledb> server # [ 145.219931] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-timescaledb> server # [ 147.995086] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1732]: DO vm-test-run-timescaledb> server # [ 148.051622] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 148.429997] postgres[1759]: ::1 2026-10-07 19:33:39.082 UTC [1759] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-timescaledb> server # [ 148.442723] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1755]: GRANT ROLE vm-test-run-timescaledb> server # [ 148.473047] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-timescaledb> server # [ 148.789628] postgres[1761]: ::1 2026-10-07 19:33:39.419 UTC [1761] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 148.843778] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1760]: GRANT vm-test-run-timescaledb> server # [ 148.851694] postgres[1761]: ::1 2026-10-07 19:33:39.495 UTC [1761] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 148.900992] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1760]: GRANT vm-test-run-timescaledb> server # [ 148.901822] postgres[1761]: ::1 2026-10-07 19:33:39.553 UTC [1761] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 148.909279] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1760]: GRANT vm-test-run-timescaledb> server # [ 148.910142] postgres[1761]: ::1 2026-10-07 19:33:39.563 UTC [1761] 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 # [ 148.927438] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1760]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 148.935448] postgres[1761]: ::1 2026-10-07 19:33:39.588 UTC [1761] 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 # [ 148.943147] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1760]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 148.951229] postgres[1761]: ::1 2026-10-07 19:33:39.602 UTC [1761] 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 # [ 148.969219] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1760]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 149.021898] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-timescaledb> server # [ 149.387826] postgres[1767]: ::1 2026-10-07 19:33:40.030 UTC [1767] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-timescaledb> server # [ 149.412056] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1766]: GRANT ROLE vm-test-run-timescaledb> server # [ 149.483034] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 149.751954] postgres[1769]: ::1 2026-10-07 19:33:40.394 UTC [1769] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-timescaledb> server # [ 149.769801] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1768]: GRANT ROLE vm-test-run-timescaledb> server # [ 149.816984] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-timescaledb> server # [ 150.119629] postgres[1771]: ::1 2026-10-07 19:33:40.762 UTC [1771] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-timescaledb> server # [ 150.138530] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1770]: ALTER ROLE vm-test-run-timescaledb> server # [ 150.152924] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1770]: ALTER ROLE vm-test-run-timescaledb> server # [ 150.156180] postgres[1771]: ::1 2026-10-07 19:33:40.785 UTC [1771] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-timescaledb> server # [ 150.177137] postgres[1771]: ::1 2026-10-07 19:33:40.792 UTC [1771] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-timescaledb> server # [ 150.184893] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1770]: ALTER ROLE vm-test-run-timescaledb> server # [ 150.219539] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1770]: DO vm-test-run-timescaledb> server # [ 150.275387] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 150.718949] postgres[1781]: ::1 2026-10-07 19:33:41.367 UTC [1781] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-timescaledb> server # [ 150.735779] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1776]: GRANT ROLE vm-test-run-timescaledb> server # [ 150.750132] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1776]: REVOKE ROLE vm-test-run-timescaledb> server # [ 150.751804] postgres[1781]: ::1 2026-10-07 19:33:41.389 UTC [1781] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-timescaledb> server # [ 150.823440] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-timescaledb> server # [ 151.378136] postgres[1794]: ::1 2026-10-07 19:33:42.021 UTC [1794] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 151.389853] postgres[1794]: returns event_trigger vm-test-run-timescaledb> server # [ 151.392282] postgres[1794]: language plpgsql vm-test-run-timescaledb> server # [ 151.402593] postgres[1794]: AS $func$ vm-test-run-timescaledb> server # [ 151.410358] postgres[1794]: DECLARE vm-test-run-timescaledb> server # [ 151.414620] postgres[1794]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 151.415835] postgres[1794]: BEGIN vm-test-run-timescaledb> server # [ 151.421871] postgres[1794]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 151.422552] postgres[1794]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 151.430836] postgres[1794]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 151.442160] postgres[1794]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 151.446780] postgres[1794]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 151.450175] postgres[1794]: ); vm-test-run-timescaledb> server # [ 151.450724] postgres[1794]: vm-test-run-timescaledb> server # [ 151.451555] postgres[1794]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 151.451909] postgres[1794]: THEN vm-test-run-timescaledb> server # [ 151.462382] postgres[1794]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 151.463040] postgres[1794]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 151.463480] postgres[1794]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 151.477442] postgres[1794]: "operationName" text default null, vm-test-run-timescaledb> server # [ 151.479297] postgres[1794]: query text default null, vm-test-run-timescaledb> server # [ 151.485077] postgres[1794]: variables jsonb default null, vm-test-run-timescaledb> server # [ 151.486065] postgres[1794]: extensions jsonb default null vm-test-run-timescaledb> server # [ 151.487390] postgres[1794]: ) vm-test-run-timescaledb> server # [ 151.487751] postgres[1794]: returns jsonb vm-test-run-timescaledb> server # [ 151.497258] postgres[1794]: language sql vm-test-run-timescaledb> server # [ 151.498985] postgres[1794]: as $$ vm-test-run-timescaledb> server # [ 151.499496] postgres[1794]: select graphql.resolve( vm-test-run-timescaledb> server # [ 151.499870] postgres[1794]: query := query, vm-test-run-timescaledb> server # [ 151.505922] postgres[1794]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 151.519817] postgres[1794]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 151.521038] postgres[1794]: extensions := extensions vm-test-run-timescaledb> server # [ 151.522027] postgres[1794]: ); vm-test-run-timescaledb> server # [ 151.522668] postgres[1794]: $$; vm-test-run-timescaledb> server # [ 151.523658] postgres[1794]: vm-test-run-timescaledb> server # [ 151.524076] postgres[1794]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 151.533763] postgres[1794]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 151.534882] postgres[1794]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 151.535867] postgres[1794]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 151.550370] postgres[1794]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 151.550957] postgres[1794]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 151.551750] postgres[1794]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 151.552165] postgres[1794]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 151.559589] postgres[1794]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 151.582506] postgres[1794]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 151.595056] postgres[1794]: vm-test-run-timescaledb> server # [ 151.602949] postgres[1794]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-timescaledb> server # [ 151.606903] postgres[1794]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-timescaledb> server # [ 151.617110] postgres[1794]: grant usage on schema graphql to postgres with grant option; vm-test-run-timescaledb> server # [ 151.625401] postgres[1794]: END IF; vm-test-run-timescaledb> server # [ 151.633263] postgres[1794]: vm-test-run-timescaledb> server # [ 151.634231] postgres[1794]: END; vm-test-run-timescaledb> server # [ 151.635735] postgres[1794]: $func$; vm-test-run-timescaledb> server # [ 151.642137] postgres[1794]: ::1 2026-10-07 19:33:42.220 UTC [1794] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 151.668389] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1788]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 151.745743] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1788]: DROP EXTENSION vm-test-run-timescaledb> server # [ 153.331395] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1788]: DO vm-test-run-timescaledb> server # [ 153.371592] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-timescaledb> server # [ 153.919664] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1804]: DO vm-test-run-timescaledb> server # [ 153.951061] postgres[1809]: ::1 2026-10-07 19:33:44.559 UTC [1809] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-timescaledb> server # [ 153.952535] postgres[1809]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 153.968875] postgres[1809]: AS $$ vm-test-run-timescaledb> server # [ 153.977913] postgres[1809]: BEGIN vm-test-run-timescaledb> server # [ 153.979415] postgres[1809]: IF EXISTS ( vm-test-run-timescaledb> server # [ 153.981605] postgres[1809]: SELECT vm-test-run-timescaledb> server # [ 153.982838] postgres[1809]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 153.983172] postgres[1809]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 153.989075] postgres[1809]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 153.991595] postgres[1809]: WHERE ext.extname = 'pg_cron' vm-test-run-timescaledb> server # [ 153.992016] postgres[1809]: ) vm-test-run-timescaledb> server # [ 153.992577] postgres[1809]: THEN vm-test-run-timescaledb> server # [ 154.002179] postgres[1809]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 154.003626] postgres[1809]: vm-test-run-timescaledb> server # [ 154.012904] postgres[1809]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 154.021249] postgres[1809]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 154.023413] postgres[1809]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 154.024072] postgres[1809]: vm-test-run-timescaledb> server # [ 154.024439] postgres[1809]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 154.034523] postgres[1809]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 154.041810] postgres[1809]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 154.042981] postgres[1809]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 154.043583] postgres[1809]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 154.051599] postgres[1809]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 154.057765] postgres[1809]: vm-test-run-timescaledb> server # [ 154.058144] postgres[1809]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 154.059336] postgres[1809]: revoke all on table cron.job from postgres; vm-test-run-timescaledb> server # [ 154.064864] postgres[1809]: grant select on table cron.job to postgres with grant option; vm-test-run-timescaledb> server # [ 154.066399] postgres[1809]: END IF; vm-test-run-timescaledb> server # [ 154.066975] postgres[1809]: END; vm-test-run-timescaledb> server # [ 154.072859] postgres[1809]: $$; vm-test-run-timescaledb> server # [ 154.088834] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1804]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 154.090618] postgres[1809]: ::1 2026-10-07 19:33:44.743 UTC [1809] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-timescaledb> server # [ 154.137546] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1804]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 154.149899] postgres[1809]: ::1 2026-10-07 19:33:44.789 UTC [1809] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-timescaledb> server # [ 154.186518] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1804]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 154.205007] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1804]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 154.208246] postgres[1809]: ::1 2026-10-07 19:33:44.819 UTC [1809] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-timescaledb> server # [ 154.238251] postgres[1809]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-timescaledb> server # [ 154.254976] postgres[1809]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 154.259025] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-timescaledb> server # [ 154.683605] postgres[1825]: ::1 2026-10-07 19:33:45.324 UTC [1825] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-timescaledb> server # [ 154.730930] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1821]: ALTER ROLE vm-test-run-timescaledb> server # [ 154.785487] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-timescaledb> server # [ 155.209781] postgres[1833]: ::1 2026-10-07 19:33:45.844 UTC [1833] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-timescaledb> server # [ 155.292086] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1829]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 155.302108] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1829]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 155.304380] postgres[1833]: ::1 2026-10-07 19:33:45.941 UTC [1833] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-timescaledb> server # [ 155.317645] postgres[1833]: ::1 2026-10-07 19:33:45.955 UTC [1833] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-timescaledb> server # [ 155.319254] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1829]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 155.365470] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 155.734885] postgres[1835]: ::1 2026-10-07 19:33:46.378 UTC [1835] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-timescaledb> server # [ 155.759810] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1834]: GRANT ROLE vm-test-run-timescaledb> server # [ 155.802002] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-timescaledb> server # [ 156.726993] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1836]: DO vm-test-run-timescaledb> server # [ 156.779430] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-timescaledb> server # [ 157.480081] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1844]: DO vm-test-run-timescaledb> server # [ 157.503119] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1844]: DO vm-test-run-timescaledb> server # [ 157.570557] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-timescaledb> server # [ 158.042664] postgres[1861]: ::1 2026-10-07 19:33:48.688 UTC [1861] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-timescaledb> server # [ 158.087209] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1856]: ALTER ROLE vm-test-run-timescaledb> server # [ 158.091153] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1856]: ALTER ROLE vm-test-run-timescaledb> server # [ 158.098519] postgres[1861]: ::1 2026-10-07 19:33:48.722 UTC [1861] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-timescaledb> server # [ 158.109560] postgres[1861]: ::1 2026-10-07 19:33:48.738 UTC [1861] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-timescaledb> server # [ 158.122890] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1856]: ALTER ROLE vm-test-run-timescaledb> server # [ 158.147646] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-timescaledb> server # [ 158.533287] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1866]: DO vm-test-run-timescaledb> server # [ 158.596027] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-timescaledb> server # [ 159.027349] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1868]: DO vm-test-run-timescaledb> server # [ 159.071076] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-timescaledb> server # [ 159.490495] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1874]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 159.498004] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1874]: DO vm-test-run-timescaledb> server # [ 159.533816] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-timescaledb> server # [ 159.823720] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1876]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 159.837743] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1876]: GRANT vm-test-run-timescaledb> server # [ 159.890436] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-timescaledb> server # [ 160.264335] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1878]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 160.320898] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1878]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 160.336760] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1878]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 160.397115] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 160.882175] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1888]: DO vm-test-run-timescaledb> server # [ 160.913266] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-timescaledb> server # [ 161.399712] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1900]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 161.426176] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1900]: GRANT vm-test-run-timescaledb> server # [ 161.465514] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-timescaledb> server # [ 161.879833] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1905]: REVOKE ROLE vm-test-run-timescaledb> server # [ 161.914010] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1905]: DO vm-test-run-timescaledb> server # [ 161.925128] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1905]: DO vm-test-run-timescaledb> server # [ 161.934526] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1905]: REVOKE ROLE vm-test-run-timescaledb> server # [ 161.961661] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1905]: REVOKE vm-test-run-timescaledb> server # [ 161.984824] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1905]: DO vm-test-run-timescaledb> server # [ 162.043806] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 162.307046] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1910]: DO vm-test-run-timescaledb> server # [ 162.335111] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 162.770197] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1912]: DO vm-test-run-timescaledb> server # [ 162.824752] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 163.250483] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1918]: DO vm-test-run-timescaledb> server # [ 163.313532] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-timescaledb> server # [ 163.725409] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1920]: ALTER ROLE vm-test-run-timescaledb> server # [ 163.763357] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-timescaledb> server # [ 164.207014] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1929]: GRANT ROLE vm-test-run-timescaledb> server # [ 164.257667] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1929]: DO vm-test-run-timescaledb> server # [ 164.338827] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-timescaledb> server # [ 164.871842] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1941]: GRANT vm-test-run-timescaledb> server # [ 164.916962] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-timescaledb> server # [ 165.405424] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1950]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 165.407027] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1950]: REVOKE vm-test-run-timescaledb> server # [ 165.424951] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1950]: REVOKE vm-test-run-timescaledb> server # [ 165.430735] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1950]: GRANT vm-test-run-timescaledb> server # [ 165.483616] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-timescaledb> server # [ 165.771662] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1952]: DO vm-test-run-timescaledb> server # [ 165.800915] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-timescaledb> server # [ 166.090839] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1954]: ALTER ROLE vm-test-run-timescaledb> server # [ 166.127281] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-timescaledb> server # [ 166.607782] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1956]: DROP EXTENSION vm-test-run-timescaledb> server # [ 166.681840] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-timescaledb> server # [ 167.347083] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1962]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 167.351420] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1962]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 167.362461] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1962]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 167.403303] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-timescaledb> server # [ 167.921134] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1973]: DO vm-test-run-timescaledb> server # [ 167.956991] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1973]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 168.039175] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-timescaledb> server # [ 168.479382] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1984]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 168.514614] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1984]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 168.561543] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Running postgresql schema... vm-test-run-timescaledb> server # [ 168.947025] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER DATABASE vm-test-run-timescaledb> server # [ 168.959078] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER DATABASE vm-test-run-timescaledb> server # [ 169.035703] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER ROLE vm-test-run-timescaledb> server # [ 169.133406] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER ROLE vm-test-run-timescaledb> server # [ 169.215183] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER ROLE vm-test-run-timescaledb> server # [ 169.315284] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER ROLE vm-test-run-timescaledb> server # [ 169.373900] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER ROLE vm-test-run-timescaledb> server # [ 169.433192] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER ROLE vm-test-run-timescaledb> server # [ 169.499891] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER ROLE vm-test-run-timescaledb> server # [ 169.563500] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER ROLE vm-test-run-timescaledb> server # [ 169.634284] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER ROLE vm-test-run-timescaledb> server # [ 169.645144] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1991]: ALTER ROLE vm-test-run-timescaledb> server # [ 169.711101] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1433]: Database initialization complete vm-test-run-timescaledb> server # [ 169.747824] systemd[1]: Finished Supabase Database Initialization. vm-test-run-timescaledb> server # [ 169.772604] systemd[1]: Reached target Multi-User System. vm-test-run-timescaledb> server # [ 169.785418] systemd[1]: Startup finished in 16.599s (kernel) + 2min 33.176s (userspace) = 2min 49.775s. vm-test-run-timescaledb> server: (finished: waiting for unit supabase-db-init.service, in 172.23 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.51 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.47 seconds) vm-test-run-timescaledb> (finished: subtest: Verify PostgreSQL 15 is our custom build, in 0.98 seconds) vm-test-run-timescaledb> subtest: Verify ansible config loaded vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW shared_preload_libraries;" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW shared_preload_libraries;", in 0.51 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.80 seconds) vm-test-run-timescaledb> (finished: subtest: Verify ansible config loaded, in 1.31 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.72 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.60 seconds) vm-test-run-timescaledb> (finished: subtest: Verify init scripts and migrations ran, in 1.33 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.52 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 # [ 181.348063] postgres[2071]: [local] 2026-10-07 19:34:11.985 UTC [2071] supabase_admin@postgres WARNING: vm-test-run-timescaledb> server # [ 181.367970] postgres[2071]: WELCOME TO vm-test-run-timescaledb> server # [ 181.379465] postgres[2071]: _____ _ _ ____________ vm-test-run-timescaledb> server # [ 181.385577] postgres[2071]: |_ _(_) | | | _ \ ___ \ vm-test-run-timescaledb> server # [ 181.386812] postgres[2071]: | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ / vm-test-run-timescaledb> server # [ 181.388973] postgres[2071]: | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \ vm-test-run-timescaledb> server # [ 181.390962] postgres[2071]: | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ / vm-test-run-timescaledb> server # [ 181.393368] postgres[2071]: |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/ vm-test-run-timescaledb> server # [ 181.393934] postgres[2071]: Running version 2.9.1 vm-test-run-timescaledb> server # [ 181.394889] postgres[2071]: For more information on TimescaleDB, please visit the following links: vm-test-run-timescaledb> server # [ 181.396221] postgres[2071]: vm-test-run-timescaledb> server # [ 181.398112] postgres[2071]: 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started vm-test-run-timescaledb> server # [ 181.399023] postgres[2071]: 2. API reference documentation: https://docs.timescale.com/api/latest vm-test-run-timescaledb> server # [ 181.399961] postgres[2071]: 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts vm-test-run-timescaledb> server # [ 181.401166] postgres[2071]: vm-test-run-timescaledb> server # [ 181.401601] postgres[2071]: 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 # [ 181.402029] postgres[2071]: vm-test-run-timescaledb> server # [ 181.402282] postgres[2071]: [local] 2026-10-07 19:34:11.985 UTC [2071] supabase_admin@postgres CONTEXT: PL/pgSQL function inline_code_block line 16 at RAISE vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.9.1' CASCADE;" , in 6.37 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 # [ 182.019640] postgres[2127]: 2026-10-07 19:34:12.663 UTC [2127] LOG: job 2 threw an error vm-test-run-timescaledb> server # [ 182.031644] postgres[2127]: 2026-10-07 19:34:12.687 UTC [2127] ERROR: functionality not supported under the current "apache" license vm-test-run-timescaledb> server # [ 182.042655] postgres[2127]: 2026-10-07 19:34:12.687 UTC [2127] HINT: Upgrade your license to 'timescale' to use this free community feature. vm-test-run-timescaledb> server # [ 182.075838] postgres[1374]: 2026-10-07 19:34:12.722 UTC [1374] LOG: background worker "Error Log Retention Policy [2]" (PID 2127) 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.92 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 # [ 183.355797] postgres[2112]: 2026-10-07 19:34:14.003 UTC [2112] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 183.383164] postgres[1374]: 2026-10-07 19:34:14.036 UTC [1374] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2112) exited with exit code 1 vm-test-run-timescaledb> server # [ 189.311776] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 vm-test-run-timescaledb> server # [ 190.263007] postgres[2142]: 2026-10-07 19:34:20.910 UTC [2142] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 190.291970] postgres[1374]: 2026-10-07 19:34:20.945 UTC [1374] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2142) 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 8.25 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 # [ 191.184435] postgres[2193]: 2026-10-07 19:34:21.810 UTC [2193] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 191.192188] postgres[2193]: 2026-10-07 19:34:21.816 UTC [2193] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 191.202090] postgres[2193]: 2026-10-07 19:34:21.816 UTC [2193] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 191.206153] postgres[1374]: 2026-10-07 19:34:21.853 UTC [1374] LOG: background worker "Job History Log Retention Policy [3]" (PID 2193) 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.77 seconds) vm-test-run-timescaledb> (finished: subtest: Check upgrade path with postgresql 15, in 16.83 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 # [ 192.050880] postgres[2185]: 2026-10-07 19:34:22.692 UTC [2185] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 192.113339] postgres[1374]: 2026-10-07 19:34:22.758 UTC [1374] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 2185) 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 1.58 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 # [ 198.446848] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-timescaledb> server # [ 198.845835] systemd[1]: Starting Virtual Console Setup... vm-test-run-timescaledb> server # [ 199.054555] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 199.074117] systemd[1]: Stopped Virtual Console Setup. vm-test-run-timescaledb> server # [ 199.118995] systemd[1]: Starting Virtual Console Setup... 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 6.13 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 # [ 199.670898] postgres[2270]: 2026-10-07 19:34:30.317 UTC [2270] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 199.677881] postgres[2270]: 2026-10-07 19:34:30.330 UTC [2270] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 199.680046] postgres[2270]: 2026-10-07 19:34:30.330 UTC [2270] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 199.717315] postgres[1374]: 2026-10-07 19:34:30.370 UTC [1374] LOG: background worker "Job History Log Retention Policy [3]" (PID 2270) 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.92 seconds) vm-test-run-timescaledb> (finished: subtest: Check the install of the last version of the extension, in 8.62 seconds) vm-test-run-timescaledb> (finished: run the VM test script, in 201.50 seconds) vm-test-run-timescaledb> test script finished in 202.26s vm-test-run-timescaledb> cleanup vm-test-run-timescaledb> kill machine (pid 9) vm-test-run-timescaledb> qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13) vm-test-run-timescaledb> vde_switch: EOF data port: Interrupted system call vm-test-run-timescaledb> kill vlan (pid 7) vm-test-run-timescaledb> (finished: cleanup, in 0.01 seconds) vm-test-run-timescaledb> vde_switch: Caught signal 15, cleaning up and exiting