these 19 derivations will be built: /nix/store/7b9dmjs4f8vs7pc4p6d7j14cll2kzp3p-supabase-db-init.drv /nix/store/3f8ddrfi4nc2aj01gsv665bcpn3fv6pv-unit-supabase-db-init.service.drv /nix/store/d8d5gimgv7fhpj7j3wmb8zplgsjywyjd-system-path.drv /nix/store/39rzvxhrjbvxvhv1d7ygfypvpiawwrmy-dbus-1.drv /nix/store/pc6mx1q30vddri11l5avsr9a50dvb169-X-Restart-Triggers-dbus.drv /nix/store/3z2ks19207zff59kqfsx90n1wc4r4b23-unit-dbus.service.drv /nix/store/qqh1vlbdb9dgmg2qq68d65fij4lygl47-postgresql-init.drv /nix/store/f25fbwzn8yspc10n0pc1h6hab4r89jm7-unit-postgresql.service.drv /nix/store/29jkg9ghhnhfxr6kjrcqgydc9nsxrbga-system-units.drv /nix/store/n9laisjq4djzj84cab5xk2y67wybhnn5-unit-dbus.service.drv /nix/store/xys9fg87sc6y856h1xz7bdag0pr89y2v-user-units.drv /nix/store/76c13b8ylisfqmxfx1ppk3l54ac83b48-etc.drv /nix/store/qj6ya4r8gvd6kg13yf8rh9j0ckja1d0l-activate.drv /nix/store/mw2l1lb2zmnjzxmsb2ivcdsnvh2mk75w-nixos-system-server-test.drv /nix/store/fi8pw4sdin66q5yby2ql8m2cysh7znwl-closure-info.drv /nix/store/h017f6dnvpqrwbqz4v5977kwjhwnwv3w-run-nixos-vm.drv /nix/store/22fr15wyd850pn48g0xf5pa0vjhbxkms-nixos-vm.drv /nix/store/zzvcn1fmjkkybqvjg9i2fpa1ds3cba4h-nixos-test-driver-timescaledb.drv /nix/store/w7b0jqrwj9gb1ln2g8bcxbsm1lz4as23-vm-test-run-timescaledb.drv building '/nix/store/d8d5gimgv7fhpj7j3wmb8zplgsjywyjd-system-path.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/d8d5gimgv7fhpj7j3wmb8zplgsjywyjd-system-path.drv' system-path> created 6951 symlinks in user environment building '/nix/store/39rzvxhrjbvxvhv1d7ygfypvpiawwrmy-dbus-1.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/39rzvxhrjbvxvhv1d7ygfypvpiawwrmy-dbus-1.drv' building '/nix/store/pc6mx1q30vddri11l5avsr9a50dvb169-X-Restart-Triggers-dbus.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/pc6mx1q30vddri11l5avsr9a50dvb169-X-Restart-Triggers-dbus.drv' building '/nix/store/3z2ks19207zff59kqfsx90n1wc4r4b23-unit-dbus.service.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/n9laisjq4djzj84cab5xk2y67wybhnn5-unit-dbus.service.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/3z2ks19207zff59kqfsx90n1wc4r4b23-unit-dbus.service.drv' building '/nix/store/n9laisjq4djzj84cab5xk2y67wybhnn5-unit-dbus.service.drv' building '/nix/store/29jkg9ghhnhfxr6kjrcqgydc9nsxrbga-system-units.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/xys9fg87sc6y856h1xz7bdag0pr89y2v-user-units.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/29jkg9ghhnhfxr6kjrcqgydc9nsxrbga-system-units.drv' building '/nix/store/xys9fg87sc6y856h1xz7bdag0pr89y2v-user-units.drv' building '/nix/store/76c13b8ylisfqmxfx1ppk3l54ac83b48-etc.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/76c13b8ylisfqmxfx1ppk3l54ac83b48-etc.drv' building '/nix/store/qj6ya4r8gvd6kg13yf8rh9j0ckja1d0l-activate.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/qj6ya4r8gvd6kg13yf8rh9j0ckja1d0l-activate.drv' building '/nix/store/mw2l1lb2zmnjzxmsb2ivcdsnvh2mk75w-nixos-system-server-test.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/mw2l1lb2zmnjzxmsb2ivcdsnvh2mk75w-nixos-system-server-test.drv' building '/nix/store/fi8pw4sdin66q5yby2ql8m2cysh7znwl-closure-info.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/fi8pw4sdin66q5yby2ql8m2cysh7znwl-closure-info.drv' closure-info> structuredAttrs is enabled building '/nix/store/h017f6dnvpqrwbqz4v5977kwjhwnwv3w-run-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/h017f6dnvpqrwbqz4v5977kwjhwnwv3w-run-nixos-vm.drv' building '/nix/store/22fr15wyd850pn48g0xf5pa0vjhbxkms-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/22fr15wyd850pn48g0xf5pa0vjhbxkms-nixos-vm.drv' building '/nix/store/zzvcn1fmjkkybqvjg9i2fpa1ds3cba4h-nixos-test-driver-timescaledb.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/zzvcn1fmjkkybqvjg9i2fpa1ds3cba4h-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/w7b0jqrwj9gb1ln2g8bcxbsm1lz4as23-vm-test-run-timescaledb.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/w7b0jqrwj9gb1ln2g8bcxbsm1lz4as23-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: QEMU running (pid 9) vm-test-run-timescaledb> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-timescaledb> (finished: start all VMs, in 0.24 seconds) vm-test-run-timescaledb> server # Formatting '/build/vm-state-server/tmp.S9dC7GpY0p', fmt=raw size=1073741824 vm-test-run-timescaledb> server: waiting for unit supabase-db-init.service 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: ddca177d-24fb-4372-acfe-b843d7db5399 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: waiting for the VM to finish booting 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 # [ 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/d4cq0p03ch9q6i75dgij1yavs51zr473-nixos-system-server-test/init regInfo=/nix/store/i7mm86w4ybirp8dvlnbpp4305vjdw3hk-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-timescaledb> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/i7mm86w4ybirp8dvlnbpp4305vjdw3hk-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.000029] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-timescaledb> server # [ 0.002592] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-timescaledb> server # [ 0.008808] Console: colour dummy device 80x25 vm-test-run-timescaledb> server # [ 0.009973] printk: legacy console [tty0] enabled vm-test-run-timescaledb> server # [ 0.014348] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-timescaledb> server # [ 0.014665] pid_max: default: 32768 minimum: 301 vm-test-run-timescaledb> server # [ 0.016261] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-timescaledb> server # [ 0.019294] landlock: Up and running. vm-test-run-timescaledb> server # [ 0.019338] Yama: becoming mindful. vm-test-run-timescaledb> server # [ 0.021748] LSM support for eBPF active vm-test-run-timescaledb> server # [ 0.024532] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.024649] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.049135] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-timescaledb> server # [ 0.058504] rcu: Hierarchical SRCU implementation. vm-test-run-timescaledb> server # [ 0.058595] rcu: Max phase no-delay instances is 1000. vm-test-run-timescaledb> server # [ 0.059760] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-timescaledb> server # [ 0.065503] fsl-mc MSI: its@8080000 domain created vm-test-run-timescaledb> server # [ 0.067091] EFI services will not be available. vm-test-run-timescaledb> server # [ 0.068834] smp: Bringing up secondary CPUs ... vm-test-run-timescaledb> server # [ 0.072548] Detected PIPT I-cache on CPU1 vm-test-run-timescaledb> server # [ 0.073716] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-timescaledb> server # [ 0.074376] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000 vm-test-run-timescaledb> server # [ 0.075677] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-timescaledb> server # [ 0.078749] smp: Brought up 1 node, 2 CPUs vm-test-run-timescaledb> server # [ 0.078868] SMP: Total of 2 processors activated. vm-test-run-timescaledb> server # [ 0.078903] CPU: All CPU(s) started at EL1 vm-test-run-timescaledb> server # [ 0.079026] CPU features: detected: Branch Target Identification vm-test-run-timescaledb> server # [ 0.079071] CPU features: detected: 32-bit EL0 Support vm-test-run-timescaledb> server # [ 0.079095] CPU features: detected: 32-bit EL1 Support vm-test-run-timescaledb> server # [ 0.079114] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-timescaledb> server # [ 0.079140] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-timescaledb> server # [ 0.079171] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-timescaledb> server # [ 0.079228] CPU features: detected: Common not Private translations vm-test-run-timescaledb> server # [ 0.079248] CPU features: detected: CRC32 instructions vm-test-run-timescaledb> server # [ 0.079270] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-timescaledb> server # [ 0.079294] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-timescaledb> server # [ 0.079314] CPU features: detected: Data independent timing control (DIT) vm-test-run-timescaledb> server # [ 0.079334] CPU features: detected: E0PD vm-test-run-timescaledb> server # [ 0.079350] CPU features: detected: Enhanced Counter Virtualization vm-test-run-timescaledb> server # [ 0.079369] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-timescaledb> server # [ 0.079389] CPU features: detected: Enhanced Privileged Access Never vm-test-run-timescaledb> server # [ 0.079410] CPU features: detected: Enhanced Virtualization Traps vm-test-run-timescaledb> server # [ 0.079434] CPU features: detected: Fine Grained Traps vm-test-run-timescaledb> server # [ 0.079485] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.079564] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-timescaledb> server # [ 0.079619] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-timescaledb> server # [ 0.079646] CPU features: detected: LSE atomic instructions vm-test-run-timescaledb> server # [ 0.079669] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-timescaledb> server # [ 0.079695] CPU features: detected: Privileged Access Never vm-test-run-timescaledb> server # [ 0.079722] CPU features: detected: RAS Extension Support vm-test-run-timescaledb> server # [ 0.079745] CPU features: detected: Random Number Generator vm-test-run-timescaledb> server # [ 0.079767] CPU features: detected: Speculation barrier (SB) vm-test-run-timescaledb> server # [ 0.079788] CPU features: detected: Stage-2 Force Write-Back vm-test-run-timescaledb> server # [ 0.079813] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-timescaledb> server # [ 0.079846] CPU features: detected: TLB range maintenance instructions vm-test-run-timescaledb> server # [ 0.079872] CPU features: detected: WFx with timeout vm-test-run-timescaledb> server # [ 0.079916] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-timescaledb> server # [ 0.079948] CPU features: detected: Scalable Vector Extension vm-test-run-timescaledb> server # [ 0.084621] alternatives: applying system-wide alternatives vm-test-run-timescaledb> server # [ 0.100142] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-timescaledb> server # [ 0.100660] SVE: maximum available vector length 256 bytes per vector vm-test-run-timescaledb> server # [ 0.100737] SVE: default vector length 64 bytes per vector vm-test-run-timescaledb> server # [ 0.112059] Memory: 3922824K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-timescaledb> server # [ 0.132072] devtmpfs: initialized vm-test-run-timescaledb> server # [ 0.154029] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-timescaledb> server # [ 0.154496] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.156364] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-timescaledb> server # [ 0.156411] 0 pages in range for non-PLT usage vm-test-run-timescaledb> server # [ 0.156442] 509248 pages in range for PLT usage vm-test-run-timescaledb> server # [ 0.158368] pinctrl core: initialized pinctrl subsystem vm-test-run-timescaledb> server # [ 0.165978] DMI not present or invalid. vm-test-run-timescaledb> server # [ 0.180619] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-timescaledb> server # [ 0.190195] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-timescaledb> server # [ 0.190929] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-timescaledb> server # [ 0.191704] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-timescaledb> server # [ 0.191900] audit: initializing netlink subsys (disabled) vm-test-run-timescaledb> server # [ 0.193306] audit: type=2000 audit(0.072:1): state=initialized audit_enabled=0 res=1 vm-test-run-timescaledb> server # [ 0.198155] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-timescaledb> server # [ 0.198192] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-timescaledb> server # [ 0.198232] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-timescaledb> server # [ 0.198256] thermal_sys: Registered thermal governor 'user_space' vm-test-run-timescaledb> server # [ 0.198276] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-timescaledb> server # [ 0.198866] cpuidle: using governor ladder vm-test-run-timescaledb> server # [ 0.199121] cpuidle: using governor menu vm-test-run-timescaledb> server # [ 0.200744] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-timescaledb> server # [ 0.201291] ASID allocator initialised with 65536 entries vm-test-run-timescaledb> server # [ 0.207761] Serial: AMBA PL011 UART driver vm-test-run-timescaledb> server # [ 0.244274] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-timescaledb> server # [ 0.245674] printk: legacy console [ttyAMA0] enabled vm-test-run-timescaledb> server # [ 0.275440] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.275658] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-timescaledb> server # [ 0.275763] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.275888] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-timescaledb> server # [ 0.275980] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.276068] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-timescaledb> server # [ 0.276290] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.276514] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-timescaledb> server # [ 0.288929] fbcon: Taking over console vm-test-run-timescaledb> server # [ 0.289712] ACPI: Interpreter disabled. vm-test-run-timescaledb> server # [ 0.296334] iommu: Default domain type: Translated vm-test-run-timescaledb> server # [ 0.296468] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-timescaledb> server # [ 0.303030] SCSI subsystem initialized vm-test-run-timescaledb> server # [ 0.307947] usbcore: registered new interface driver usbfs vm-test-run-timescaledb> server # [ 0.308288] usbcore: registered new interface driver hub vm-test-run-timescaledb> server # [ 0.309363] usbcore: registered new device driver usb vm-test-run-timescaledb> server # [ 0.311459] pps_core: LinuxPPS API ver. 1 registered vm-test-run-timescaledb> server # [ 0.311575] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-timescaledb> server # [ 0.311854] PTP clock support registered vm-test-run-timescaledb> server # [ 0.312862] EDAC MC: Ver: 3.0.0 vm-test-run-timescaledb> server # [ 0.314490] scmi_core: SCMI protocol bus registered vm-test-run-timescaledb> server # [ 0.316814] FPGA manager framework vm-test-run-timescaledb> server # [ 0.318943] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-timescaledb> server # [ 0.326377] vgaarb: loaded vm-test-run-timescaledb> server # [ 0.330696] clocksource: Switched to clocksource arch_sys_counter vm-test-run-timescaledb> server # [ 0.335055] VFS: Disk quotas dquot_6.6.0 vm-test-run-timescaledb> server # [ 0.335249] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-timescaledb> server # [ 0.337304] netfs: FS-Cache loaded vm-test-run-timescaledb> server # [ 0.339121] pnp: PnP ACPI: disabled vm-test-run-timescaledb> server # [ 0.366010] NET: Registered PF_INET protocol family vm-test-run-timescaledb> server # [ 0.368353] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-timescaledb> server # [ 0.457557] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.457926] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.458229] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.459697] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-timescaledb> server # [ 0.460349] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-timescaledb> server # [ 0.461635] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-timescaledb> server # [ 0.462017] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.462738] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.463955] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-timescaledb> server # [ 0.464394] NET: Registered PF_XDP protocol family vm-test-run-timescaledb> server # [ 0.464634] PCI: CLS 0 bytes, default 64 vm-test-run-timescaledb> server # [ 0.467334] Trying to unpack rootfs image as initramfs... vm-test-run-timescaledb> server # [ 0.468222] kvm [1]: HYP mode not available vm-test-run-timescaledb> server # [ 0.565150] Initialise system trusted keyrings vm-test-run-timescaledb> server # [ 0.567984] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-timescaledb> server # [ 0.574222] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-timescaledb> server # [ 0.576220] 9p: Installing v9fs 9p2000 file system support vm-test-run-timescaledb> server # [ 0.635977] Key type asymmetric registered vm-test-run-timescaledb> server # [ 0.636199] Asymmetric key parser 'x509' registered vm-test-run-timescaledb> server # [ 0.637035] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-timescaledb> server # [ 0.638049] io scheduler mq-deadline registered vm-test-run-timescaledb> server # [ 0.638192] io scheduler kyber registered vm-test-run-timescaledb> server # [ 0.660117] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-timescaledb> server # [ 0.663972] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-timescaledb> server # [ 0.667591] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-timescaledb> server # [ 0.668642] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-timescaledb> server # [ 0.669210] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-timescaledb> server # [ 0.669733] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-timescaledb> server # [ 0.671435] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-timescaledb> server # [ 0.671939] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-timescaledb> server # [ 0.673223] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-timescaledb> server # [ 0.673661] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-timescaledb> server # [ 0.674477] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.675417] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.675613] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.676670] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.679020] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.679671] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.679780] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.679900] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.680020] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.680970] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.681098] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.681174] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.681260] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.681730] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.681883] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.681964] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.682072] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.683362] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.683484] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.683561] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.683649] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.684010] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.684129] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.684210] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.684303] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.684673] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.684788] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-timescaledb> server # [ 0.684862] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.684948] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.685327] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.685639] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.685729] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.685829] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.685923] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.686306] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.687118] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.687235] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.687713] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.687854] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.687950] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.688391] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.688513] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.688880] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.689054] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.689147] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.689238] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.689703] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.689832] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.689913] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.690003] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.691431] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.691612] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.691753] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.691918] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.692044] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.692151] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.692256] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.692361] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.692465] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.692570] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.692675] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.692779] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.692911] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.693928] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-timescaledb> server # [ 0.694144] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-timescaledb> server # [ 0.694360] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-timescaledb> server # [ 0.694451] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-timescaledb> server # [ 0.694540] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-timescaledb> server # [ 0.694631] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-timescaledb> server # [ 0.694718] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-timescaledb> server # [ 0.694807] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-timescaledb> server # [ 0.694897] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-timescaledb> server # [ 0.695882] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-timescaledb> server # [ 0.696448] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-timescaledb> server # [ 0.697183] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-timescaledb> server # [ 0.697413] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-timescaledb> server # [ 0.697910] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-timescaledb> server # [ 0.698112] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-timescaledb> server # [ 0.698347] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-timescaledb> server # [ 0.698450] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-timescaledb> server # [ 0.698537] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-timescaledb> server # [ 0.698621] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-timescaledb> server # [ 0.698702] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-timescaledb> server # [ 0.699418] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-timescaledb> server # [ 0.700002] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.700691] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.700906] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.701831] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.778468] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.782438] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.785172] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.788117] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.791679] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.793517] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.796069] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.798531] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.801928] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.804024] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.806875] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.832073] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-timescaledb> server # [ 0.841230] msm_serial: driver initialized vm-test-run-timescaledb> server # [ 0.842147] SuperH (H)SCI(F) driver initialized vm-test-run-timescaledb> server # [ 0.843263] STM32 USART driver initialized vm-test-run-timescaledb> server # [ 0.891745] Freeing initrd memory: 10684K vm-test-run-timescaledb> server # [ 0.895259] loop: module loaded vm-test-run-timescaledb> server # [ 0.896345] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-timescaledb> server # [ 0.899899] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-timescaledb> server # [ 0.912885] megasas: 07.727.03.00-rc1 vm-test-run-timescaledb> server # [ 0.917763] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-timescaledb> server # [ 0.921503] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 0.923362] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 0.926644] Using buffer write method vm-test-run-timescaledb> server # [ 0.927198] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-timescaledb> server # [ 0.929731] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 0.929947] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 0.934503] Using buffer write method vm-test-run-timescaledb> server # [ 0.935801] Concatenating MTD devices: vm-test-run-timescaledb> server # [ 0.936403] (0): "0.flash" vm-test-run-timescaledb> server # [ 0.937250] (1): "0.flash" vm-test-run-timescaledb> server # [ 0.937313] into device "0.flash" vm-test-run-timescaledb> server # [ 0.962197] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-timescaledb> server # [ 0.971889] thunder_xcv, ver 1.0 vm-test-run-timescaledb> server # [ 0.972117] thunder_bgx, ver 1.0 vm-test-run-timescaledb> server # [ 0.972273] nicpf, ver 1.0 vm-test-run-timescaledb> server # [ 0.974445] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-timescaledb> server # [ 0.974587] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-timescaledb> server # [ 0.975041] hclge is initializing vm-test-run-timescaledb> server # [ 0.975539] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 0.975678] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-timescaledb> server # [ 0.975942] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 0.976015] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-timescaledb> server # [ 0.976216] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-timescaledb> server # [ 0.976463] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-timescaledb> server # [ 0.976650] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-timescaledb> server # [ 0.976797] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-timescaledb> server # [ 0.977720] sky2: driver version 1.30 vm-test-run-timescaledb> server # [ 0.983359] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-timescaledb> server # [ 0.984580] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-timescaledb> server # [ 0.985117] usbcore: registered new interface driver usb-storage vm-test-run-timescaledb> server # [ 0.985730] usbcore: registered new interface driver usbserial_generic vm-test-run-timescaledb> server # [ 0.985980] usbserial: USB Serial support registered for generic vm-test-run-timescaledb> server # [ 0.988120] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-timescaledb> server # [ 0.994970] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-timescaledb> server # [ 0.995497] rtc-pl031 9010000.pl031: setting system clock to 2026-10-06T20:05:45 UTC (1791317145) vm-test-run-timescaledb> server # [ 0.996944] i2c_dev: i2c /dev entries driver vm-test-run-timescaledb> server # [ 1.004509] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-timescaledb> server # [ 1.009099] sdhci: Secure Digital Host Controller Interface driver vm-test-run-timescaledb> server # [ 1.009222] sdhci: Copyright(c) Pierre Ossman vm-test-run-timescaledb> server # [ 1.010281] hub 1-0:1.0: USB hub found vm-test-run-timescaledb> server # [ 1.011055] Synopsys Designware Multimedia Card Interface Driver vm-test-run-timescaledb> server # [ 1.011766] hub 1-0:1.0: 6 ports detected vm-test-run-timescaledb> server # [ 1.012936] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-timescaledb> server # [ 1.018585] hid: raw HID events driver (C) Jiri Kosina vm-test-run-timescaledb> server # [ 1.020472] usbcore: registered new interface driver usbhid vm-test-run-timescaledb> server # [ 1.020717] usbhid: USB HID core driver vm-test-run-timescaledb> server # [ 1.027597] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-timescaledb> server # [ 1.039687] drop_monitor: Initializing network drop monitor service vm-test-run-timescaledb> server # [ 1.040854] NET: Registered PF_INET6 protocol family vm-test-run-timescaledb> server # [ 1.051750] Segment Routing with IPv6 vm-test-run-timescaledb> server # [ 1.052193] In-situ OAM (IOAM) with IPv6 vm-test-run-timescaledb> server # [ 1.052902] NET: Registered PF_PACKET protocol family vm-test-run-timescaledb> server # [ 1.054481] 9pnet: Installing 9P2000 support vm-test-run-timescaledb> server # [ 1.058147] Key type dns_resolver registered vm-test-run-timescaledb> server # [ 1.089051] registered taskstats version 1 vm-test-run-timescaledb> server # [ 1.091007] Loading compiled-in X.509 certificates vm-test-run-timescaledb> server # [ 1.133183] Demotion targets for Node 0: null vm-test-run-timescaledb> server # [ 1.135378] Key type .fscrypt registered vm-test-run-timescaledb> server # [ 1.135528] Key type fscrypt-provisioning registered vm-test-run-timescaledb> server # [ 1.142228] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-timescaledb> server # [ 1.175383] clk: Disabling unused clocks vm-test-run-timescaledb> server # [ 1.175893] PM: genpd: Disabling unused power domains vm-test-run-timescaledb> server # [ 1.176174] ALSA device list: vm-test-run-timescaledb> server # [ 1.176674] No soundcards found. vm-test-run-timescaledb> server # [ 1.238620] Freeing unused kernel memory: 4416K vm-test-run-timescaledb> server # [ 1.240241] Run /init as init process vm-test-run-timescaledb> server # [ 1.264149] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-timescaledb> server # [ 1.561006] 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.626824] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-timescaledb> server # [ 1.710492] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-timescaledb> server # [ 1.711418] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-timescaledb> server # [ 1.711442] [drm] features: -context_init vm-test-run-timescaledb> server # [ 1.713226] [drm] number of scanouts: 1 vm-test-run-timescaledb> server # [ 1.713337] [drm] number of cap sets: 0 vm-test-run-timescaledb> server # [ 1.721653] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-timescaledb> server # [ 1.748384] Console: switching to colour frame buffer device 160x50 vm-test-run-timescaledb> server # [ 1.757289] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-timescaledb> server # [ 1.770779] 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.905533] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-timescaledb> server # [ 2.159591] 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.170094] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 vm-test-run-timescaledb> server # [ 3.924052] EXT4-fs (vda): mounted filesystem ddca177d-24fb-4372-acfe-b843d7db5399 r/w with ordered data mode. Quota mode: none. vm-test-run-timescaledb> server # [ 5.554949] EXT4-fs (vda): re-mounted ddca177d-24fb-4372-acfe-b843d7db5399. vm-test-run-timescaledb> server # [ 5.572392] booting system configuration /nix/store/d4cq0p03ch9q6i75dgij1yavs51zr473-nixos-system-server-test vm-test-run-timescaledb> server # [ 13.392046] 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 # [ 13.398969] systemd[1]: Detected virtualization qemu. vm-test-run-timescaledb> server # [ 13.403257] systemd[1]: Detected architecture arm64. vm-test-run-timescaledb> server # [ 13.406655] systemd[1]: Detected first boot. vm-test-run-timescaledb> server # [ 13.422440] systemd[1]: Initializing machine ID from random generator. vm-test-run-timescaledb> server # [ 13.441596] systemd[1]: Hostname set to . vm-test-run-timescaledb> server # [ 14.422264] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-timescaledb> server # [ 15.488369] systemd[1]: Applying preset policy. vm-test-run-timescaledb> server # [ 17.765639] systemd[1]: Populated /etc with preset unit settings. vm-test-run-timescaledb> server # [ 19.857619] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-timescaledb> server # [ 20.007098] systemd[1]: Created slice Slice /system/getty. vm-test-run-timescaledb> server # [ 20.019629] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-timescaledb> server # [ 20.030228] systemd[1]: Created slice User and Session Slice. vm-test-run-timescaledb> server # [ 20.037551] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-timescaledb> server # [ 20.042403] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-timescaledb> server # [ 20.047276] systemd[1]: Expecting device /dev/hvc0... vm-test-run-timescaledb> server # [ 20.051026] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-timescaledb> server # [ 20.055246] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-timescaledb> server # [ 20.059178] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-timescaledb> server # [ 20.063463] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-timescaledb> server # [ 20.066307] systemd[1]: Reached target Path Units. vm-test-run-timescaledb> server # [ 20.070270] systemd[1]: Reached target Remote File Systems. vm-test-run-timescaledb> server # [ 20.074486] systemd[1]: Reached target Slice Units. vm-test-run-timescaledb> server # [ 20.078199] systemd[1]: Reached target Swaps. vm-test-run-timescaledb> server # [ 20.104317] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-timescaledb> server # [ 20.122204] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-timescaledb> server # [ 20.131679] systemd[1]: Listening on Journal Audit Socket. vm-test-run-timescaledb> server # [ 20.136775] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-timescaledb> server # [ 20.141378] systemd[1]: Listening on Journal Sockets. vm-test-run-timescaledb> server # [ 20.147028] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-timescaledb> server # [ 20.150835] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 20.154961] systemd[1]: Listening on udev Control Socket. vm-test-run-timescaledb> server # [ 20.158745] systemd[1]: Listening on udev Kernel Socket. vm-test-run-timescaledb> server # [ 20.190211] systemd[1]: Mounting Huge Pages File System... vm-test-run-timescaledb> server # [ 20.218844] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-timescaledb> server # [ 20.253631] systemd[1]: Mounting Kernel Debug File System... vm-test-run-timescaledb> server # [ 20.315632] systemd[1]: Mounting Kernel Trace File System... vm-test-run-timescaledb> server # [ 20.428082] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-timescaledb> server # [ 20.506782] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-timescaledb> server # [ 20.525886] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-timescaledb> server # [ 20.644235] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-timescaledb> server # [ 20.650793] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-timescaledb> server # [ 20.667877] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-timescaledb> server # [ 20.749038] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-timescaledb> server # [ 20.759462] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-timescaledb> server # [ 20.764440] 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 # [ 20.877630] systemd[1]: Starting Journal Service... vm-test-run-timescaledb> server # [ 20.967216] systemd[1]: Starting Load Kernel Modules... vm-test-run-timescaledb> server # [ 21.051701] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-timescaledb> server # [ 21.115382] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-timescaledb> server # [ 21.122203] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 21.198011] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-timescaledb> server # [ 21.280256] systemd[1]: Mounted Huge Pages File System. vm-test-run-timescaledb> server # [ 21.292384] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-timescaledb> server # [ 21.302082] systemd[1]: Mounted Kernel Debug File System. vm-test-run-timescaledb> server # [ 21.310091] systemd[1]: Mounted Kernel Trace File System. vm-test-run-timescaledb> server # [ 21.338327] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-timescaledb> server # [ 21.362039] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-timescaledb> server # [ 21.442474] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-timescaledb> server # [ 21.509868] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 21.549273] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-timescaledb> server # [ 21.909826] fuse: init (API version 7.41) vm-test-run-timescaledb> server # [ 21.989588] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 22.004655] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-timescaledb> server # [ 22.052392] systemd[1]: Mounting FUSE Control File System... vm-test-run-timescaledb> server # [ 22.159454] EXT4-fs (vda): re-mounted ddca177d-24fb-4372-acfe-b843d7db5399. vm-test-run-timescaledb> server # [ 22.228651] systemd[1]: Finished Load Kernel Modules. vm-test-run-timescaledb> server # [ 22.302326] systemd[1]: Starting Firewall... vm-test-run-timescaledb> server # [ 22.352734] systemd[1]: Starting Apply Kernel Variables... vm-test-run-timescaledb> server # [ 22.388535] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-timescaledb> server # [ 22.403908] systemd[1]: Mounted FUSE Control File System. vm-test-run-timescaledb> server # [ 22.413927] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-timescaledb> server # [ 22.477769] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-timescaledb> server # [ 22.488650] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 22.542525] systemd-journald[395]: Collecting audit messages is enabled. vm-test-run-timescaledb> server # [ 23.268821] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-timescaledb> server # [ 23.284977] systemd[1]: Reached target First Boot Complete. vm-test-run-timescaledb> server # [ 23.681222] systemd[1]: Finished Apply Kernel Variables. vm-test-run-timescaledb> server # [ 23.828103] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-timescaledb> server # [ 23.902473] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-timescaledb> server # [ 23.920686] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-timescaledb> server # [ 24.764127] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-timescaledb> server # [ 24.776310] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-timescaledb> server # [ 24.826849] systemd[1]: Mounting /run/wrappers... vm-test-run-timescaledb> server # [ 24.878108] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-timescaledb> server # [ 24.908869] systemd[1]: Started Journal Service. vm-test-run-timescaledb> server # [ 24.762990] systemd-modules-load[396]: Module 'atkbd' is built in vm-test-run-timescaledb> server # [ 24.770910] systemd-modules-load[396]: Module 'loop' is built in vm-test-run-timescaledb> server # [ 24.783285] systemd-oomd[397]: No swap; memory pressure usage will be degraded vm-test-run-timescaledb> server # [ 24.831439] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-timescaledb> server # [ 25.248907] systemd[1]: Mounted /run/wrappers. vm-test-run-timescaledb> server # [ 25.283411] systemd[1]: Reached target Local File Systems. vm-test-run-timescaledb> server # [ 25.299819] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-timescaledb> server # [ 25.346588] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-timescaledb> server # [ 25.354007] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-timescaledb> server # [ 25.384974] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-timescaledb> server # [ 25.827139] systemd-journald[395]: Received client request to flush runtime journal. vm-test-run-timescaledb> server # [ 26.217789] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-timescaledb> server # [ 26.263045] systemd[1]: Starting Create System Files and Directories... vm-test-run-timescaledb> server # [ 26.293526] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-timescaledb> server # [ 26.335675] systemd-udevd[425]: Using default interface naming scheme 'v258'. vm-test-run-timescaledb> server # [ 26.365370] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-timescaledb> server # [ 28.137599] systemd[1]: Finished Create System Files and Directories. vm-test-run-timescaledb> server # [ 28.192927] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-timescaledb> server # [ 28.243506] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-timescaledb> server # [ 28.727586] systemd[1]: Started Rule-based Manager for Device Events and Files. 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.295445] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-timescaledb> server # [ 30.101125] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-timescaledb> server # [ 30.126100] systemd[1]: Starting Update is Completed... vm-test-run-timescaledb> server # [ 30.847088] systemd[1]: Finished Update is Completed. vm-test-run-timescaledb> server # [ 33.795044] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 33.809897] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-timescaledb> server # [ 33.824923] systemd[1]: suid-sgid-wrappers.service: Consumed 2.412s CPU time, 5.5M memory peak. vm-test-run-timescaledb> server # [ 36.075133] systemd[1]: Finished Firewall. vm-test-run-timescaledb> server # [ 37.350918] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-timescaledb> server # [ 37.370203] systemd[1]: Reached target System Initialization. vm-test-run-timescaledb> server # [ 37.384844] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-timescaledb> server # [ 37.410147] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-timescaledb> server # [ 37.412721] systemd[1]: Reached target Timer Units. vm-test-run-timescaledb> server # [ 37.416310] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-timescaledb> server # [ 37.424630] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-timescaledb> server # [ 37.428052] systemd[1]: Listening on Hostname Service Socket. vm-test-run-timescaledb> server # [ 37.433896] systemd[1]: Reached target Socket Units. vm-test-run-timescaledb> server # [ 37.439556] systemd[1]: Reached target Basic System. vm-test-run-timescaledb> server # [ 37.442841] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-timescaledb> server # [ 37.472955] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 37.534306] systemd[1]: Started Reset console on configuration changes. vm-test-run-timescaledb> server # [ 37.560752] systemd[1]: Starting resolvconf update... vm-test-run-timescaledb> server # [ 37.633683] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-timescaledb> server # [ 38.696720] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-timescaledb> server # [ 38.835379] nsncd[631]: Oct 06 20:06:23.486 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 38.850503] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 38.858724] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 38.869943] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 38.889710] dbus-daemon[634]: dbus[634]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-timescaledb> server # [ 38.904049] systemd[1]: Starting User Login Management... vm-test-run-timescaledb> server # [ 39.329110] systemd[1]: Started D-Bus System Message Bus. vm-test-run-timescaledb> server # [ 40.145911] systemd-logind[647]: New seat seat0. vm-test-run-timescaledb> server # [ 40.167612] systemd[1]: Started User Login Management. vm-test-run-timescaledb> server # [ 40.208955] systemd[1]: Starting linger-users.service... vm-test-run-timescaledb> server # [ 40.344607] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 40.349692] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-timescaledb> server # [ 40.350757] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 40.367441] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-timescaledb> server # [ 40.382035] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 40.449126] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 40.459180] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 40.601858] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 40.884999] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 40.898589] systemd[1]: Finished linger-users.service. vm-test-run-timescaledb> server # [ 41.267420] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 41.277424] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 41.280537] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 41.289645] nsncd[694]: Oct 06 20:06:25.968 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 41.555554] systemd[1]: Finished resolvconf update. vm-test-run-timescaledb> server # [ 41.565100] systemd[1]: Reached target Preparation for Network. vm-test-run-timescaledb> server # [ 41.617580] systemd[1]: Starting DHCP Client... vm-test-run-timescaledb> server # [ 42.694372] dhcpcd[742]: dhcpcd-10.2.4 starting vm-test-run-timescaledb> server # [ 42.766999] dhcpcd[746]: dev: loaded udev vm-test-run-timescaledb> server # [ 43.240171] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-timescaledb> server # [ 43.741193] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-timescaledb> server # [ 44.003000] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-timescaledb> server # [ 44.015556] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-timescaledb> server # [ 44.048325] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-timescaledb> server # [ 44.053837] cfg80211: failed to load regulatory.db vm-test-run-timescaledb> server # [ 44.380275] systemd[1]: Found device /dev/hvc0. vm-test-run-timescaledb> server # [ 44.809194] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-timescaledb> server # [ 44.643775] dhcpcd[746]: eth0: waiting for carrier vm-test-run-timescaledb> server # [ 44.657073] dhcpcd[746]: eth0: carrier acquired vm-test-run-timescaledb> server # [ 44.784012] dhcpcd[746]: DUID 00:01:00:01:32:58:11:45:52:54:00:12:34:56 vm-test-run-timescaledb> server # [ 44.786326] dhcpcd[746]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 44.790451] dhcpcd[746]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-timescaledb> server # [ 44.973372] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-timescaledb> server # [ 45.028352] systemd[1]: Started backdoor.service. vm-test-run-timescaledb> server # connecting to host... vm-test-run-timescaledb> server # [ 45.592112] (udev-worker)[764]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-timescaledb> server # [ 45.597091] (udev-worker)[764]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 45.648786] (udev-worker)[752]: Network interface NamePolicy= disabled on kernel command line. 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 46.63 seconds) vm-test-run-timescaledb> server: (finished: waiting for the VM to finish booting, in 46.63 seconds) vm-test-run-timescaledb> server # [ 46.334862] systemd[1]: Found device Virtio network device. vm-test-run-timescaledb> server # [ 46.373687] systemd[1]: Starting Address configuration of eth1... vm-test-run-timescaledb> server # [ 46.394238] dhcpcd[746]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 47.119644] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-timescaledb> server # [ 47.120101] network-addresses-eth1-start[795]: adding address 192.168.1.1/24... done vm-test-run-timescaledb> server # [ 47.254059] dhcpcd[746]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 47.269157] network-addresses-eth1-start[795]: adding address 2001:db8:1::1/64... done vm-test-run-timescaledb> server # [ 47.302631] dhcpcd[746]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 47.329522] dhcpcd[746]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 47.447456] dhcpcd[746]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 47.465114] dhcpcd[746]: eth0: Router Advertisement from fe80::2 vm-test-run-timescaledb> server # [ 47.465863] dhcpcd[746]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-timescaledb> server # [ 47.481919] dhcpcd[746]: eth0: adding route to fec0::/64 vm-test-run-timescaledb> server # [ 47.490594] dhcpcd[746]: eth0: adding default route via fe80::2 vm-test-run-timescaledb> server # [ 47.558472] systemd[1]: Finished Address configuration of eth1. vm-test-run-timescaledb> server # [ 47.624025] systemd[1]: Starting Networking Setup... vm-test-run-timescaledb> server # [ 49.269694] dhcpcd[849]: /nix/store/hsj50yr7hr62ql9xaynbihkhfhbgprcn-openresolv-3.17.0/sbin/.resolvconf-wrapped: line 1221: kill: (832) - Operation not permitted vm-test-run-timescaledb> server # [ 49.278882] dhcpcd[849]: clearing stale lock pid 832 vm-test-run-timescaledb> server # [ 50.039332] systemd[1]: Finished Networking Setup. vm-test-run-timescaledb> server # [ 50.044784] systemd[1]: Reached target Network. vm-test-run-timescaledb> server # [ 50.091365] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-timescaledb> server # [ 50.144879] systemd[1]: Starting Permit User Sessions... vm-test-run-timescaledb> server # [ 50.585769] systemd[1]: Finished Permit User Sessions. vm-test-run-timescaledb> server # [ 50.645283] systemd[1]: Started Getty on tty1. vm-test-run-timescaledb> server # [ 50.648335] systemd[1]: Reached target Login Prompts. vm-test-run-timescaledb> server # [ 51.283468] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[912]: Initializing database at /var/lib/postgresql/data vm-test-run-timescaledb> server # [ 51.763591] systemd-logind[647]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-timescaledb> server # [ 52.351448] dhcpcd[746]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-timescaledb> server # [ 52.358011] dhcpcd[746]: eth0: adding route to 10.0.2.0/24 vm-test-run-timescaledb> server # [ 52.363883] dhcpcd[746]: eth0: adding default route via 10.0.2.2 vm-test-run-timescaledb> server # [ 52.859687] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: The files belonging to this database system will be owned by user "postgres". vm-test-run-timescaledb> server # [ 52.866869] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: This user must also own the server process. vm-test-run-timescaledb> server # [ 52.967251] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-timescaledb> server # [ 52.982190] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: The default database encoding has accordingly been set to "UTF8". vm-test-run-timescaledb> server # [ 52.983088] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: The default text search configuration will be set to "english". vm-test-run-timescaledb> server # [ 52.983817] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: Data page checksums are enabled. vm-test-run-timescaledb> server # [ 52.995738] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-timescaledb> server # [ 53.009688] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: creating subdirectories ... ok vm-test-run-timescaledb> server # [ 53.029478] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: selecting dynamic shared memory implementation ... posix vm-test-run-timescaledb> server # [ 54.650293] systemd[1]: Started DHCP Client. vm-test-run-timescaledb> server # [ 54.688206] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: selecting default max_connections ... 100 vm-test-run-timescaledb> server # [ 55.395301] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: selecting default shared_buffers ... 128MB vm-test-run-timescaledb> server # [ 61.612672] mousedev: PS/2 mouse device common for all mice vm-test-run-timescaledb> server # [ 64.060743] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: selecting default time zone ... UTC vm-test-run-timescaledb> server # [ 64.089598] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: creating configuration files ... ok vm-test-run-timescaledb> server # [ 64.148157] systemd-logind[647]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-timescaledb> server # [ 67.826706] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: running bootstrap script ... ok vm-test-run-timescaledb> server # [ 78.014873] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: performing post-bootstrap initialization ... ok vm-test-run-timescaledb> server # [ 80.367753] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: syncing data to disk ... ok vm-test-run-timescaledb> server # [ 80.370183] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-timescaledb> server # [ 80.371895] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: 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 # [ 80.375554] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: Success. You can now start the database server using: vm-test-run-timescaledb> server # [ 80.378588] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[920]: /nix/store/94klgdz2cgaxgz57rzi4ziz1hz4kwq0y-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-timescaledb> server # [ 81.919936] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[912]: Validating PostgreSQL configuration... vm-test-run-timescaledb> server # [ 82.318677] bvj88v0viij0pfmfb5y6hydk768rjvjy-postgresql-init[1292]: 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 # [ 83.131219] postgres[1303]: 2026-10-06 20:07:07.814 UTC [1303] LOG: pgaudit extension initialized vm-test-run-timescaledb> server # [ 83.815044] postgres[1303]: 2026-10-06 20:07:08.501 UTC [1303] LOG: pgsodium primary server secret key loaded vm-test-run-timescaledb> server # [ 84.249850] postgres[1303]: 2026-10-06 20:07:08.926 UTC [1303] LOG: vault primary server secret key loaded vm-test-run-timescaledb> server # [ 84.672892] postgres[1303]: 2026-10-06 20:07:09.358 UTC [1303] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-timescaledb> server # [ 84.697060] postgres[1303]: 2026-10-06 20:07:09.381 UTC [1303] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-timescaledb> server # [ 84.698561] postgres[1303]: 2026-10-06 20:07:09.382 UTC [1303] LOG: listening on IPv6 address "::", port 5432 vm-test-run-timescaledb> server # [ 84.718511] postgres[1303]: 2026-10-06 20:07:09.405 UTC [1303] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-timescaledb> server # [ 84.887264] postgres[1333]: 2026-10-06 20:07:09.569 UTC [1333] LOG: database system was shut down at 2026-10-06 20:07:02 UTC vm-test-run-timescaledb> server # [ 85.255613] postgres[1303]: 2026-10-06 20:07:09.936 UTC [1303] LOG: database system is ready to accept connections vm-test-run-timescaledb> server # [ 85.316824] systemd[1]: Started PostgreSQL Database Server. vm-test-run-timescaledb> server # [ 85.342357] postgres[1344]: 2026-10-06 20:07:10.000 UTC [1344] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-timescaledb> server # [ 85.377766] systemd[1]: Starting Supabase Database Initialization... vm-test-run-timescaledb> server # [ 85.400133] postgres[1345]: 2026-10-06 20:07:10.071 UTC [1345] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 85.580576] postgres[1303]: 2026-10-06 20:07:10.265 UTC [1303] LOG: background worker "pg_net 0.20.4 worker" (PID 1345) exited with exit code 1 vm-test-run-timescaledb> server # [ 85.753939] postgres[1346]: 2026-10-06 20:07:10.437 UTC [1346] LOG: pg_cron scheduler started vm-test-run-timescaledb> server # [ 85.786648] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Waiting for PostgreSQL to be ready... vm-test-run-timescaledb> server # [ 86.179978] postgres[1352]: ::1 2026-10-06 20:07:10.857 UTC [1352] root@root FATAL: role "root" does not exist vm-test-run-timescaledb> server # [ 86.223244] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: PostgreSQL is ready vm-test-run-timescaledb> server # [ 86.229240] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Creating postgres role... vm-test-run-timescaledb> server # [ 86.493768] postgres[1354]: ::1 2026-10-06 20:07:11.175 UTC [1354] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-timescaledb> server # [ 86.526899] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1353]: CREATE ROLE vm-test-run-timescaledb> server # [ 86.869232] postgres[1357]: ::1 2026-10-06 20:07:11.545 UTC [1357] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-timescaledb> server # [ 86.938708] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1355]: ALTER DATABASE vm-test-run-timescaledb> server # [ 87.010972] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-timescaledb> server # [ 87.331681] postgres[1367]: ::1 2026-10-06 20:07:11.998 UTC [1367] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-timescaledb> server # [ 87.353606] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: CREATE PUBLICATION vm-test-run-timescaledb> server # [ 87.355347] postgres[1367]: ::1 2026-10-06 20:07:12.036 UTC [1367] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-timescaledb> server # [ 87.368290] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: ALTER ROLE vm-test-run-timescaledb> server # [ 87.372464] postgres[1367]: ::1 2026-10-06 20:07:12.053 UTC [1367] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-timescaledb> server # [ 87.381874] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: CREATE ROLE vm-test-run-timescaledb> server # [ 87.382893] postgres[1367]: ::1 2026-10-06 20:07:12.066 UTC [1367] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-timescaledb> server # [ 87.394532] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: CREATE ROLE vm-test-run-timescaledb> server # [ 87.396355] postgres[1367]: ::1 2026-10-06 20:07:12.075 UTC [1367] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-timescaledb> server # [ 87.421254] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: GRANT ROLE vm-test-run-timescaledb> server # [ 87.432111] postgres[1367]: ::1 2026-10-06 20:07:12.102 UTC [1367] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-timescaledb> server # [ 87.439509] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: GRANT vm-test-run-timescaledb> server # [ 87.441327] postgres[1367]: ::1 2026-10-06 20:07:12.122 UTC [1367] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-timescaledb> server # [ 87.448090] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: CREATE ROLE vm-test-run-timescaledb> server # [ 87.455934] postgres[1367]: ::1 2026-10-06 20:07:12.135 UTC [1367] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-timescaledb> server # [ 87.462177] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: GRANT ROLE vm-test-run-timescaledb> server # [ 87.462990] postgres[1367]: ::1 2026-10-06 20:07:12.149 UTC [1367] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-timescaledb> server # [ 87.473464] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 87.474875] postgres[1367]: ::1 2026-10-06 20:07:12.161 UTC [1367] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-timescaledb> server # [ 89.495239] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 89.501328] postgres[1367]: ::1 2026-10-06 20:07:14.176 UTC [1367] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-timescaledb> server # [ 90.135692] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 90.140986] postgres[1367]: ::1 2026-10-06 20:07:14.827 UTC [1367] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-timescaledb> server # [ 90.147905] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: CREATE ROLE vm-test-run-timescaledb> server # [ 90.151953] postgres[1367]: ::1 2026-10-06 20:07:14.836 UTC [1367] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-timescaledb> server # [ 90.158366] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: CREATE ROLE vm-test-run-timescaledb> server # [ 90.161711] postgres[1367]: ::1 2026-10-06 20:07:14.846 UTC [1367] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-timescaledb> server # [ 90.170652] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: CREATE ROLE vm-test-run-timescaledb> server # [ 90.175036] postgres[1367]: ::1 2026-10-06 20:07:14.858 UTC [1367] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-timescaledb> server # [ 90.182636] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: CREATE ROLE vm-test-run-timescaledb> server # [ 90.187584] postgres[1367]: ::1 2026-10-06 20:07:14.871 UTC [1367] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-timescaledb> server # [ 90.197105] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: GRANT ROLE vm-test-run-timescaledb> server # [ 90.197931] postgres[1367]: ::1 2026-10-06 20:07:14.882 UTC [1367] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-timescaledb> server # [ 90.208655] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: GRANT ROLE vm-test-run-timescaledb> server # [ 90.210689] postgres[1367]: ::1 2026-10-06 20:07:14.893 UTC [1367] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-timescaledb> server # [ 90.225491] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: GRANT ROLE vm-test-run-timescaledb> server # [ 90.237145] postgres[1367]: ::1 2026-10-06 20:07:14.908 UTC [1367] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-timescaledb> server # [ 90.238152] postgres[1367]: ::1 2026-10-06 20:07:14.920 UTC [1367] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 90.244605] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: GRANT ROLE vm-test-run-timescaledb> server # [ 90.249969] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: GRANT vm-test-run-timescaledb> server # [ 90.251214] postgres[1367]: ::1 2026-10-06 20:07:14.937 UTC [1367] 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 # [ 90.284567] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 90.285528] postgres[1367]: ::1 2026-10-06 20:07:14.971 UTC [1367] 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 # [ 90.295979] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 90.301977] postgres[1367]: ::1 2026-10-06 20:07:14.982 UTC [1367] 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 # [ 90.313792] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 90.314879] postgres[1367]: ::1 2026-10-06 20:07:15.001 UTC [1367] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 90.322183] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: GRANT vm-test-run-timescaledb> server # [ 90.323016] postgres[1367]: ::1 2026-10-06 20:07:15.008 UTC [1367] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-timescaledb> server # [ 90.340869] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: ALTER ROLE vm-test-run-timescaledb> server # [ 90.341760] postgres[1367]: ::1 2026-10-06 20:07:15.027 UTC [1367] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 90.343913] postgres[1367]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 90.352033] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 90.357510] postgres[1367]: ::1 2026-10-06 20:07:15.039 UTC [1367] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 90.366434] postgres[1367]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 90.367798] postgres[1367]: ::1 2026-10-06 20:07:15.049 UTC [1367] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 90.375639] postgres[1367]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 90.378805] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 90.379516] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 90.379947] postgres[1367]: ::1 2026-10-06 20:07:15.066 UTC [1367] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-timescaledb> server # [ 90.393677] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: ALTER ROLE vm-test-run-timescaledb> server # [ 90.399474] postgres[1367]: ::1 2026-10-06 20:07:15.076 UTC [1367] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 90.403953] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1362]: ALTER ROLE vm-test-run-timescaledb> server # [ 90.459447] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-timescaledb> server # [ 90.862639] postgres[1400]: ::1 2026-10-06 20:07:15.538 UTC [1400] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 90.889162] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 90.900924] postgres[1400]: ::1 2026-10-06 20:07:15.564 UTC [1400] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-timescaledb> server # [ 90.902035] postgres[1400]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 90.902559] postgres[1400]: id uuid NOT NULL UNIQUE, vm-test-run-timescaledb> server # [ 90.903991] postgres[1400]: aud varchar(255) NULL, vm-test-run-timescaledb> server # [ 90.913366] postgres[1400]: "role" varchar(255) NULL, vm-test-run-timescaledb> server # [ 90.913988] postgres[1400]: email varchar(255) NULL UNIQUE, vm-test-run-timescaledb> server # [ 90.914489] postgres[1400]: encrypted_password varchar(255) NULL, vm-test-run-timescaledb> server # [ 90.914998] postgres[1400]: confirmed_at timestamptz NULL, vm-test-run-timescaledb> server # [ 90.916197] postgres[1400]: invited_at timestamptz NULL, vm-test-run-timescaledb> server # [ 90.921821] postgres[1400]: confirmation_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 90.922364] postgres[1400]: confirmation_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 90.923281] postgres[1400]: recovery_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 90.932866] postgres[1400]: recovery_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 90.933587] postgres[1400]: email_change_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 90.933918] postgres[1400]: email_change varchar(255) NULL, vm-test-run-timescaledb> server # [ 90.934344] postgres[1400]: email_change_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 90.934931] postgres[1400]: last_sign_in_at timestamptz NULL, vm-test-run-timescaledb> server # [ 90.935399] postgres[1400]: raw_app_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 90.935768] postgres[1400]: raw_user_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 90.936037] postgres[1400]: is_super_admin bool NULL, vm-test-run-timescaledb> server # [ 90.941379] postgres[1400]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 90.941951] postgres[1400]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 90.942401] postgres[1400]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 90.943316] postgres[1400]: ); vm-test-run-timescaledb> server # [ 91.087609] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE TABLE vm-test-run-timescaledb> server # [ 91.097389] postgres[1400]: ::1 2026-10-06 20:07:15.784 UTC [1400] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-timescaledb> server # [ 91.166138] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE INDEX vm-test-run-timescaledb> server # [ 91.167567] postgres[1400]: ::1 2026-10-06 20:07:15.849 UTC [1400] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-timescaledb> server # [ 91.221704] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE INDEX vm-test-run-timescaledb> server # [ 91.222810] postgres[1400]: ::1 2026-10-06 20:07:15.907 UTC [1400] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-timescaledb> server # [ 91.244170] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: COMMENT vm-test-run-timescaledb> server # [ 91.249608] postgres[1400]: ::1 2026-10-06 20:07:15.928 UTC [1400] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-timescaledb> server # [ 91.258281] postgres[1400]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 91.259652] postgres[1400]: id bigserial NOT NULL, vm-test-run-timescaledb> server # [ 91.260220] postgres[1400]: "token" varchar(255) NULL, vm-test-run-timescaledb> server # [ 91.270601] postgres[1400]: user_id varchar(255) NULL, vm-test-run-timescaledb> server # [ 91.272027] postgres[1400]: revoked bool NULL, vm-test-run-timescaledb> server # [ 91.280895] postgres[1400]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 91.281954] postgres[1400]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 91.283040] postgres[1400]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 91.283950] postgres[1400]: ); vm-test-run-timescaledb> server # [ 91.377651] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE TABLE vm-test-run-timescaledb> server # [ 91.378655] postgres[1400]: ::1 2026-10-06 20:07:16.062 UTC [1400] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-timescaledb> server # [ 91.404816] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE INDEX vm-test-run-timescaledb> server # [ 91.413254] postgres[1400]: ::1 2026-10-06 20:07:16.096 UTC [1400] 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 # [ 91.434830] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE INDEX vm-test-run-timescaledb> server # [ 91.440949] postgres[1400]: ::1 2026-10-06 20:07:16.123 UTC [1400] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-timescaledb> server # [ 91.459815] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE INDEX vm-test-run-timescaledb> server # [ 91.464709] postgres[1400]: ::1 2026-10-06 20:07:16.149 UTC [1400] 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 # [ 91.473299] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: COMMENT vm-test-run-timescaledb> server # [ 91.481873] postgres[1400]: ::1 2026-10-06 20:07:16.163 UTC [1400] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-timescaledb> server # [ 91.482820] postgres[1400]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 91.483405] postgres[1400]: uuid uuid NULL, vm-test-run-timescaledb> server # [ 91.483680] postgres[1400]: raw_base_config text NULL, vm-test-run-timescaledb> server # [ 91.485340] postgres[1400]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 91.485703] postgres[1400]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 91.486366] postgres[1400]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 91.487042] postgres[1400]: ); vm-test-run-timescaledb> server # [ 91.541498] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE TABLE vm-test-run-timescaledb> server # [ 91.543718] postgres[1400]: ::1 2026-10-06 20:07:16.230 UTC [1400] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-timescaledb> server # [ 91.550464] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: COMMENT vm-test-run-timescaledb> server # [ 91.554587] postgres[1400]: ::1 2026-10-06 20:07:16.241 UTC [1400] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-timescaledb> server # [ 91.555455] postgres[1400]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 91.555783] postgres[1400]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 91.558497] postgres[1400]: payload json NULL, vm-test-run-timescaledb> server # [ 91.558895] postgres[1400]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 91.559289] postgres[1400]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 91.559653] postgres[1400]: ); vm-test-run-timescaledb> server # [ 91.600744] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE TABLE vm-test-run-timescaledb> server # [ 91.602382] postgres[1400]: ::1 2026-10-06 20:07:16.288 UTC [1400] 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 # [ 91.627832] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE INDEX vm-test-run-timescaledb> server # [ 91.629379] postgres[1400]: ::1 2026-10-06 20:07:16.315 UTC [1400] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-timescaledb> server # [ 91.637167] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: COMMENT vm-test-run-timescaledb> server # [ 91.639701] postgres[1400]: ::1 2026-10-06 20:07:16.326 UTC [1400] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-timescaledb> server # [ 91.640655] postgres[1400]: "version" varchar(255) NOT NULL, vm-test-run-timescaledb> server # [ 91.641736] postgres[1400]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-timescaledb> server # [ 91.642543] postgres[1400]: ); vm-test-run-timescaledb> server # [ 91.666968] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE TABLE vm-test-run-timescaledb> server # [ 91.667853] postgres[1400]: ::1 2026-10-06 20:07:16.354 UTC [1400] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-timescaledb> server # [ 91.680666] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: COMMENT vm-test-run-timescaledb> server # [ 91.691345] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: INSERT 0 7 vm-test-run-timescaledb> server # [ 91.701482] postgres[1400]: ::1 2026-10-06 20:07:16.383 UTC [1400] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-timescaledb> server # [ 91.702558] postgres[1400]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-timescaledb> server # [ 91.703290] postgres[1400]: $$ language sql stable; vm-test-run-timescaledb> server # [ 91.709943] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 91.712842] postgres[1400]: ::1 2026-10-06 20:07:16.399 UTC [1400] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-timescaledb> server # [ 91.713538] postgres[1400]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-timescaledb> server # [ 91.714266] postgres[1400]: $$ language sql stable; vm-test-run-timescaledb> server # [ 91.723313] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 91.729162] postgres[1400]: ::1 2026-10-06 20:07:16.412 UTC [1400] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-timescaledb> server # [ 91.729904] postgres[1400]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-timescaledb> server # [ 91.730814] postgres[1400]: $$ language sql stable; vm-test-run-timescaledb> server # [ 91.737754] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 91.739019] postgres[1400]: ::1 2026-10-06 20:07:16.421 UTC [1400] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 91.742288] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: GRANT vm-test-run-timescaledb> server # [ 91.745702] postgres[1400]: ::1 2026-10-06 20:07:16.432 UTC [1400] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 91.754018] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: CREATE ROLE vm-test-run-timescaledb> server # [ 91.755525] postgres[1400]: ::1 2026-10-06 20:07:16.440 UTC [1400] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 91.765390] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: GRANT vm-test-run-timescaledb> server # [ 91.766530] postgres[1400]: ::1 2026-10-06 20:07:16.453 UTC [1400] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 91.782801] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: GRANT vm-test-run-timescaledb> server # [ 91.783643] postgres[1400]: ::1 2026-10-06 20:07:16.470 UTC [1400] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 91.790846] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: GRANT vm-test-run-timescaledb> server # [ 91.791816] postgres[1400]: ::1 2026-10-06 20:07:16.478 UTC [1400] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-timescaledb> server # [ 91.799013] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: ALTER ROLE vm-test-run-timescaledb> server # [ 91.800003] postgres[1400]: ::1 2026-10-06 20:07:16.486 UTC [1400] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 91.814620] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: ALTER TABLE vm-test-run-timescaledb> server # [ 91.815642] postgres[1400]: ::1 2026-10-06 20:07:16.502 UTC [1400] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 91.825275] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: ALTER TABLE vm-test-run-timescaledb> server # [ 91.826587] postgres[1400]: ::1 2026-10-06 20:07:16.512 UTC [1400] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 91.843677] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: ALTER TABLE vm-test-run-timescaledb> server # [ 91.844569] postgres[1400]: ::1 2026-10-06 20:07:16.531 UTC [1400] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 91.854492] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: ALTER TABLE vm-test-run-timescaledb> server # [ 91.862865] postgres[1400]: ::1 2026-10-06 20:07:16.541 UTC [1400] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 91.871759] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1395]: ALTER TABLE vm-test-run-timescaledb> server # [ 91.899808] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-timescaledb> server # [ 92.143019] postgres[1415]: ::1 2026-10-06 20:07:16.817 UTC [1415] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 92.157324] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1414]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 92.158725] postgres[1415]: ::1 2026-10-06 20:07:16.839 UTC [1415] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 92.165692] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1414]: CREATE ROLE vm-test-run-timescaledb> server # [ 92.166779] postgres[1415]: ::1 2026-10-06 20:07:16.852 UTC [1415] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-timescaledb> server # [ 92.177794] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1414]: ALTER ROLE vm-test-run-timescaledb> server # [ 92.187060] postgres[1415]: ::1 2026-10-06 20:07:16.869 UTC [1415] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-timescaledb> server # [ 92.202065] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1414]: GRANT vm-test-run-timescaledb> server # [ 92.262882] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1414]: DO vm-test-run-timescaledb> server # [ 92.302094] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-timescaledb> server # [ 92.612337] postgres[1421]: ::1 2026-10-06 20:07:17.294 UTC [1421] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-timescaledb> server # [ 92.637293] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: ALTER ROLE vm-test-run-timescaledb> server # [ 92.638869] postgres[1421]: ::1 2026-10-06 20:07:17.312 UTC [1421] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-timescaledb> server # [ 92.650325] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: ALTER ROLE vm-test-run-timescaledb> server # [ 92.657007] postgres[1421]: ::1 2026-10-06 20:07:17.329 UTC [1421] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-timescaledb> server # [ 92.657943] postgres[1421]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 92.658414] postgres[1421]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 92.658879] postgres[1421]: AS $$ vm-test-run-timescaledb> server # [ 92.659418] postgres[1421]: DECLARE vm-test-run-timescaledb> server # [ 92.660403] postgres[1421]: schema_is_cron bool; vm-test-run-timescaledb> server # [ 92.663921] postgres[1421]: BEGIN vm-test-run-timescaledb> server # [ 92.667461] postgres[1421]: schema_is_cron = ( vm-test-run-timescaledb> server # [ 92.669190] postgres[1421]: SELECT n.nspname = 'cron' vm-test-run-timescaledb> server # [ 92.669703] postgres[1421]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 92.670247] postgres[1421]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-timescaledb> server # [ 92.670717] postgres[1421]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 92.671391] postgres[1421]: ); vm-test-run-timescaledb> server # [ 92.671825] postgres[1421]: vm-test-run-timescaledb> server # [ 92.672915] postgres[1421]: IF schema_is_cron vm-test-run-timescaledb> server # [ 92.673328] postgres[1421]: THEN vm-test-run-timescaledb> server # [ 92.673706] postgres[1421]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 92.674014] postgres[1421]: vm-test-run-timescaledb> server # [ 92.674256] postgres[1421]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 92.674560] postgres[1421]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 92.674825] postgres[1421]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 92.675092] postgres[1421]: vm-test-run-timescaledb> server # [ 92.675809] postgres[1421]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 92.676740] postgres[1421]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 92.677361] postgres[1421]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 92.677858] postgres[1421]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 92.678433] postgres[1421]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 92.678948] postgres[1421]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 92.679751] postgres[1421]: vm-test-run-timescaledb> server # [ 92.680021] postgres[1421]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 92.680990] postgres[1421]: vm-test-run-timescaledb> server # [ 92.681596] postgres[1421]: END IF; vm-test-run-timescaledb> server # [ 92.681968] postgres[1421]: vm-test-run-timescaledb> server # [ 92.682342] postgres[1421]: END; vm-test-run-timescaledb> server # [ 92.684209] postgres[1421]: $$; vm-test-run-timescaledb> server # [ 92.685239] postgres[1421]: ::1 2026-10-06 20:07:17.360 UTC [1421] 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 # [ 92.685728] postgres[1421]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 92.686326] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 92.696915] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 92.698556] postgres[1421]: ::1 2026-10-06 20:07:17.381 UTC [1421] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-timescaledb> server # [ 92.705397] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: COMMENT vm-test-run-timescaledb> server # [ 92.713380] postgres[1421]: ::1 2026-10-06 20:07:17.398 UTC [1421] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-timescaledb> server # [ 92.714918] postgres[1421]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 92.723514] postgres[1421]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 92.735430] postgres[1421]: AS $$ vm-test-run-timescaledb> server # [ 92.739810] postgres[1421]: BEGIN vm-test-run-timescaledb> server # [ 92.741301] postgres[1421]: IF EXISTS ( vm-test-run-timescaledb> server # [ 92.741824] postgres[1421]: SELECT 1 vm-test-run-timescaledb> server # [ 92.742104] postgres[1421]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 92.742976] postgres[1421]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 92.743556] postgres[1421]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 92.744981] postgres[1421]: WHERE ext.extname = 'pg_net' vm-test-run-timescaledb> server # [ 92.746483] postgres[1421]: ) vm-test-run-timescaledb> server # [ 92.746823] postgres[1421]: THEN vm-test-run-timescaledb> server # [ 92.747656] postgres[1421]: IF NOT EXISTS ( vm-test-run-timescaledb> server # [ 92.754297] postgres[1421]: SELECT 1 vm-test-run-timescaledb> server # [ 92.755447] postgres[1421]: FROM pg_roles vm-test-run-timescaledb> server # [ 92.758327] postgres[1421]: WHERE rolname = 'supabase_functions_admin' vm-test-run-timescaledb> server # [ 92.759999] postgres[1421]: ) vm-test-run-timescaledb> server # [ 92.765146] postgres[1421]: THEN vm-test-run-timescaledb> server # [ 92.766752] postgres[1421]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 92.768556] postgres[1421]: END IF; vm-test-run-timescaledb> server # [ 92.768987] postgres[1421]: vm-test-run-timescaledb> server # [ 92.769283] postgres[1421]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 92.769941] postgres[1421]: vm-test-run-timescaledb> server # [ 92.771529] postgres[1421]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 92.773671] postgres[1421]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 92.774680] postgres[1421]: vm-test-run-timescaledb> server # [ 92.774996] postgres[1421]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-timescaledb> server # [ 92.775629] postgres[1421]: 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 # [ 92.777249] postgres[1421]: vm-test-run-timescaledb> server # [ 92.779029] postgres[1421]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-timescaledb> server # [ 92.781008] postgres[1421]: 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 # [ 92.782434] postgres[1421]: vm-test-run-timescaledb> server # [ 92.783580] postgres[1421]: 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 # [ 92.784014] postgres[1421]: 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 # [ 92.785886] postgres[1421]: END IF; vm-test-run-timescaledb> server # [ 92.788256] postgres[1421]: END; vm-test-run-timescaledb> server # [ 92.789616] postgres[1421]: $$; vm-test-run-timescaledb> server # [ 92.790165] postgres[1421]: ::1 2026-10-06 20:07:17.428 UTC [1421] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-timescaledb> server # [ 92.794797] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 92.795788] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: COMMENT vm-test-run-timescaledb> server # [ 92.811567] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: DO vm-test-run-timescaledb> server # [ 92.815427] postgres[1421]: ::1 2026-10-06 20:07:17.500 UTC [1421] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-timescaledb> server # [ 92.823243] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: CREATE ROLE vm-test-run-timescaledb> server # [ 92.826276] postgres[1421]: ::1 2026-10-06 20:07:17.512 UTC [1421] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-timescaledb> server # [ 92.834602] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: GRANT vm-test-run-timescaledb> server # [ 92.839421] postgres[1421]: ::1 2026-10-06 20:07:17.523 UTC [1421] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 92.851503] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: GRANT vm-test-run-timescaledb> server # [ 92.853624] postgres[1421]: ::1 2026-10-06 20:07:17.534 UTC [1421] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 92.859685] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: GRANT vm-test-run-timescaledb> server # [ 92.866411] postgres[1421]: ::1 2026-10-06 20:07:17.548 UTC [1421] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 92.870837] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: GRANT vm-test-run-timescaledb> server # [ 92.876508] postgres[1421]: ::1 2026-10-06 20:07:17.560 UTC [1421] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 92.878960] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: GRANT vm-test-run-timescaledb> server # [ 92.884278] postgres[1421]: ::1 2026-10-06 20:07:17.568 UTC [1421] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 92.889865] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: GRANT vm-test-run-timescaledb> server # [ 92.890843] postgres[1421]: ::1 2026-10-06 20:07:17.577 UTC [1421] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 92.905508] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: GRANT vm-test-run-timescaledb> server # [ 92.908547] postgres[1421]: ::1 2026-10-06 20:07:17.581 UTC [1421] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 92.915778] postgres[1421]: ::1 2026-10-06 20:07:17.601 UTC [1421] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 92.918908] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: GRANT vm-test-run-timescaledb> server # [ 92.951274] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: GRANT vm-test-run-timescaledb> server # [ 92.967645] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1420]: DO vm-test-run-timescaledb> server # [ 93.011659] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running pgbouncer auth schema... vm-test-run-timescaledb> server # [ 93.259600] postgres[1423]: ::1 2026-10-06 20:07:17.941 UTC [1423] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-timescaledb> server # [ 93.271854] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1422]: CREATE ROLE vm-test-run-timescaledb> server # [ 93.275035] postgres[1423]: ::1 2026-10-06 20:07:17.956 UTC [1423] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-timescaledb> server # [ 93.280964] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1422]: REVOKE vm-test-run-timescaledb> server # [ 93.282986] postgres[1423]: ::1 2026-10-06 20:07:17.969 UTC [1423] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-timescaledb> server # [ 93.342427] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1422]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 93.354879] postgres[1423]: ::1 2026-10-06 20:07:18.036 UTC [1423] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-timescaledb> server # [ 93.362625] postgres[1423]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-timescaledb> server # [ 93.363959] postgres[1423]: $$ vm-test-run-timescaledb> server # [ 93.379443] postgres[1423]: BEGIN vm-test-run-timescaledb> server # [ 93.383840] postgres[1423]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-timescaledb> server # [ 93.391580] postgres[1423]: vm-test-run-timescaledb> server # [ 93.398089] postgres[1423]: RETURN QUERY vm-test-run-timescaledb> server # [ 93.399909] postgres[1423]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-timescaledb> server # [ 93.401803] postgres[1423]: WHERE usename = p_usename; vm-test-run-timescaledb> server # [ 93.402557] postgres[1423]: END; vm-test-run-timescaledb> server # [ 93.403483] postgres[1423]: $$ LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 93.404998] postgres[1423]: SET search_path = '' vm-test-run-timescaledb> server # [ 93.407842] postgres[1423]: SECURITY DEFINER; vm-test-run-timescaledb> server # [ 93.425632] postgres[1423]: ::1 2026-10-06 20:07:18.079 UTC [1423] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-timescaledb> server # [ 93.438221] postgres[1423]: ::1 2026-10-06 20:07:18.088 UTC [1423] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-timescaledb> server # [ 93.447198] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1422]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 93.456360] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1422]: REVOKE vm-test-run-timescaledb> server # [ 93.465812] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1422]: GRANT vm-test-run-timescaledb> server # [ 93.478875] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running stat extension... vm-test-run-timescaledb> server # [ 93.851081] postgres[1434]: ::1 2026-10-06 20:07:18.510 UTC [1434] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-timescaledb> server # [ 93.882083] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1427]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-timescaledb> server # [ 93.935861] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1427]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 93.944882] postgres[1434]: ::1 2026-10-06 20:07:18.628 UTC [1434] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-timescaledb> server # [ 95.130779] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1427]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 95.180326] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-timescaledb> server # [ 95.398772] postgres[1451]: ::1 2026-10-06 20:07:20.076 UTC [1451] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-timescaledb> server # [ 95.409346] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1450]: GRANT vm-test-run-timescaledb> server # [ 95.411303] postgres[1451]: ::1 2026-10-06 20:07:20.092 UTC [1451] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 95.419431] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1450]: GRANT vm-test-run-timescaledb> server # [ 95.423413] postgres[1451]: ::1 2026-10-06 20:07:20.108 UTC [1451] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 95.428702] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1450]: GRANT vm-test-run-timescaledb> server # [ 95.433117] postgres[1451]: ::1 2026-10-06 20:07:20.119 UTC [1451] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 95.445761] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1450]: GRANT vm-test-run-timescaledb> server # [ 95.454016] postgres[1451]: ::1 2026-10-06 20:07:20.135 UTC [1451] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 95.459932] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1450]: GRANT vm-test-run-timescaledb> server # [ 95.464890] postgres[1451]: ::1 2026-10-06 20:07:20.149 UTC [1451] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 95.473864] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1450]: GRANT vm-test-run-timescaledb> server # [ 95.483293] postgres[1451]: ::1 2026-10-06 20:07:20.159 UTC [1451] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 95.485274] postgres[1451]: ::1 2026-10-06 20:07:20.165 UTC [1451] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 95.486704] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1450]: GRANT vm-test-run-timescaledb> server # [ 95.491476] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1450]: GRANT vm-test-run-timescaledb> server # [ 95.497973] postgres[1451]: ::1 2026-10-06 20:07:20.182 UTC [1451] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 95.528283] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1450]: GRANT vm-test-run-timescaledb> server # [ 95.547800] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1450]: DO vm-test-run-timescaledb> server # [ 95.550715] postgres[1451]: ::1 2026-10-06 20:07:20.233 UTC [1451] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-timescaledb> server # [ 95.559520] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1450]: ALTER ROLE vm-test-run-timescaledb> server # [ 95.601568] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-timescaledb> server # [ 95.818683] postgres[1453]: ::1 2026-10-06 20:07:20.494 UTC [1453] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 95.847991] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: GRANT vm-test-run-timescaledb> server # [ 95.861905] postgres[1453]: ::1 2026-10-06 20:07:20.525 UTC [1453] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 95.872713] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: GRANT vm-test-run-timescaledb> server # [ 95.889257] postgres[1453]: ::1 2026-10-06 20:07:20.568 UTC [1453] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 95.913366] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: GRANT vm-test-run-timescaledb> server # [ 95.914915] postgres[1453]: ::1 2026-10-06 20:07:20.596 UTC [1453] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 95.929362] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: ALTER TABLE vm-test-run-timescaledb> server # [ 95.930547] postgres[1453]: ::1 2026-10-06 20:07:20.616 UTC [1453] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 95.939269] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: ALTER TABLE vm-test-run-timescaledb> server # [ 95.942713] postgres[1453]: ::1 2026-10-06 20:07:20.629 UTC [1453] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 95.952692] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: ALTER TABLE vm-test-run-timescaledb> server # [ 95.953536] postgres[1453]: ::1 2026-10-06 20:07:20.638 UTC [1453] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 95.965859] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: ALTER TABLE vm-test-run-timescaledb> server # [ 95.967027] postgres[1453]: ::1 2026-10-06 20:07:20.650 UTC [1453] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 95.979610] postgres[1453]: ::1 2026-10-06 20:07:20.666 UTC [1453] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 95.984941] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: ALTER TABLE vm-test-run-timescaledb> server # [ 95.990996] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: GRANT vm-test-run-timescaledb> server # [ 95.992129] postgres[1453]: ::1 2026-10-06 20:07:20.677 UTC [1453] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 96.005817] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: GRANT vm-test-run-timescaledb> server # [ 96.007084] postgres[1453]: ::1 2026-10-06 20:07:20.691 UTC [1453] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 96.013575] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: GRANT vm-test-run-timescaledb> server # [ 96.019640] postgres[1453]: ::1 2026-10-06 20:07:20.705 UTC [1453] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 96.042820] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: GRANT vm-test-run-timescaledb> server # [ 96.050384] postgres[1453]: ::1 2026-10-06 20:07:20.736 UTC [1453] 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 # [ 96.066875] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 96.077406] postgres[1453]: ::1 2026-10-06 20:07:20.752 UTC [1453] 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 # [ 96.082362] postgres[1453]: ::1 2026-10-06 20:07:20.762 UTC [1453] 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 # [ 96.084390] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 96.095818] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1452]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 96.138638] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-timescaledb> server # [ 96.571402] postgres[1465]: ::1 2026-10-06 20:07:21.251 UTC [1465] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-timescaledb> server # [ 96.611560] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1458]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 96.686387] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 96.974777] postgres[1475]: ::1 2026-10-06 20:07:21.653 UTC [1475] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-timescaledb> server # [ 96.991055] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1469]: GRANT vm-test-run-timescaledb> server # [ 96.992120] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1469]: GRANT vm-test-run-timescaledb> server # [ 96.997871] postgres[1475]: ::1 2026-10-06 20:07:21.675 UTC [1475] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 96.998972] postgres[1475]: ::1 2026-10-06 20:07:21.680 UTC [1475] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 96.999631] postgres[1475]: ::1 2026-10-06 20:07:21.682 UTC [1475] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 97.011896] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1469]: GRANT vm-test-run-timescaledb> server # [ 97.013196] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1469]: GRANT vm-test-run-timescaledb> server # [ 97.043840] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-timescaledb> server # [ 97.354550] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1479]: DO vm-test-run-timescaledb> server # [ 97.357422] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1479]: DO vm-test-run-timescaledb> server # [ 97.369254] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1479]: DO vm-test-run-timescaledb> server # [ 97.403651] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 97.581043] postgres[1485]: ::1 2026-10-06 20:07:22.263 UTC [1485] 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 # [ 97.599892] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1484]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 97.602163] postgres[1485]: ::1 2026-10-06 20:07:22.281 UTC [1485] 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 # [ 97.603036] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1484]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 97.606880] postgres[1485]: ::1 2026-10-06 20:07:22.290 UTC [1485] 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 # [ 97.612330] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1484]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 97.645174] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-timescaledb> server # [ 97.985163] postgres[1490]: ::1 2026-10-06 20:07:22.649 UTC [1490] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-timescaledb> server # [ 97.992092] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1486]: ALTER ROLE vm-test-run-timescaledb> server # [ 98.027317] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql vm-test-run-timescaledb> server # [ 98.343702] postgres[1493]: ::1 2026-10-06 20:07:23.018 UTC [1493] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 98.354205] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: 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 # [ 98.359591] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 98.366384] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: 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 # [ 98.367976] postgres[1493]: ::1 2026-10-06 20:07:23.040 UTC [1493] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 98.373989] postgres[1493]: ::1 2026-10-06 20:07:23.057 UTC [1493] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 98.375274] postgres[1493]: DECLARE vm-test-run-timescaledb> server # [ 98.375697] postgres[1493]: cmd record; vm-test-run-timescaledb> server # [ 98.380607] postgres[1493]: BEGIN vm-test-run-timescaledb> server # [ 98.383831] postgres[1493]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 98.387593] postgres[1493]: LOOP vm-test-run-timescaledb> server # [ 98.388062] postgres[1493]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 98.393700] postgres[1493]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 98.394908] postgres[1493]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 98.395733] postgres[1493]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 98.397694] postgres[1493]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 98.400123] postgres[1493]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 98.401091] postgres[1493]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 98.401826] postgres[1493]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 98.402123] postgres[1493]: , 'CREATE TYPE' vm-test-run-timescaledb> server # [ 98.403799] postgres[1493]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 98.405016] postgres[1493]: , 'COMMENT' vm-test-run-timescaledb> server # [ 98.405339] postgres[1493]: ) vm-test-run-timescaledb> server # [ 98.405689] postgres[1493]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 98.407410] postgres[1493]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 98.408902] postgres[1493]: THEN vm-test-run-timescaledb> server # [ 98.409816] postgres[1493]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 98.410139] postgres[1493]: END IF; vm-test-run-timescaledb> server # [ 98.410561] postgres[1493]: END LOOP; vm-test-run-timescaledb> server # [ 98.411057] postgres[1493]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 98.412207] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: DROP FUNCTION vm-test-run-timescaledb> server # [ 98.413300] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 98.413699] postgres[1493]: ::1 2026-10-06 20:07:23.090 UTC [1493] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 98.414626] postgres[1493]: DECLARE vm-test-run-timescaledb> server # [ 98.415194] postgres[1493]: obj record; vm-test-run-timescaledb> server # [ 98.415513] postgres[1493]: BEGIN vm-test-run-timescaledb> server # [ 98.415761] postgres[1493]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 98.416480] postgres[1493]: LOOP vm-test-run-timescaledb> server # [ 98.416997] postgres[1493]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 98.417279] postgres[1493]: 'schema' vm-test-run-timescaledb> server # [ 98.417522] postgres[1493]: , 'table' vm-test-run-timescaledb> server # [ 98.417727] postgres[1493]: , 'foreign table' vm-test-run-timescaledb> server # [ 98.417978] postgres[1493]: , 'view' vm-test-run-timescaledb> server # [ 98.418207] postgres[1493]: , 'materialized view' vm-test-run-timescaledb> server # [ 98.418439] postgres[1493]: , 'function' vm-test-run-timescaledb> server # [ 98.418983] postgres[1493]: , 'trigger' vm-test-run-timescaledb> server # [ 98.419378] postgres[1493]: , 'type' vm-test-run-timescaledb> server # [ 98.419664] postgres[1493]: , 'rule' vm-test-run-timescaledb> server # [ 98.420054] postgres[1493]: ) vm-test-run-timescaledb> server # [ 98.421206] postgres[1493]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 98.421970] postgres[1493]: THEN vm-test-run-timescaledb> server # [ 98.422665] postgres[1493]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 98.423245] postgres[1493]: END IF; vm-test-run-timescaledb> server # [ 98.423592] postgres[1493]: END LOOP; vm-test-run-timescaledb> server # [ 98.424020] postgres[1493]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 98.435318] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 98.442559] postgres[1493]: ::1 2026-10-06 20:07:23.126 UTC [1493] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 98.444078] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: 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 # [ 98.447247] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 98.449434] postgres[1493]: ::1 2026-10-06 20:07:23.135 UTC [1493] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 98.451199] postgres[1493]: ON ddl_command_end vm-test-run-timescaledb> server # [ 98.457633] postgres[1493]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 98.475043] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 98.483945] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: 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 # [ 98.489535] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 98.490649] postgres[1493]: ::1 2026-10-06 20:07:23.165 UTC [1493] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 98.500940] postgres[1493]: ::1 2026-10-06 20:07:23.170 UTC [1493] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 98.502016] postgres[1493]: ON sql_drop vm-test-run-timescaledb> server # [ 98.502789] postgres[1493]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 98.503456] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1492]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 98.536927] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql vm-test-run-timescaledb> server # [ 99.255788] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1494]: DO vm-test-run-timescaledb> server # [ 99.296286] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql vm-test-run-timescaledb> server # [ 99.615795] postgres[1500]: ::1 2026-10-06 20:07:24.289 UTC [1500] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public; vm-test-run-timescaledb> server # [ 99.738954] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 99.757248] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: 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 # [ 99.758241] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: DROP FUNCTION vm-test-run-timescaledb> server # [ 99.760145] postgres[1500]: ::1 2026-10-06 20:07:24.408 UTC [1500] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb); vm-test-run-timescaledb> server # [ 99.767013] postgres[1500]: ::1 2026-10-06 20:07:24.421 UTC [1500] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 99.768109] postgres[1500]: "operationName" text default null, vm-test-run-timescaledb> server # [ 99.793401] postgres[1500]: query text default null, vm-test-run-timescaledb> server # [ 99.820854] postgres[1500]: variables jsonb default null, vm-test-run-timescaledb> server # [ 99.822502] postgres[1500]: extensions jsonb default null vm-test-run-timescaledb> server # [ 99.832440] postgres[1500]: ) vm-test-run-timescaledb> server # [ 99.844712] postgres[1500]: returns jsonb vm-test-run-timescaledb> server # [ 99.845415] postgres[1500]: language plpgsql vm-test-run-timescaledb> server # [ 99.846761] postgres[1500]: as $$ vm-test-run-timescaledb> server # [ 99.848306] postgres[1500]: DECLARE vm-test-run-timescaledb> server # [ 99.849997] postgres[1500]: server_version float; vm-test-run-timescaledb> server # [ 99.851249] postgres[1500]: BEGIN vm-test-run-timescaledb> server # [ 99.851618] postgres[1500]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 99.852125] postgres[1500]: vm-test-run-timescaledb> server # [ 99.852372] postgres[1500]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 99.853688] postgres[1500]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 99.854356] postgres[1500]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 99.855248] postgres[1500]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 99.855827] postgres[1500]: ); vm-test-run-timescaledb> server # [ 99.856549] postgres[1500]: ELSE vm-test-run-timescaledb> server # [ 99.858860] postgres[1500]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 99.860163] postgres[1500]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 99.868135] postgres[1500]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 99.870483] postgres[1500]: ); vm-test-run-timescaledb> server # [ 99.871246] postgres[1500]: END IF; vm-test-run-timescaledb> server # [ 99.871547] postgres[1500]: END; vm-test-run-timescaledb> server # [ 99.873131] postgres[1500]: $$; vm-test-run-timescaledb> server # [ 99.875003] postgres[1500]: ::1 2026-10-06 20:07:24.461 UTC [1500] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 99.876333] postgres[1500]: ::1 2026-10-06 20:07:24.525 UTC [1500] 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 # [ 99.882125] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 99.883634] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: GRANT vm-test-run-timescaledb> server # [ 99.884074] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 99.890263] postgres[1500]: ::1 2026-10-06 20:07:24.567 UTC [1500] 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 # [ 99.902251] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 99.908991] postgres[1500]: ::1 2026-10-06 20:07:24.590 UTC [1500] 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 # [ 99.916243] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 99.925479] postgres[1500]: ::1 2026-10-06 20:07:24.606 UTC [1500] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 99.927048] postgres[1500]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 99.941411] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 99.943801] postgres[1500]: ::1 2026-10-06 20:07:24.624 UTC [1500] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 99.960741] postgres[1500]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 99.964457] postgres[1500]: ::1 2026-10-06 20:07:24.644 UTC [1500] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all vm-test-run-timescaledb> server # [ 99.973141] postgres[1500]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 99.974845] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 99.980256] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 99.998646] postgres[1500]: ::1 2026-10-06 20:07:24.679 UTC [1500] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 99.999825] postgres[1500]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 100.000280] postgres[1500]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 100.001515] postgres[1500]: AS $func$ vm-test-run-timescaledb> server # [ 100.002325] postgres[1500]: DECLARE vm-test-run-timescaledb> server # [ 100.002800] postgres[1500]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 100.003534] postgres[1500]: BEGIN vm-test-run-timescaledb> server # [ 100.003880] postgres[1500]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 100.004215] postgres[1500]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 100.005153] postgres[1500]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 100.005907] postgres[1500]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 100.007006] postgres[1500]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 100.008614] postgres[1500]: ); vm-test-run-timescaledb> server # [ 100.009950] postgres[1500]: vm-test-run-timescaledb> server # [ 100.010428] postgres[1500]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 100.010772] postgres[1500]: THEN vm-test-run-timescaledb> server # [ 100.011364] postgres[1500]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 100.011868] postgres[1500]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 100.017735] postgres[1500]: vm-test-run-timescaledb> server # [ 100.018870] postgres[1500]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 100.020098] postgres[1500]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 100.021276] postgres[1500]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 100.021636] postgres[1500]: vm-test-run-timescaledb> server # [ 100.021852] postgres[1500]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 100.024379] postgres[1500]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 100.030125] postgres[1500]: "operationName" text default null, vm-test-run-timescaledb> server # [ 100.030747] postgres[1500]: query text default null, vm-test-run-timescaledb> server # [ 100.031199] postgres[1500]: variables jsonb default null, vm-test-run-timescaledb> server # [ 100.031557] postgres[1500]: extensions jsonb default null vm-test-run-timescaledb> server # [ 100.031902] postgres[1500]: ) vm-test-run-timescaledb> server # [ 100.033100] postgres[1500]: returns jsonb vm-test-run-timescaledb> server # [ 100.033771] postgres[1500]: language sql vm-test-run-timescaledb> server # [ 100.034614] postgres[1500]: as $$ vm-test-run-timescaledb> server # [ 100.035726] postgres[1500]: SELECT graphql.resolve(query, coalesce(variables, '{}')); vm-test-run-timescaledb> server # [ 100.042003] postgres[1500]: $$; vm-test-run-timescaledb> server # [ 100.042898] postgres[1500]: vm-test-run-timescaledb> server # [ 100.043865] postgres[1500]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 100.046650] postgres[1500]: END IF; vm-test-run-timescaledb> server # [ 100.047353] postgres[1500]: vm-test-run-timescaledb> server # [ 100.048066] postgres[1500]: END; vm-test-run-timescaledb> server # [ 100.048896] postgres[1500]: $func$; vm-test-run-timescaledb> server # [ 100.049337] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 100.051099] postgres[1500]: ::1 2026-10-06 20:07:24.737 UTC [1500] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access; vm-test-run-timescaledb> server # [ 100.063097] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: 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 # [ 100.065517] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 100.066151] postgres[1500]: ::1 2026-10-06 20:07:24.750 UTC [1500] 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 # [ 100.067579] postgres[1500]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access(); vm-test-run-timescaledb> server # [ 100.079651] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 100.084951] postgres[1500]: ::1 2026-10-06 20:07:24.768 UTC [1500] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql'; vm-test-run-timescaledb> server # [ 100.103494] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: COMMENT vm-test-run-timescaledb> server # [ 100.109622] postgres[1500]: ::1 2026-10-06 20:07:24.791 UTC [1500] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 100.110519] postgres[1500]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 100.110989] postgres[1500]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 100.111268] postgres[1500]: AS $func$ vm-test-run-timescaledb> server # [ 100.111497] postgres[1500]: DECLARE vm-test-run-timescaledb> server # [ 100.112003] postgres[1500]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 100.112287] postgres[1500]: BEGIN vm-test-run-timescaledb> server # [ 100.116577] postgres[1500]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 100.130623] postgres[1500]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 100.135700] postgres[1500]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 100.139761] postgres[1500]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 100.143642] postgres[1500]: ); vm-test-run-timescaledb> server # [ 100.154134] postgres[1500]: vm-test-run-timescaledb> server # [ 100.154911] postgres[1500]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 100.155715] postgres[1500]: THEN vm-test-run-timescaledb> server # [ 100.156015] postgres[1500]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 100.160974] postgres[1500]: "operationName" text default null, vm-test-run-timescaledb> server # [ 100.161617] postgres[1500]: query text default null, vm-test-run-timescaledb> server # [ 100.162143] postgres[1500]: variables jsonb default null, vm-test-run-timescaledb> server # [ 100.162465] postgres[1500]: extensions jsonb default null vm-test-run-timescaledb> server # [ 100.162731] postgres[1500]: ) vm-test-run-timescaledb> server # [ 100.163262] postgres[1500]: returns jsonb vm-test-run-timescaledb> server # [ 100.163979] postgres[1500]: language plpgsql vm-test-run-timescaledb> server # [ 100.173331] postgres[1500]: as $$ vm-test-run-timescaledb> server # [ 100.173983] postgres[1500]: DECLARE vm-test-run-timescaledb> server # [ 100.174434] postgres[1500]: server_version float; vm-test-run-timescaledb> server # [ 100.175057] postgres[1500]: BEGIN vm-test-run-timescaledb> server # [ 100.183761] postgres[1500]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 100.185769] postgres[1500]: vm-test-run-timescaledb> server # [ 100.186111] postgres[1500]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 100.186632] postgres[1500]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 100.186926] postgres[1500]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 100.187291] postgres[1500]: 'errors', array['pg_graphql extension is not enabled.'] vm-test-run-timescaledb> server # [ 100.187682] postgres[1500]: ); vm-test-run-timescaledb> server # [ 100.188240] postgres[1500]: ELSE vm-test-run-timescaledb> server # [ 100.197917] postgres[1500]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 100.198559] postgres[1500]: 'data', null::jsonb, vm-test-run-timescaledb> server # [ 100.199049] postgres[1500]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.'] vm-test-run-timescaledb> server # [ 100.225429] postgres[1500]: ); vm-test-run-timescaledb> server # [ 100.226615] postgres[1500]: END IF; vm-test-run-timescaledb> server # [ 100.227594] postgres[1500]: END; vm-test-run-timescaledb> server # [ 100.253347] postgres[1500]: $$; vm-test-run-timescaledb> server # [ 100.256230] postgres[1500]: END IF; vm-test-run-timescaledb> server # [ 100.270321] postgres[1500]: vm-test-run-timescaledb> server # [ 100.270959] postgres[1500]: END; vm-test-run-timescaledb> server # [ 100.271334] postgres[1500]: $func$; vm-test-run-timescaledb> server # [ 100.289541] postgres[1500]: ::1 2026-10-06 20:07:24.849 UTC [1500] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder; vm-test-run-timescaledb> server # [ 100.291830] postgres[1500]: ::1 2026-10-06 20:07:24.858 UTC [1500] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION') vm-test-run-timescaledb> server # [ 100.298903] postgres[1500]: EXECUTE PROCEDURE extensions.set_graphql_placeholder(); vm-test-run-timescaledb> server # [ 100.305976] postgres[1500]: ::1 2026-10-06 20:07:24.872 UTC [1500] 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 # [ 100.308261] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 100.316085] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: 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 # [ 100.322007] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 100.323923] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 100.335547] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1496]: COMMENT vm-test-run-timescaledb> server # [ 100.350051] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql vm-test-run-timescaledb> server # [ 100.627500] postgres[1520]: ::1 2026-10-06 20:07:25.301 UTC [1520] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart; vm-test-run-timescaledb> server # [ 100.644318] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1516]: 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 # [ 100.645485] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1516]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 100.654459] postgres[1520]: ::1 2026-10-06 20:07:25.310 UTC [1520] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart(); vm-test-run-timescaledb> server # [ 100.655393] postgres[1520]: ::1 2026-10-06 20:07:25.340 UTC [1520] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 100.656096] postgres[1520]: DECLARE vm-test-run-timescaledb> server # [ 100.657124] postgres[1520]: cmd record; vm-test-run-timescaledb> server # [ 100.657541] postgres[1520]: BEGIN vm-test-run-timescaledb> server # [ 100.657938] postgres[1520]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands() vm-test-run-timescaledb> server # [ 100.658305] postgres[1520]: LOOP vm-test-run-timescaledb> server # [ 100.659227] postgres[1520]: IF cmd.command_tag IN ( vm-test-run-timescaledb> server # [ 100.660114] postgres[1520]: 'CREATE SCHEMA', 'ALTER SCHEMA' vm-test-run-timescaledb> server # [ 100.665331] postgres[1520]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE' vm-test-run-timescaledb> server # [ 100.666207] postgres[1520]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE' vm-test-run-timescaledb> server # [ 100.667098] postgres[1520]: , 'CREATE VIEW', 'ALTER VIEW' vm-test-run-timescaledb> server # [ 100.667969] postgres[1520]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW' vm-test-run-timescaledb> server # [ 100.673349] postgres[1520]: , 'CREATE FUNCTION', 'ALTER FUNCTION' vm-test-run-timescaledb> server # [ 100.674079] postgres[1520]: , 'CREATE TRIGGER' vm-test-run-timescaledb> server # [ 100.674636] postgres[1520]: , 'CREATE TYPE', 'ALTER TYPE' vm-test-run-timescaledb> server # [ 100.674934] postgres[1520]: , 'CREATE RULE' vm-test-run-timescaledb> server # [ 100.680911] postgres[1520]: , 'COMMENT' vm-test-run-timescaledb> server # [ 100.681752] postgres[1520]: ) vm-test-run-timescaledb> server # [ 100.682269] postgres[1520]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp vm-test-run-timescaledb> server # [ 100.682612] postgres[1520]: AND cmd.schema_name is distinct from 'pg_temp' vm-test-run-timescaledb> server # [ 100.684015] postgres[1520]: THEN vm-test-run-timescaledb> server # [ 100.696143] postgres[1520]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 100.697112] postgres[1520]: END IF; vm-test-run-timescaledb> server # [ 100.697723] postgres[1520]: END LOOP; vm-test-run-timescaledb> server # [ 100.698436] postgres[1520]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 100.699825] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1516]: 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 # [ 100.701224] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1516]: DROP FUNCTION vm-test-run-timescaledb> server # [ 100.726283] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1516]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 100.728290] postgres[1520]: ::1 2026-10-06 20:07:25.415 UTC [1520] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$ vm-test-run-timescaledb> server # [ 100.728999] postgres[1520]: DECLARE vm-test-run-timescaledb> server # [ 100.730124] postgres[1520]: obj record; vm-test-run-timescaledb> server # [ 100.730704] postgres[1520]: BEGIN vm-test-run-timescaledb> server # [ 100.731072] postgres[1520]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects() vm-test-run-timescaledb> server # [ 100.731448] postgres[1520]: LOOP vm-test-run-timescaledb> server # [ 100.732140] postgres[1520]: IF obj.object_type IN ( vm-test-run-timescaledb> server # [ 100.737874] postgres[1520]: 'schema' vm-test-run-timescaledb> server # [ 100.738627] postgres[1520]: , 'table' vm-test-run-timescaledb> server # [ 100.739031] postgres[1520]: , 'foreign table' vm-test-run-timescaledb> server # [ 100.739994] postgres[1520]: , 'view' vm-test-run-timescaledb> server # [ 100.742844] postgres[1520]: , 'materialized view' vm-test-run-timescaledb> server # [ 100.743497] postgres[1520]: , 'function' vm-test-run-timescaledb> server # [ 100.743927] postgres[1520]: , 'trigger' vm-test-run-timescaledb> server # [ 100.744238] postgres[1520]: , 'type' vm-test-run-timescaledb> server # [ 100.744542] postgres[1520]: , 'rule' vm-test-run-timescaledb> server # [ 100.749460] postgres[1520]: ) vm-test-run-timescaledb> server # [ 100.749870] postgres[1520]: AND obj.is_temporary IS false -- no pg_temp objects vm-test-run-timescaledb> server # [ 100.750235] postgres[1520]: THEN vm-test-run-timescaledb> server # [ 100.750630] postgres[1520]: NOTIFY pgrst, 'reload schema'; vm-test-run-timescaledb> server # [ 100.750999] postgres[1520]: END IF; vm-test-run-timescaledb> server # [ 100.751761] postgres[1520]: END LOOP; vm-test-run-timescaledb> server # [ 100.752009] postgres[1520]: END; $$ LANGUAGE plpgsql; vm-test-run-timescaledb> server # [ 100.758087] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1516]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 100.758872] postgres[1520]: ::1 2026-10-06 20:07:25.445 UTC [1520] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch; vm-test-run-timescaledb> server # [ 100.771695] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1516]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 100.776136] postgres[1520]: ::1 2026-10-06 20:07:25.459 UTC [1520] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch vm-test-run-timescaledb> server # [ 100.777597] postgres[1520]: ON ddl_command_end vm-test-run-timescaledb> server # [ 100.778404] postgres[1520]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch(); vm-test-run-timescaledb> server # [ 100.778834] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1516]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 100.780937] postgres[1520]: ::1 2026-10-06 20:07:25.466 UTC [1520] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch; vm-test-run-timescaledb> server # [ 100.789207] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1516]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 100.790421] postgres[1520]: ::1 2026-10-06 20:07:25.474 UTC [1520] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch vm-test-run-timescaledb> server # [ 100.791772] postgres[1520]: ON sql_drop vm-test-run-timescaledb> server # [ 100.796992] postgres[1520]: EXECUTE PROCEDURE extensions.pgrst_drop_watch(); vm-test-run-timescaledb> server # [ 100.799085] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1516]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 100.825011] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220322085208_gotrue-session-limit.sql vm-test-run-timescaledb> server # [ 101.023187] postgres[1525]: ::1 2026-10-06 20:07:25.706 UTC [1525] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000; vm-test-run-timescaledb> server # [ 101.042214] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1524]: ALTER ROLE vm-test-run-timescaledb> server # [ 101.070132] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql vm-test-run-timescaledb> server # [ 101.270880] postgres[1527]: ::1 2026-10-06 20:07:25.953 UTC [1527] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 101.271998] postgres[1527]: returns event_trigger vm-test-run-timescaledb> server # [ 101.278195] postgres[1527]: language plpgsql vm-test-run-timescaledb> server # [ 101.278817] postgres[1527]: AS $func$ vm-test-run-timescaledb> server # [ 101.279493] postgres[1527]: DECLARE vm-test-run-timescaledb> server # [ 101.279817] postgres[1527]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 101.284382] postgres[1527]: BEGIN vm-test-run-timescaledb> server # [ 101.286633] postgres[1527]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 101.287407] postgres[1527]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 101.287748] postgres[1527]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 101.288943] postgres[1527]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 101.289388] postgres[1527]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 101.289743] postgres[1527]: ); vm-test-run-timescaledb> server # [ 101.290137] postgres[1527]: vm-test-run-timescaledb> server # [ 101.290852] postgres[1527]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 101.291372] postgres[1527]: THEN vm-test-run-timescaledb> server # [ 101.291803] postgres[1527]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 101.293823] postgres[1527]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 101.294754] postgres[1527]: vm-test-run-timescaledb> server # [ 101.295331] postgres[1527]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 101.296876] postgres[1527]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 101.297739] postgres[1527]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 101.298307] postgres[1527]: vm-test-run-timescaledb> server # [ 101.298582] postgres[1527]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 101.298892] postgres[1527]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 101.299237] postgres[1527]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 101.299546] postgres[1527]: "operationName" text default null, vm-test-run-timescaledb> server # [ 101.300123] postgres[1527]: query text default null, vm-test-run-timescaledb> server # [ 101.300980] postgres[1527]: variables jsonb default null, vm-test-run-timescaledb> server # [ 101.301857] postgres[1527]: extensions jsonb default null vm-test-run-timescaledb> server # [ 101.302175] postgres[1527]: ) vm-test-run-timescaledb> server # [ 101.302421] postgres[1527]: returns jsonb vm-test-run-timescaledb> server # [ 101.303001] postgres[1527]: language sql vm-test-run-timescaledb> server # [ 101.303669] postgres[1527]: as $$ vm-test-run-timescaledb> server # [ 101.304489] postgres[1527]: -- This changed vm-test-run-timescaledb> server # [ 101.306261] postgres[1527]: select graphql.resolve( vm-test-run-timescaledb> server # [ 101.306641] postgres[1527]: query := query, vm-test-run-timescaledb> server # [ 101.307010] postgres[1527]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 101.307942] postgres[1527]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 101.309422] postgres[1527]: extensions := extensions vm-test-run-timescaledb> server # [ 101.310140] postgres[1527]: ); vm-test-run-timescaledb> server # [ 101.310616] postgres[1527]: $$; vm-test-run-timescaledb> server # [ 101.310845] postgres[1527]: vm-test-run-timescaledb> server # [ 101.311061] postgres[1527]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 101.311472] postgres[1527]: END IF; vm-test-run-timescaledb> server # [ 101.311789] postgres[1527]: vm-test-run-timescaledb> server # [ 101.312177] postgres[1527]: END; vm-test-run-timescaledb> server # [ 101.312547] postgres[1527]: $func$; vm-test-run-timescaledb> server # [ 101.344083] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1526]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 101.348326] postgres[1527]: ::1 2026-10-06 20:07:26.030 UTC [1527] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder() vm-test-run-timescaledb> server # [ 101.349841] postgres[1527]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 101.350196] postgres[1527]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 101.351427] postgres[1527]: AS $func$ vm-test-run-timescaledb> server # [ 101.351921] postgres[1527]: DECLARE vm-test-run-timescaledb> server # [ 101.353203] postgres[1527]: graphql_is_dropped bool; vm-test-run-timescaledb> server # [ 101.353590] postgres[1527]: BEGIN vm-test-run-timescaledb> server # [ 101.353834] postgres[1527]: graphql_is_dropped = ( vm-test-run-timescaledb> server # [ 101.354079] postgres[1527]: SELECT ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 101.354655] postgres[1527]: FROM pg_event_trigger_dropped_objects() AS ev vm-test-run-timescaledb> server # [ 101.354912] postgres[1527]: WHERE ev.schema_name = 'graphql_public' vm-test-run-timescaledb> server # [ 101.355435] postgres[1527]: ); vm-test-run-timescaledb> server # [ 101.358775] postgres[1527]: vm-test-run-timescaledb> server # [ 101.361868] postgres[1527]: IF graphql_is_dropped vm-test-run-timescaledb> server # [ 101.362379] postgres[1527]: THEN vm-test-run-timescaledb> server # [ 101.362678] postgres[1527]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 101.363072] postgres[1527]: "operationName" text default null, vm-test-run-timescaledb> server # [ 101.363843] postgres[1527]: query text default null, vm-test-run-timescaledb> server # [ 101.365811] postgres[1527]: variables jsonb default null, vm-test-run-timescaledb> server # [ 101.366492] postgres[1527]: extensions jsonb default null vm-test-run-timescaledb> server # [ 101.369922] postgres[1527]: ) vm-test-run-timescaledb> server # [ 101.370690] postgres[1527]: returns jsonb vm-test-run-timescaledb> server # [ 101.371271] postgres[1527]: language plpgsql vm-test-run-timescaledb> server # [ 101.371550] postgres[1527]: as $$ vm-test-run-timescaledb> server # [ 101.371770] postgres[1527]: DECLARE vm-test-run-timescaledb> server # [ 101.372138] postgres[1527]: server_version float; vm-test-run-timescaledb> server # [ 101.372362] postgres[1527]: BEGIN vm-test-run-timescaledb> server # [ 101.372593] postgres[1527]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 101.383195] postgres[1527]: vm-test-run-timescaledb> server # [ 101.384176] postgres[1527]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 101.385667] postgres[1527]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 101.386652] postgres[1527]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 101.387273] postgres[1527]: jsonb_build_object( vm-test-run-timescaledb> server # [ 101.387669] postgres[1527]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 101.389016] postgres[1527]: ) vm-test-run-timescaledb> server # [ 101.390035] postgres[1527]: ) vm-test-run-timescaledb> server # [ 101.390495] postgres[1527]: ); vm-test-run-timescaledb> server # [ 101.390924] postgres[1527]: ELSE vm-test-run-timescaledb> server # [ 101.391404] postgres[1527]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 101.391699] postgres[1527]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 101.391974] postgres[1527]: jsonb_build_object( vm-test-run-timescaledb> server # [ 101.393362] postgres[1527]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 101.394454] postgres[1527]: ) vm-test-run-timescaledb> server # [ 101.394815] postgres[1527]: ) vm-test-run-timescaledb> server # [ 101.395071] postgres[1527]: ); vm-test-run-timescaledb> server # [ 101.395438] postgres[1527]: END IF; vm-test-run-timescaledb> server # [ 101.395861] postgres[1527]: END; vm-test-run-timescaledb> server # [ 101.396211] postgres[1527]: $$; vm-test-run-timescaledb> server # [ 101.397280] postgres[1527]: END IF; vm-test-run-timescaledb> server # [ 101.397649] postgres[1527]: vm-test-run-timescaledb> server # [ 101.398002] postgres[1527]: END; vm-test-run-timescaledb> server # [ 101.398797] postgres[1527]: $func$; vm-test-run-timescaledb> server # [ 101.399535] postgres[1527]: ::1 2026-10-06 20:07:26.059 UTC [1527] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 101.400123] postgres[1527]: "operationName" text default null, vm-test-run-timescaledb> server # [ 101.401496] postgres[1527]: query text default null, vm-test-run-timescaledb> server # [ 101.402287] postgres[1527]: variables jsonb default null, vm-test-run-timescaledb> server # [ 101.402767] postgres[1527]: extensions jsonb default null vm-test-run-timescaledb> server # [ 101.403446] postgres[1527]: ) vm-test-run-timescaledb> server # [ 101.404231] postgres[1527]: returns jsonb vm-test-run-timescaledb> server # [ 101.405290] postgres[1527]: language plpgsql vm-test-run-timescaledb> server # [ 101.406037] postgres[1527]: as $$ vm-test-run-timescaledb> server # [ 101.406369] postgres[1527]: DECLARE vm-test-run-timescaledb> server # [ 101.406615] postgres[1527]: server_version float; vm-test-run-timescaledb> server # [ 101.406879] postgres[1527]: BEGIN vm-test-run-timescaledb> server # [ 101.407540] postgres[1527]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float); vm-test-run-timescaledb> server # [ 101.408154] postgres[1527]: vm-test-run-timescaledb> server # [ 101.409586] postgres[1527]: IF server_version >= 14 THEN vm-test-run-timescaledb> server # [ 101.416877] postgres[1527]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 101.417805] postgres[1527]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 101.418322] postgres[1527]: jsonb_build_object( vm-test-run-timescaledb> server # [ 101.419069] postgres[1527]: 'message', 'pg_graphql extension is not enabled.' vm-test-run-timescaledb> server # [ 101.419661] postgres[1527]: ) vm-test-run-timescaledb> server # [ 101.420204] postgres[1527]: ) vm-test-run-timescaledb> server # [ 101.425672] postgres[1527]: ); vm-test-run-timescaledb> server # [ 101.428119] postgres[1527]: ELSE vm-test-run-timescaledb> server # [ 101.429032] postgres[1527]: RETURN jsonb_build_object( vm-test-run-timescaledb> server # [ 101.429968] postgres[1527]: 'errors', jsonb_build_array( vm-test-run-timescaledb> server # [ 101.430412] postgres[1527]: jsonb_build_object( vm-test-run-timescaledb> server # [ 101.430911] postgres[1527]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.' vm-test-run-timescaledb> server # [ 101.431523] postgres[1527]: ) vm-test-run-timescaledb> server # [ 101.432152] postgres[1527]: ) vm-test-run-timescaledb> server # [ 101.434220] postgres[1527]: ); vm-test-run-timescaledb> server # [ 101.434745] postgres[1527]: END IF; vm-test-run-timescaledb> server # [ 101.435003] postgres[1527]: END; vm-test-run-timescaledb> server # [ 101.435896] postgres[1527]: $$; vm-test-run-timescaledb> server # [ 101.437339] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1526]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 101.438612] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1526]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 101.439356] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1526]: 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 # [ 101.439880] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1526]: DROP EXTENSION vm-test-run-timescaledb> server # [ 101.441224] postgres[1527]: ::1 2026-10-06 20:07:26.102 UTC [1527] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 103.163462] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1526]: DO vm-test-run-timescaledb> server # [ 103.191212] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: 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 # [ 103.551731] postgres[1556]: ::1 2026-10-06 20:07:28.220 UTC [1556] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres; vm-test-run-timescaledb> server # [ 103.578304] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1549]: GRANT ROLE vm-test-run-timescaledb> server # [ 103.612925] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql vm-test-run-timescaledb> server # [ 103.951067] postgres[1559]: ::1 2026-10-06 20:07:28.620 UTC [1559] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 103.952798] postgres[1559]: returns event_trigger vm-test-run-timescaledb> server # [ 103.953891] postgres[1559]: language plpgsql vm-test-run-timescaledb> server # [ 103.955437] postgres[1559]: AS $func$ vm-test-run-timescaledb> server # [ 103.955998] postgres[1559]: DECLARE vm-test-run-timescaledb> server # [ 103.967704] postgres[1559]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 103.974591] postgres[1559]: BEGIN vm-test-run-timescaledb> server # [ 103.975057] postgres[1559]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 103.975485] postgres[1559]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 103.975902] postgres[1559]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 103.976161] postgres[1559]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 103.980635] postgres[1559]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 103.985621] postgres[1559]: ); vm-test-run-timescaledb> server # [ 103.987328] postgres[1559]: vm-test-run-timescaledb> server # [ 103.987653] postgres[1559]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 103.987924] postgres[1559]: THEN vm-test-run-timescaledb> server # [ 103.993208] postgres[1559]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 103.994158] postgres[1559]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 103.994511] postgres[1559]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 103.995018] postgres[1559]: "operationName" text default null, vm-test-run-timescaledb> server # [ 103.995416] postgres[1559]: query text default null, vm-test-run-timescaledb> server # [ 104.001462] postgres[1559]: variables jsonb default null, vm-test-run-timescaledb> server # [ 104.002122] postgres[1559]: extensions jsonb default null vm-test-run-timescaledb> server # [ 104.002398] postgres[1559]: ) vm-test-run-timescaledb> server # [ 104.003579] postgres[1559]: returns jsonb vm-test-run-timescaledb> server # [ 104.003852] postgres[1559]: language sql vm-test-run-timescaledb> server # [ 104.004085] postgres[1559]: as $$ vm-test-run-timescaledb> server # [ 104.004819] postgres[1559]: select graphql.resolve( vm-test-run-timescaledb> server # [ 104.013334] postgres[1559]: query := query, vm-test-run-timescaledb> server # [ 104.014110] postgres[1559]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 104.014438] postgres[1559]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 104.014879] postgres[1559]: extensions := extensions vm-test-run-timescaledb> server # [ 104.015530] postgres[1559]: ); vm-test-run-timescaledb> server # [ 104.015802] postgres[1559]: $$; vm-test-run-timescaledb> server # [ 104.017094] postgres[1559]: vm-test-run-timescaledb> server # [ 104.018284] postgres[1559]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 104.019070] postgres[1559]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 104.019528] postgres[1559]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 104.019979] postgres[1559]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 104.025509] postgres[1559]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 104.026765] postgres[1559]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 104.027422] postgres[1559]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 104.036432] postgres[1559]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 104.037971] postgres[1559]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 104.038892] postgres[1559]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 104.039378] postgres[1559]: END IF; vm-test-run-timescaledb> server # [ 104.039985] postgres[1559]: vm-test-run-timescaledb> server # [ 104.041857] postgres[1559]: END; vm-test-run-timescaledb> server # [ 104.042465] postgres[1559]: $func$; vm-test-run-timescaledb> server # [ 104.047908] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1558]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 104.049970] postgres[1559]: ::1 2026-10-06 20:07:28.736 UTC [1559] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 104.087680] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1558]: DROP EXTENSION vm-test-run-timescaledb> server # [ 105.571426] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1558]: DO vm-test-run-timescaledb> server # [ 105.665546] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql vm-test-run-timescaledb> server # [ 106.559669] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1575]: DO vm-test-run-timescaledb> server # [ 107.144151] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1575]: DO vm-test-run-timescaledb> server # [ 107.194432] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql vm-test-run-timescaledb> server # [ 107.462988] postgres[1591]: ::1 2026-10-06 20:07:32.140 UTC [1591] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 107.497935] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1590]: ALTER ROLE vm-test-run-timescaledb> server # [ 107.522517] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221103090837_revoke_admin.sql vm-test-run-timescaledb> server # [ 107.735885] postgres[1593]: ::1 2026-10-06 20:07:32.414 UTC [1593] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator; vm-test-run-timescaledb> server # [ 107.750969] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1592]: REVOKE ROLE vm-test-run-timescaledb> server # [ 107.776942] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql vm-test-run-timescaledb> server # [ 109.762427] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 vm-test-run-timescaledb> server # [ 109.724869] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1594]: DO vm-test-run-timescaledb> server # [ 109.759477] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 109.984042] postgres[1621]: ::1 2026-10-06 20:07:34.663 UTC [1621] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres; vm-test-run-timescaledb> server # [ 110.006319] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1620]: GRANT ROLE vm-test-run-timescaledb> server # [ 110.041914] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql vm-test-run-timescaledb> server # [ 110.308319] postgres[1625]: ::1 2026-10-06 20:07:34.991 UTC [1625] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 110.362298] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1622]: GRANT vm-test-run-timescaledb> server # [ 110.363585] postgres[1625]: ::1 2026-10-06 20:07:35.033 UTC [1625] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 110.422254] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1622]: GRANT vm-test-run-timescaledb> server # [ 110.429767] postgres[1625]: ::1 2026-10-06 20:07:35.112 UTC [1625] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option; vm-test-run-timescaledb> server # [ 110.438441] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1622]: GRANT vm-test-run-timescaledb> server # [ 110.439988] postgres[1625]: ::1 2026-10-06 20:07:35.126 UTC [1625] 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 # [ 110.460990] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1622]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 110.465767] postgres[1625]: ::1 2026-10-06 20:07:35.151 UTC [1625] 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 # [ 110.483291] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1622]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 110.491516] postgres[1625]: ::1 2026-10-06 20:07:35.169 UTC [1625] 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 # [ 110.511802] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1622]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 110.551897] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql vm-test-run-timescaledb> server # [ 110.846536] postgres[1631]: ::1 2026-10-06 20:07:35.522 UTC [1631] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres; vm-test-run-timescaledb> server # [ 110.862613] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1629]: GRANT ROLE vm-test-run-timescaledb> server # [ 110.936007] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 111.199910] postgres[1633]: ::1 2026-10-06 20:07:35.880 UTC [1633] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin; vm-test-run-timescaledb> server # [ 111.219688] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1632]: GRANT ROLE vm-test-run-timescaledb> server # [ 111.239787] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql vm-test-run-timescaledb> server # [ 111.462262] postgres[1635]: ::1 2026-10-06 20:07:36.142 UTC [1635] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit; vm-test-run-timescaledb> server # [ 111.474572] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1634]: ALTER ROLE vm-test-run-timescaledb> server # [ 111.475388] postgres[1635]: ::1 2026-10-06 20:07:36.157 UTC [1635] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit; vm-test-run-timescaledb> server # [ 111.481457] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1634]: ALTER ROLE vm-test-run-timescaledb> server # [ 111.485457] postgres[1635]: ::1 2026-10-06 20:07:36.170 UTC [1635] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit; vm-test-run-timescaledb> server # [ 111.491078] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1634]: ALTER ROLE vm-test-run-timescaledb> server # [ 111.511821] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1634]: DO vm-test-run-timescaledb> server # [ 111.544012] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql vm-test-run-timescaledb> server # [ 111.747831] postgres[1637]: ::1 2026-10-06 20:07:36.428 UTC [1637] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin; vm-test-run-timescaledb> server # [ 111.760540] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1636]: GRANT ROLE vm-test-run-timescaledb> server # [ 111.764080] postgres[1637]: ::1 2026-10-06 20:07:36.443 UTC [1637] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin; vm-test-run-timescaledb> server # [ 111.765708] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1636]: REVOKE ROLE vm-test-run-timescaledb> server # [ 111.801405] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql vm-test-run-timescaledb> server # [ 112.063196] postgres[1639]: ::1 2026-10-06 20:07:36.741 UTC [1639] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access() vm-test-run-timescaledb> server # [ 112.077271] postgres[1639]: returns event_trigger vm-test-run-timescaledb> server # [ 112.077882] postgres[1639]: language plpgsql vm-test-run-timescaledb> server # [ 112.078446] postgres[1639]: AS $func$ vm-test-run-timescaledb> server # [ 112.078789] postgres[1639]: DECLARE vm-test-run-timescaledb> server # [ 112.079265] postgres[1639]: func_is_graphql_resolve bool; vm-test-run-timescaledb> server # [ 112.079887] postgres[1639]: BEGIN vm-test-run-timescaledb> server # [ 112.080380] postgres[1639]: func_is_graphql_resolve = ( vm-test-run-timescaledb> server # [ 112.088478] postgres[1639]: SELECT n.proname = 'resolve' vm-test-run-timescaledb> server # [ 112.095476] postgres[1639]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 112.102945] postgres[1639]: LEFT JOIN pg_catalog.pg_proc AS n vm-test-run-timescaledb> server # [ 112.114003] postgres[1639]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 112.116380] postgres[1639]: ); vm-test-run-timescaledb> server # [ 112.121841] postgres[1639]: vm-test-run-timescaledb> server # [ 112.122274] postgres[1639]: IF func_is_graphql_resolve vm-test-run-timescaledb> server # [ 112.122588] postgres[1639]: THEN vm-test-run-timescaledb> server # [ 112.122883] postgres[1639]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func vm-test-run-timescaledb> server # [ 112.134379] postgres[1639]: DROP FUNCTION IF EXISTS graphql_public.graphql; vm-test-run-timescaledb> server # [ 112.135316] postgres[1639]: create or replace function graphql_public.graphql( vm-test-run-timescaledb> server # [ 112.142200] postgres[1639]: "operationName" text default null, vm-test-run-timescaledb> server # [ 112.143392] postgres[1639]: query text default null, vm-test-run-timescaledb> server # [ 112.143750] postgres[1639]: variables jsonb default null, vm-test-run-timescaledb> server # [ 112.154147] postgres[1639]: extensions jsonb default null vm-test-run-timescaledb> server # [ 112.155040] postgres[1639]: ) vm-test-run-timescaledb> server # [ 112.160661] postgres[1639]: returns jsonb vm-test-run-timescaledb> server # [ 112.162719] postgres[1639]: language sql vm-test-run-timescaledb> server # [ 112.176780] postgres[1639]: as $$ vm-test-run-timescaledb> server # [ 112.178297] postgres[1639]: select graphql.resolve( vm-test-run-timescaledb> server # [ 112.179003] postgres[1639]: query := query, vm-test-run-timescaledb> server # [ 112.179392] postgres[1639]: variables := coalesce(variables, '{}'), vm-test-run-timescaledb> server # [ 112.179702] postgres[1639]: "operationName" := "operationName", vm-test-run-timescaledb> server # [ 112.187012] postgres[1639]: extensions := extensions vm-test-run-timescaledb> server # [ 112.187935] postgres[1639]: ); vm-test-run-timescaledb> server # [ 112.202975] postgres[1639]: $$; vm-test-run-timescaledb> server # [ 112.209974] postgres[1639]: vm-test-run-timescaledb> server # [ 112.210925] postgres[1639]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last vm-test-run-timescaledb> server # [ 112.211645] postgres[1639]: -- function in the extension so we need to grant permissions on existing entities AND vm-test-run-timescaledb> server # [ 112.212012] postgres[1639]: -- update default permissions to any others that are created after `graphql.resolve` vm-test-run-timescaledb> server # [ 112.225250] postgres[1639]: grant usage on schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.227831] postgres[1639]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.229809] postgres[1639]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.230788] postgres[1639]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.232148] postgres[1639]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.240785] postgres[1639]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.245064] postgres[1639]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 112.246111] postgres[1639]: vm-test-run-timescaledb> server # [ 112.247330] postgres[1639]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles vm-test-run-timescaledb> server # [ 112.259197] postgres[1639]: grant usage on schema graphql_public to postgres with grant option; vm-test-run-timescaledb> server # [ 112.269177] postgres[1639]: grant usage on schema graphql to postgres with grant option; vm-test-run-timescaledb> server # [ 112.269965] postgres[1639]: END IF; vm-test-run-timescaledb> server # [ 112.270261] postgres[1639]: vm-test-run-timescaledb> server # [ 112.270900] postgres[1639]: END; vm-test-run-timescaledb> server # [ 112.271327] postgres[1639]: $func$; vm-test-run-timescaledb> server # [ 112.271851] postgres[1639]: ::1 2026-10-06 20:07:36.955 UTC [1639] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql; vm-test-run-timescaledb> server # [ 112.293603] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1638]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 112.373915] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1638]: DROP EXTENSION vm-test-run-timescaledb> server # [ 113.859295] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1638]: DO vm-test-run-timescaledb> server # [ 113.883784] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql vm-test-run-timescaledb> server # [ 114.260140] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1664]: DO vm-test-run-timescaledb> server # [ 114.278027] postgres[1668]: ::1 2026-10-06 20:07:38.940 UTC [1668] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger vm-test-run-timescaledb> server # [ 114.279311] postgres[1668]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 114.286123] postgres[1668]: AS $$ vm-test-run-timescaledb> server # [ 114.288043] postgres[1668]: BEGIN vm-test-run-timescaledb> server # [ 114.291843] postgres[1668]: IF EXISTS ( vm-test-run-timescaledb> server # [ 114.298185] postgres[1668]: SELECT vm-test-run-timescaledb> server # [ 114.298862] postgres[1668]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 114.299439] postgres[1668]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 114.299768] postgres[1668]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 114.300541] postgres[1668]: WHERE ext.extname = 'pg_cron' vm-test-run-timescaledb> server # [ 114.309195] postgres[1668]: ) vm-test-run-timescaledb> server # [ 114.309955] postgres[1668]: THEN vm-test-run-timescaledb> server # [ 114.310360] postgres[1668]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 114.310684] postgres[1668]: vm-test-run-timescaledb> server # [ 114.310924] postgres[1668]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 114.311505] postgres[1668]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 114.322330] postgres[1668]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 114.323086] postgres[1668]: vm-test-run-timescaledb> server # [ 114.323928] postgres[1668]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 114.329377] postgres[1668]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 114.331267] postgres[1668]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 114.331972] postgres[1668]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 114.332328] postgres[1668]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 114.332661] postgres[1668]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 114.337958] postgres[1668]: vm-test-run-timescaledb> server # [ 114.338663] postgres[1668]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 114.339697] postgres[1668]: revoke all on table cron.job from postgres; vm-test-run-timescaledb> server # [ 114.342475] postgres[1668]: grant select on table cron.job to postgres with grant option; vm-test-run-timescaledb> server # [ 114.342920] postgres[1668]: END IF; vm-test-run-timescaledb> server # [ 114.344511] postgres[1668]: END; vm-test-run-timescaledb> server # [ 114.344887] postgres[1668]: $$; vm-test-run-timescaledb> server # [ 114.397086] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1664]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 114.399013] postgres[1668]: ::1 2026-10-06 20:07:39.082 UTC [1668] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access; vm-test-run-timescaledb> server # [ 114.406240] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1664]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 114.413210] postgres[1668]: ::1 2026-10-06 20:07:39.094 UTC [1668] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin; vm-test-run-timescaledb> server # [ 114.422475] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1664]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 114.428746] postgres[1668]: ::1 2026-10-06 20:07:39.113 UTC [1668] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end vm-test-run-timescaledb> server # [ 114.429593] postgres[1668]: WHEN TAG IN ('CREATE EXTENSION') vm-test-run-timescaledb> server # [ 114.430538] postgres[1668]: EXECUTE FUNCTION extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 114.453445] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1664]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 114.491017] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql vm-test-run-timescaledb> server # [ 114.742371] postgres[1671]: ::1 2026-10-06 20:07:39.423 UTC [1671] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s'; vm-test-run-timescaledb> server # [ 114.754549] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1670]: ALTER ROLE vm-test-run-timescaledb> server # [ 114.787506] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql vm-test-run-timescaledb> server # [ 115.021428] postgres[1673]: ::1 2026-10-06 20:07:39.692 UTC [1673] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin; vm-test-run-timescaledb> server # [ 115.035698] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1672]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 115.036533] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1672]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 115.040473] postgres[1673]: ::1 2026-10-06 20:07:39.717 UTC [1673] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin; vm-test-run-timescaledb> server # [ 115.049500] postgres[1673]: ::1 2026-10-06 20:07:39.722 UTC [1673] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin; vm-test-run-timescaledb> server # [ 115.058244] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1672]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 115.108692] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql vm-test-run-timescaledb> server # [ 115.466155] postgres[1682]: ::1 2026-10-06 20:07:40.148 UTC [1682] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres; vm-test-run-timescaledb> server # [ 115.508818] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1674]: GRANT ROLE vm-test-run-timescaledb> server # [ 115.526483] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241031003909_create_orioledb.sql vm-test-run-timescaledb> server # [ 116.428212] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1686]: DO vm-test-run-timescaledb> server # [ 116.473516] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql vm-test-run-timescaledb> server # [ 116.906841] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1701]: DO vm-test-run-timescaledb> server # [ 116.919643] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1701]: DO vm-test-run-timescaledb> server # [ 116.953049] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql vm-test-run-timescaledb> server # [ 117.198632] postgres[1705]: ::1 2026-10-06 20:07:41.873 UTC [1705] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none; vm-test-run-timescaledb> server # [ 117.201250] postgres[1705]: ::1 2026-10-06 20:07:41.884 UTC [1705] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none; vm-test-run-timescaledb> server # [ 117.205468] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1704]: ALTER ROLE vm-test-run-timescaledb> server # [ 117.206585] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1704]: ALTER ROLE vm-test-run-timescaledb> server # [ 117.207490] postgres[1705]: ::1 2026-10-06 20:07:41.894 UTC [1705] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none; vm-test-run-timescaledb> server # [ 117.225310] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1704]: ALTER ROLE vm-test-run-timescaledb> server # [ 117.242468] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql vm-test-run-timescaledb> server # [ 117.607332] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1706]: DO vm-test-run-timescaledb> server # [ 117.654635] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql vm-test-run-timescaledb> server # [ 117.958644] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1712]: DO vm-test-run-timescaledb> server # [ 118.000226] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql vm-test-run-timescaledb> server # [ 118.481601] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1714]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 118.489844] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1714]: DO vm-test-run-timescaledb> server # [ 118.543746] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql vm-test-run-timescaledb> server # [ 118.947380] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1722]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 118.965982] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1722]: GRANT vm-test-run-timescaledb> server # [ 119.036349] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql vm-test-run-timescaledb> server # [ 119.358621] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1732]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 119.386389] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1732]: ALTER FUNCTION vm-test-run-timescaledb> server # [ 119.414492] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1732]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 119.471761] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 119.938861] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1744]: DO vm-test-run-timescaledb> server # [ 119.982107] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql vm-test-run-timescaledb> server # [ 120.389843] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1746]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 120.390971] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1746]: GRANT vm-test-run-timescaledb> server # [ 120.436789] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql vm-test-run-timescaledb> server # [ 120.739270] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1748]: REVOKE ROLE vm-test-run-timescaledb> server # [ 120.786303] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1748]: DO vm-test-run-timescaledb> server # [ 120.805930] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1748]: DO vm-test-run-timescaledb> server # [ 120.814973] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1748]: REVOKE ROLE vm-test-run-timescaledb> server # [ 120.835537] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1748]: REVOKE vm-test-run-timescaledb> server # [ 120.863882] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1748]: DO vm-test-run-timescaledb> server # [ 120.916578] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql vm-test-run-timescaledb> server # [ 121.315217] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1750]: DO vm-test-run-timescaledb> server # [ 121.340943] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 121.826256] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1755]: DO vm-test-run-timescaledb> server # [ 121.887845] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql vm-test-run-timescaledb> server # [ 122.451550] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1762]: DO vm-test-run-timescaledb> server # [ 122.480035] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql vm-test-run-timescaledb> server # [ 123.003883] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1771]: ALTER ROLE vm-test-run-timescaledb> server # [ 123.067428] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251001204436_predefined_role_grants.sql vm-test-run-timescaledb> server # [ 123.508666] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1780]: GRANT ROLE vm-test-run-timescaledb> server # [ 123.529544] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1780]: DO vm-test-run-timescaledb> server # [ 123.607444] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql vm-test-run-timescaledb> server # [ 124.177362] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1788]: GRANT vm-test-run-timescaledb> server # [ 124.197363] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql vm-test-run-timescaledb> server # [ 124.503285] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1790]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 124.508265] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1790]: REVOKE vm-test-run-timescaledb> server # [ 124.522861] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1790]: REVOKE vm-test-run-timescaledb> server # [ 124.531857] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1790]: GRANT vm-test-run-timescaledb> server # [ 124.572683] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260211120934_supabase_privileged_role.sql vm-test-run-timescaledb> server # [ 124.926221] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1792]: DO vm-test-run-timescaledb> server # [ 124.928648] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql vm-test-run-timescaledb> server # [ 125.367907] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1794]: ALTER ROLE vm-test-run-timescaledb> server # [ 125.400328] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql vm-test-run-timescaledb> server # [ 126.205136] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1800]: DROP EXTENSION vm-test-run-timescaledb> server # [ 126.207364] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql vm-test-run-timescaledb> server # [ 126.727639] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1811]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.739492] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1811]: DROP EVENT TRIGGER vm-test-run-timescaledb> server # [ 126.763659] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1811]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 126.834590] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql vm-test-run-timescaledb> server # [ 127.266563] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1823]: DO vm-test-run-timescaledb> server # [ 127.301343] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1823]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 127.357293] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql vm-test-run-timescaledb> server # [ 127.814703] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1830]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 127.827374] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1830]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 127.882401] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Running postgresql schema... vm-test-run-timescaledb> server # [ 128.183857] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER DATABASE vm-test-run-timescaledb> server # [ 128.191862] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER DATABASE vm-test-run-timescaledb> server # [ 128.259069] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.311762] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.369873] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.430285] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.514107] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.575095] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.639545] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.703311] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.845623] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.870469] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1832]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.923751] sifpz75c14n7mhfi99hm1l0wzdnrmng9-supabase-db-init[1348]: Database initialization complete vm-test-run-timescaledb> server # [ 128.966861] systemd[1]: Finished Supabase Database Initialization. vm-test-run-timescaledb> server # [ 129.001088] systemd[1]: Reached target Multi-User System. vm-test-run-timescaledb> server # [ 129.003959] systemd[1]: Startup finished in 12.750s (kernel) + 1min 56.238s (userspace) = 2min 8.989s. vm-test-run-timescaledb> server: (finished: waiting for unit supabase-db-init.service, in 130.86 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.63 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.40 seconds) vm-test-run-timescaledb> (finished: subtest: Verify PostgreSQL 15 is our custom build, in 1.04 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.45 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.67 seconds) vm-test-run-timescaledb> (finished: subtest: Verify ansible config loaded, in 1.12 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 # [ 132.735438] systemd[1]: Starting Virtual Console Setup... vm-test-run-timescaledb> server # [ 132.993721] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 133.004928] systemd[1]: Stopped Virtual Console Setup. 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.91 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 # [ 133.063870] systemd[1]: Starting Virtual Console Setup... 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.90 seconds) vm-test-run-timescaledb> (finished: subtest: Verify init scripts and migrations ran, in 1.81 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.97 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 # [ 137.987017] systemd[1]: Finished Virtual Console Setup. vm-test-run-timescaledb> server # [ 138.232150] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-timescaledb> server # [ 140.177452] systemd-logind[647]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) 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 # [ 140.984143] postgres[1917]: [local] 2026-10-06 20:08:05.658 UTC [1917] supabase_admin@postgres WARNING: vm-test-run-timescaledb> server # [ 140.986895] postgres[1917]: WELCOME TO vm-test-run-timescaledb> server # [ 140.987988] postgres[1917]: _____ _ _ ____________ vm-test-run-timescaledb> server # [ 140.988998] postgres[1917]: |_ _(_) | | | _ \ ___ \ vm-test-run-timescaledb> server # [ 140.989450] postgres[1917]: | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ / vm-test-run-timescaledb> server # [ 140.989918] postgres[1917]: | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \ vm-test-run-timescaledb> server # [ 140.990430] postgres[1917]: | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ / vm-test-run-timescaledb> server # [ 140.991029] postgres[1917]: |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/ vm-test-run-timescaledb> server # [ 140.991415] postgres[1917]: Running version 2.9.1 vm-test-run-timescaledb> server # [ 140.991691] postgres[1917]: For more information on TimescaleDB, please visit the following links: vm-test-run-timescaledb> server # [ 140.996597] postgres[1917]: vm-test-run-timescaledb> server # [ 140.998649] postgres[1917]: 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started vm-test-run-timescaledb> server # [ 140.999410] postgres[1917]: 2. API reference documentation: https://docs.timescale.com/api/latest vm-test-run-timescaledb> server # [ 141.000037] postgres[1917]: 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts vm-test-run-timescaledb> server # [ 141.004844] postgres[1917]: vm-test-run-timescaledb> server # [ 141.005745] postgres[1917]: 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 # [ 141.006104] postgres[1917]: vm-test-run-timescaledb> server # [ 141.006346] postgres[1917]: [local] 2026-10-06 20:08:05.658 UTC [1917] 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.15 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 # [ 141.198552] postgres[1961]: 2026-10-06 20:08:05.877 UTC [1961] LOG: job 2 threw an error vm-test-run-timescaledb> server # [ 141.204866] postgres[1961]: 2026-10-06 20:08:05.891 UTC [1961] ERROR: functionality not supported under the current "apache" license vm-test-run-timescaledb> server # [ 141.207039] postgres[1961]: 2026-10-06 20:08:05.891 UTC [1961] HINT: Upgrade your license to 'timescale' to use this free community feature. vm-test-run-timescaledb> server # [ 141.229769] postgres[1303]: 2026-10-06 20:08:05.911 UTC [1303] LOG: background worker "Error Log Retention Policy [2]" (PID 1961) 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.31 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 # [ 141.917787] postgres[1957]: 2026-10-06 20:08:06.599 UTC [1957] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 141.931091] postgres[1303]: 2026-10-06 20:08:06.617 UTC [1303] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 1957) exited with exit code 1 vm-test-run-timescaledb> server # [ 145.138714] postgres[1967]: 2026-10-06 20:08:09.818 UTC [1967] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 145.156551] postgres[1303]: 2026-10-06 20:08:09.840 UTC [1303] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 1967) 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 4.19 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 # [ 145.766415] postgres[1972]: 2026-10-06 20:08:10.441 UTC [1972] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 145.770826] postgres[1972]: 2026-10-06 20:08:10.448 UTC [1972] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 145.774633] postgres[1972]: 2026-10-06 20:08:10.448 UTC [1972] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 145.860325] postgres[1303]: 2026-10-06 20:08:10.545 UTC [1303] LOG: background worker "Job History Log Retention Policy [3]" (PID 1972) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.51 seconds) vm-test-run-timescaledb> (finished: subtest: Check upgrade path with postgresql 15, in 12.14 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 # [ 146.354181] postgres[1968]: 2026-10-06 20:08:11.032 UTC [1968] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command vm-test-run-timescaledb> server # [ 146.380033] postgres[1303]: 2026-10-06 20:08:11.054 UTC [1303] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 1968) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" , in 0.84 seconds) vm-test-run-timescaledb> server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" , in 3.31 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 # [ 150.475591] postgres[1988]: 2026-10-06 20:08:15.156 UTC [1988] LOG: job 3 threw an error vm-test-run-timescaledb> server # [ 150.481211] postgres[1988]: 2026-10-06 20:08:15.167 UTC [1988] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/. vm-test-run-timescaledb> server # [ 150.483432] postgres[1988]: 2026-10-06 20:08:15.167 UTC [1988] HINT: To access all features and the best time-series experience, try out Timescale Cloud. vm-test-run-timescaledb> server # [ 150.527542] postgres[1303]: 2026-10-06 20:08:15.203 UTC [1303] LOG: background worker "Job History Log Retention Policy [3]" (PID 1988) exited with exit code 1 vm-test-run-timescaledb> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.47 seconds) vm-test-run-timescaledb> (finished: subtest: Check the install of the last version of the extension, in 4.62 seconds) vm-test-run-timescaledb> (finished: run the VM test script, in 151.84 seconds) vm-test-run-timescaledb> test script finished in 152.22s 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