these 10 derivations will be built: /nix/store/rp6gcam4yafbmkvgcfi0b0hj2vb5iqc2-user-units.drv /nix/store/rwz4s6dfjqhyr64w6z3z8qrggl5zj52b-system-units.drv /nix/store/sx1rw9bd3i1yvfq7i4vkcrb3bn9ijfql-etc.drv /nix/store/5s048fdjqyzsbl03pvh4ywmyqnh3fmqm-activate.drv /nix/store/cx10cmqf20zx1pb1clza42i1kkh211fi-nixos-system-server-test.drv /nix/store/77ikwz4y4d8vm8k1fkvwjxhn1clzmpxn-closure-info.drv /nix/store/hqq45f72swydh65nkp9f29amnkzj2dyx-run-nixos-vm.drv /nix/store/nv1rjsqxyryds5q4ag7bn5p8h08cq048-nixos-vm.drv /nix/store/2jyvfi3bd6vyxwpz0087jymdb1ssjnly-nixos-test-driver-timescaledb.drv /nix/store/ml4dd3raikc8v80n99mwa689zrspws3m-vm-test-run-timescaledb.drv building '/nix/store/rwz4s6dfjqhyr64w6z3z8qrggl5zj52b-system-units.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/rwz4s6dfjqhyr64w6z3z8qrggl5zj52b-system-units.drv' building '/nix/store/sx1rw9bd3i1yvfq7i4vkcrb3bn9ijfql-etc.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/sx1rw9bd3i1yvfq7i4vkcrb3bn9ijfql-etc.drv' building '/nix/store/5s048fdjqyzsbl03pvh4ywmyqnh3fmqm-activate.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/5s048fdjqyzsbl03pvh4ywmyqnh3fmqm-activate.drv' building '/nix/store/cx10cmqf20zx1pb1clza42i1kkh211fi-nixos-system-server-test.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/cx10cmqf20zx1pb1clza42i1kkh211fi-nixos-system-server-test.drv' building '/nix/store/77ikwz4y4d8vm8k1fkvwjxhn1clzmpxn-closure-info.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/77ikwz4y4d8vm8k1fkvwjxhn1clzmpxn-closure-info.drv' closure-info> structuredAttrs is enabled building '/nix/store/hqq45f72swydh65nkp9f29amnkzj2dyx-run-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/hqq45f72swydh65nkp9f29amnkzj2dyx-run-nixos-vm.drv' building '/nix/store/nv1rjsqxyryds5q4ag7bn5p8h08cq048-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/nv1rjsqxyryds5q4ag7bn5p8h08cq048-nixos-vm.drv' building '/nix/store/2jyvfi3bd6vyxwpz0087jymdb1ssjnly-nixos-test-driver-timescaledb.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247' building '/nix/store/2jyvfi3bd6vyxwpz0087jymdb1ssjnly-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/ml4dd3raikc8v80n99mwa689zrspws3m-vm-test-run-timescaledb.drv' on 'ssh-ng://builder@mac-linux-builder' building '/nix/store/ml4dd3raikc8v80n99mwa689zrspws3m-vm-test-run-timescaledb.drv' vm-test-run-timescaledb> Machine state will be reset. To keep it, pass --keep-vm-state vm-test-run-timescaledb> start all VLans vm-test-run-timescaledb> start vlan vm-test-run-timescaledb> running vlan (pid 7; ctl /build/vde1.ctl) vm-test-run-timescaledb> (finished: start all VLans, in 0.00 seconds) vm-test-run-timescaledb> Test will time out and terminate in 3600 seconds vm-test-run-timescaledb> run the VM test script vm-test-run-timescaledb> additionally exposed symbols: vm-test-run-timescaledb> server, vm-test-run-timescaledb> vlan1, vm-test-run-timescaledb> start_all, test_script, machines, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, Machine, t, debug vm-test-run-timescaledb> start all VMs vm-test-run-timescaledb> server: starting vm vm-test-run-timescaledb> mke2fs 1.47.3 (8-Jul-2025) vm-test-run-timescaledb> qemu-system-aarch64: Could not access KVM kernel module: No such file or directory vm-test-run-timescaledb> qemu-system-aarch64: failed to initialize kvm: No such file or directory vm-test-run-timescaledb> qemu-system-aarch64: falling back to tcg vm-test-run-timescaledb> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-timescaledb> server # Formatting '/build/vm-state-server/tmp.t7sqqC8CWU', fmt=raw size=1073741824 vm-test-run-timescaledb> server # Discarding device blocks: 0/262144 done vm-test-run-timescaledb> server # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-timescaledb> server # Filesystem UUID: e0ade8bf-7736-4b20-84e8-779d7c29ee59 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: QEMU running (pid 9) vm-test-run-timescaledb> server # Writing inode tables: 0/8 done vm-test-run-timescaledb> server # Creating journal (8192 blocks): done vm-test-run-timescaledb> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-timescaledb> server # vm-test-run-timescaledb> server # Virtualisation disk image created. vm-test-run-timescaledb> (finished: start all VMs, in 0.29 seconds) vm-test-run-timescaledb> server: waiting for unit supabase-db-init.service vm-test-run-timescaledb> server: waiting for the VM to finish booting vm-test-run-timescaledb> server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510] vm-test-run-timescaledb> server # [ 0.000000] Linux version 6.12.63 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP Thu Dec 18 12:55:23 UTC 2025 vm-test-run-timescaledb> server # [ 0.000000] KASLR enabled vm-test-run-timescaledb> server # [ 0.000000] random: crng init done vm-test-run-timescaledb> server # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-timescaledb> server # [ 0.000000] efi: UEFI not found. vm-test-run-timescaledb> server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-timescaledb> server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f602200-0x13f60593f] vm-test-run-timescaledb> server # [ 0.000000] Zone ranges: vm-test-run-timescaledb> server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff] vm-test-run-timescaledb> server # [ 0.000000] DMA32 empty vm-test-run-timescaledb> server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] Device empty vm-test-run-timescaledb> server # [ 0.000000] Movable zone start for each node vm-test-run-timescaledb> server # [ 0.000000] Early memory node ranges vm-test-run-timescaledb> server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff] vm-test-run-timescaledb> server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -1 vm-test-run-timescaledb> server # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-timescaledb> server # [ 0.000000] psci: PSCIv1.1 detected in firmware. vm-test-run-timescaledb> server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-timescaledb> server # [ 0.000000] psci: Trusted OS migration not required vm-test-run-timescaledb> server # [ 0.000000] psci: SMC Calling Convention v1.0 vm-test-run-timescaledb> server # [ 0.000000] percpu: Embedded 88 pages/cpu s180056 r65536 d114856 u360448 vm-test-run-timescaledb> server # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: GIC system register CPU interface vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: HCRX_EL2 register vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2) vm-test-run-timescaledb> server # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-timescaledb> server # [ 0.000000] alternatives: applying boot alternatives vm-test-run-timescaledb> server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/rb7xbjjbx4v04r30l6v7agk4rq1bmx4h-nixos-system-server-test/init regInfo=/nix/store/2chg9fcli3a46lyc5v9gg4z5b0k2p9fb-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-timescaledb> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/2chg9fcli3a46lyc5v9gg4z5b0k2p9fb-closure-info/registration", will be passed to user space. vm-test-run-timescaledb> server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) vm-test-run-timescaledb> server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) vm-test-run-timescaledb> server # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-timescaledb> server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576 vm-test-run-timescaledb> server # [ 0.000000] Policy zone: Normal vm-test-run-timescaledb> server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-timescaledb> server # [ 0.000000] software IO TLB: area num 2. vm-test-run-timescaledb> server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB) vm-test-run-timescaledb> server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 vm-test-run-timescaledb> server # [ 0.000000] allocated 8388608 bytes of page_ext vm-test-run-timescaledb> server # [ 0.000000] ftrace: allocating 72257 entries in 283 pages vm-test-run-timescaledb> server # [ 0.000000] ftrace: allocated 283 pages with 5 groups vm-test-run-timescaledb> server # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2. vm-test-run-timescaledb> server # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-timescaledb> server # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-timescaledb> server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-timescaledb> server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 vm-test-run-timescaledb> server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-timescaledb> server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. vm-test-run-timescaledb> server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-timescaledb> server # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-timescaledb> server # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-timescaledb> server # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-timescaledb> server # [ 0.000000] GICv3: GICv3 features: 16 PPIs vm-test-run-timescaledb> server # [ 0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 vm-test-run-timescaledb> server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-timescaledb> server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-timescaledb> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100ae0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-timescaledb> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100af0000 (flat, esz 8, psz 64K, shr 1) vm-test-run-timescaledb> server # [ 0.000000] GICv3: using LPI property table @0x0000000100b00000 vm-test-run-timescaledb> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b10000 vm-test-run-timescaledb> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-timescaledb> server # [ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (virt). vm-test-run-timescaledb> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-timescaledb> server # [ 0.000034] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-timescaledb> server # [ 0.003654] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-timescaledb> server # [ 0.010865] Console: colour dummy device 80x25 vm-test-run-timescaledb> server # [ 0.012222] printk: legacy console [tty0] enabled vm-test-run-timescaledb> server # [ 0.017206] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-timescaledb> server # [ 0.017567] pid_max: default: 32768 minimum: 301 vm-test-run-timescaledb> server # [ 0.021628] LSM: initializing lsm=capability,landlock,yama,bpf vm-test-run-timescaledb> server # [ 0.023207] landlock: Up and running. vm-test-run-timescaledb> server # [ 0.023260] Yama: becoming mindful. vm-test-run-timescaledb> server # [ 0.027455] LSM support for eBPF active vm-test-run-timescaledb> server # [ 0.030048] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.030638] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.056098] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-timescaledb> server # [ 0.066514] rcu: Hierarchical SRCU implementation. vm-test-run-timescaledb> server # [ 0.066626] rcu: Max phase no-delay instances is 1000. vm-test-run-timescaledb> server # [ 0.068560] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level vm-test-run-timescaledb> server # [ 0.074106] fsl-mc MSI: its@8080000 domain created vm-test-run-timescaledb> server # [ 0.075802] EFI services will not be available. vm-test-run-timescaledb> server # [ 0.077204] smp: Bringing up secondary CPUs ... vm-test-run-timescaledb> server # [ 0.081356] Detected PIPT I-cache on CPU1 vm-test-run-timescaledb> server # [ 0.083372] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 vm-test-run-timescaledb> server # [ 0.084440] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000 vm-test-run-timescaledb> server # [ 0.086083] CPU1: Booted secondary processor 0x0000000001 [0x000f0510] vm-test-run-timescaledb> server # [ 0.091651] smp: Brought up 1 node, 2 CPUs vm-test-run-timescaledb> server # [ 0.091794] SMP: Total of 2 processors activated. vm-test-run-timescaledb> server # [ 0.092078] CPU: All CPU(s) started at EL1 vm-test-run-timescaledb> server # [ 0.092234] CPU features: detected: Branch Target Identification vm-test-run-timescaledb> server # [ 0.092284] CPU features: detected: 32-bit EL0 Support vm-test-run-timescaledb> server # [ 0.092314] CPU features: detected: 32-bit EL1 Support vm-test-run-timescaledb> server # [ 0.092334] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-timescaledb> server # [ 0.092360] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-timescaledb> server # [ 0.092392] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-timescaledb> server # [ 0.092449] CPU features: detected: Common not Private translations vm-test-run-timescaledb> server # [ 0.092473] CPU features: detected: CRC32 instructions vm-test-run-timescaledb> server # [ 0.092491] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-timescaledb> server # [ 0.092514] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-timescaledb> server # [ 0.092539] CPU features: detected: Data independent timing control (DIT) vm-test-run-timescaledb> server # [ 0.092559] CPU features: detected: E0PD vm-test-run-timescaledb> server # [ 0.092576] CPU features: detected: Enhanced Counter Virtualization vm-test-run-timescaledb> server # [ 0.092597] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-timescaledb> server # [ 0.092620] CPU features: detected: Enhanced Privileged Access Never vm-test-run-timescaledb> server # [ 0.092640] CPU features: detected: Enhanced Virtualization Traps vm-test-run-timescaledb> server # [ 0.092660] CPU features: detected: Fine Grained Traps vm-test-run-timescaledb> server # [ 0.092706] CPU features: detected: Generic authentication (IMP DEF algorithm) vm-test-run-timescaledb> server # [ 0.092776] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-timescaledb> server # [ 0.092813] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2) vm-test-run-timescaledb> server # [ 0.092839] CPU features: detected: LSE atomic instructions vm-test-run-timescaledb> server # [ 0.092858] CPU features: detected: Memory Copy and Memory Set instructions vm-test-run-timescaledb> server # [ 0.092882] CPU features: detected: Privileged Access Never vm-test-run-timescaledb> server # [ 0.092906] CPU features: detected: RAS Extension Support vm-test-run-timescaledb> server # [ 0.092929] CPU features: detected: Random Number Generator vm-test-run-timescaledb> server # [ 0.092948] CPU features: detected: Speculation barrier (SB) vm-test-run-timescaledb> server # [ 0.092966] CPU features: detected: Stage-2 Force Write-Back vm-test-run-timescaledb> server # [ 0.092985] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality vm-test-run-timescaledb> server # [ 0.093008] CPU features: detected: TLB range maintenance instructions vm-test-run-timescaledb> server # [ 0.093027] CPU features: detected: WFx with timeout vm-test-run-timescaledb> server # [ 0.093061] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-timescaledb> server # [ 0.093103] CPU features: detected: Scalable Vector Extension vm-test-run-timescaledb> server # [ 0.101183] alternatives: applying system-wide alternatives vm-test-run-timescaledb> server # [ 0.114468] CPU features: detected: Hardware dirty bit management on CPU0-1 vm-test-run-timescaledb> server # [ 0.115026] SVE: maximum available vector length 256 bytes per vector vm-test-run-timescaledb> server # [ 0.115105] SVE: default vector length 64 bytes per vector vm-test-run-timescaledb> server # [ 0.130004] Memory: 3922856K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved) vm-test-run-timescaledb> server # [ 0.152875] devtmpfs: initialized vm-test-run-timescaledb> server # [ 0.180072] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-timescaledb> server # [ 0.180569] futex hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.183272] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-timescaledb> server # [ 0.183338] 0 pages in range for non-PLT usage vm-test-run-timescaledb> server # [ 0.183382] 509248 pages in range for PLT usage vm-test-run-timescaledb> server # [ 0.185779] pinctrl core: initialized pinctrl subsystem vm-test-run-timescaledb> server # [ 0.196516] DMI not present or invalid. vm-test-run-timescaledb> server # [ 0.225551] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-timescaledb> server # [ 0.238582] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations vm-test-run-timescaledb> server # [ 0.240023] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-timescaledb> server # [ 0.241582] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-timescaledb> server # [ 0.241870] audit: initializing netlink subsys (disabled) vm-test-run-timescaledb> server # [ 0.245073] audit: type=2000 audit(0.120:1): state=initialized audit_enabled=0 res=1 vm-test-run-timescaledb> server # [ 0.252399] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-timescaledb> server # [ 0.252455] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-timescaledb> server # [ 0.252515] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-timescaledb> server # [ 0.252547] thermal_sys: Registered thermal governor 'user_space' vm-test-run-timescaledb> server # [ 0.252575] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-timescaledb> server # [ 0.253495] cpuidle: using governor ladder vm-test-run-timescaledb> server # [ 0.253947] cpuidle: using governor menu vm-test-run-timescaledb> server # [ 0.258194] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. vm-test-run-timescaledb> server # [ 0.259609] ASID allocator initialised with 65536 entries vm-test-run-timescaledb> server # [ 0.269135] Serial: AMBA PL011 UART driver vm-test-run-timescaledb> server # [ 0.322194] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-timescaledb> server # [ 0.323459] printk: legacy console [ttyAMA0] enabled vm-test-run-timescaledb> server # [ 0.360991] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.361318] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-timescaledb> server # [ 0.361423] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.361508] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-timescaledb> server # [ 0.361597] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.361694] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-timescaledb> server # [ 0.361818] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-timescaledb> server # [ 0.361907] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-timescaledb> server # [ 0.375314] fbcon: Taking over console vm-test-run-timescaledb> server # [ 0.376004] ACPI: Interpreter disabled. vm-test-run-timescaledb> server # [ 0.382615] iommu: Default domain type: Translated vm-test-run-timescaledb> server # [ 0.383010] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-timescaledb> server # [ 0.386783] SCSI subsystem initialized vm-test-run-timescaledb> server # [ 0.388957] usbcore: registered new interface driver usbfs vm-test-run-timescaledb> server # [ 0.389432] usbcore: registered new interface driver hub vm-test-run-timescaledb> server # [ 0.389636] usbcore: registered new device driver usb vm-test-run-timescaledb> server # [ 0.392575] pps_core: LinuxPPS API ver. 1 registered vm-test-run-timescaledb> server # [ 0.392863] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-timescaledb> server # [ 0.393315] PTP clock support registered vm-test-run-timescaledb> server # [ 0.393655] EDAC MC: Ver: 3.0.0 vm-test-run-timescaledb> server # [ 0.395148] scmi_core: SCMI protocol bus registered vm-test-run-timescaledb> server # [ 0.398377] FPGA manager framework vm-test-run-timescaledb> server # [ 0.400324] Advanced Linux Sound Architecture Driver Initialized. vm-test-run-timescaledb> server # [ 0.407760] vgaarb: loaded vm-test-run-timescaledb> server # [ 0.413654] clocksource: Switched to clocksource arch_sys_counter vm-test-run-timescaledb> server # [ 0.423409] VFS: Disk quotas dquot_6.6.0 vm-test-run-timescaledb> server # [ 0.423941] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-timescaledb> server # [ 0.425645] netfs: FS-Cache loaded vm-test-run-timescaledb> server # [ 0.428271] pnp: PnP ACPI: disabled vm-test-run-timescaledb> server # [ 0.455087] NET: Registered PF_INET protocol family vm-test-run-timescaledb> server # [ 0.457667] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-timescaledb> server # [ 0.558971] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) vm-test-run-timescaledb> server # [ 0.559332] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.560343] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) vm-test-run-timescaledb> server # [ 0.561847] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) vm-test-run-timescaledb> server # [ 0.562875] TCP: Hash tables configured (established 32768 bind 32768) vm-test-run-timescaledb> server # [ 0.564389] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear) vm-test-run-timescaledb> server # [ 0.564777] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.565350] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) vm-test-run-timescaledb> server # [ 0.566736] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-timescaledb> server # [ 0.567119] NET: Registered PF_XDP protocol family vm-test-run-timescaledb> server # [ 0.567336] PCI: CLS 0 bytes, default 64 vm-test-run-timescaledb> server # [ 0.568935] kvm [1]: HYP mode not available vm-test-run-timescaledb> server # [ 0.572282] Trying to unpack rootfs image as initramfs... vm-test-run-timescaledb> server # [ 0.669625] Initialise system trusted keyrings vm-test-run-timescaledb> server # [ 0.672838] workingset: timestamp_bits=42 max_order=20 bucket_order=0 vm-test-run-timescaledb> server # [ 0.677069] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-timescaledb> server # [ 0.677852] 9p: Installing v9fs 9p2000 file system support vm-test-run-timescaledb> server # [ 0.735114] Key type asymmetric registered vm-test-run-timescaledb> server # [ 0.735628] Asymmetric key parser 'x509' registered vm-test-run-timescaledb> server # [ 0.736327] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) vm-test-run-timescaledb> server # [ 0.737847] io scheduler mq-deadline registered vm-test-run-timescaledb> server # [ 0.737981] io scheduler kyber registered vm-test-run-timescaledb> server # [ 0.765609] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-timescaledb> server # [ 0.771905] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-timescaledb> server # [ 0.774858] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-timescaledb> server # [ 0.775358] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-timescaledb> server # [ 0.776062] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-timescaledb> server # [ 0.776221] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-timescaledb> server # [ 0.776610] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-timescaledb> server # [ 0.777029] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-timescaledb> server # [ 0.778892] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-timescaledb> server # [ 0.779202] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-timescaledb> server # [ 0.779340] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.779444] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.779533] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.780652] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.783419] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.783695] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.783817] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.784021] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.784146] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.784588] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.784713] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.785309] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.785741] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.787477] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.787800] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.787904] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.788002] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.788419] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.788539] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.788617] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.788708] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.789063] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.789698] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.789919] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.791027] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.792129] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.792711] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-timescaledb> server # [ 0.792924] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.793408] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.794557] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.794729] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.794834] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.794942] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.795037] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-timescaledb> server # [ 0.795946] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.796086] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.796181] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.796543] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.796667] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.796758] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.797781] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.798392] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.799081] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.799328] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-timescaledb> server # [ 0.799414] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.799510] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.799928] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-timescaledb> server # [ 0.800048] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-timescaledb> server # [ 0.800131] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-timescaledb> server # [ 0.800221] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-timescaledb> server # [ 0.801922] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.802725] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-timescaledb> server # [ 0.802978] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.803152] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.803508] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.803896] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.804005] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.804113] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.804550] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.805390] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.805687] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.806481] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.806847] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-timescaledb> server # [ 0.807080] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-timescaledb> server # [ 0.807375] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-timescaledb> server # [ 0.807583] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-timescaledb> server # [ 0.807777] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-timescaledb> server # [ 0.807956] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-timescaledb> server # [ 0.808058] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-timescaledb> server # [ 0.808152] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-timescaledb> server # [ 0.808248] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-timescaledb> server # [ 0.808341] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-timescaledb> server # [ 0.808434] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-timescaledb> server # [ 0.808523] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-timescaledb> server # [ 0.808644] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-timescaledb> server # [ 0.808802] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-timescaledb> server # [ 0.808956] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-timescaledb> server # [ 0.809054] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-timescaledb> server # [ 0.809306] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-timescaledb> server # [ 0.809409] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-timescaledb> server # [ 0.809502] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-timescaledb> server # [ 0.810655] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-timescaledb> server # [ 0.810771] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-timescaledb> server # [ 0.810858] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-timescaledb> server # [ 0.811105] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-timescaledb> server # [ 0.811195] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-timescaledb> server # [ 0.811277] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-timescaledb> server # [ 0.812010] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.866208] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.870940] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.872494] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.874939] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.876728] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.879768] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.882791] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.885695] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.888111] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-timescaledb> server # [ 0.892495] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.896388] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-timescaledb> server # [ 0.919225] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-timescaledb> server # [ 0.929809] msm_serial: driver initialized vm-test-run-timescaledb> server # [ 0.931181] SuperH (H)SCI(F) driver initialized vm-test-run-timescaledb> server # [ 0.931558] STM32 USART driver initialized vm-test-run-timescaledb> server # [ 0.991984] loop: module loaded vm-test-run-timescaledb> server # [ 0.992850] virtio_blk virtio5: 2/0/0 default/read/poll queues vm-test-run-timescaledb> server # [ 0.996478] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-timescaledb> server # [ 1.001848] Freeing initrd memory: 10684K vm-test-run-timescaledb> server # [ 1.009014] megasas: 07.727.03.00-rc1 vm-test-run-timescaledb> server # [ 1.014179] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-timescaledb> server # [ 1.016841] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 1.017390] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 1.020817] Using buffer write method vm-test-run-timescaledb> server # [ 1.021617] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-timescaledb> server # [ 1.023092] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-timescaledb> server # [ 1.023665] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-timescaledb> server # [ 1.025956] Using buffer write method vm-test-run-timescaledb> server # [ 1.026145] Concatenating MTD devices: vm-test-run-timescaledb> server # [ 1.026213] (0): "0.flash" vm-test-run-timescaledb> server # [ 1.026262] (1): "0.flash" vm-test-run-timescaledb> server # [ 1.026658] into device "0.flash" vm-test-run-timescaledb> server # [ 1.050079] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-timescaledb> server # [ 1.061072] thunder_xcv, ver 1.0 vm-test-run-timescaledb> server # [ 1.061323] thunder_bgx, ver 1.0 vm-test-run-timescaledb> server # [ 1.061461] nicpf, ver 1.0 vm-test-run-timescaledb> server # [ 1.064155] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version vm-test-run-timescaledb> server # [ 1.064298] hns3: Copyright (c) 2017 Huawei Corporation. vm-test-run-timescaledb> server # [ 1.064581] hclge is initializing vm-test-run-timescaledb> server # [ 1.064781] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.064860] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-timescaledb> server # [ 1.065039] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-timescaledb> server # [ 1.065374] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-timescaledb> server # [ 1.065761] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-timescaledb> server # [ 1.065850] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-timescaledb> server # [ 1.066851] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-timescaledb> server # [ 1.066954] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-timescaledb> server # [ 1.067585] sky2: driver version 1.30 vm-test-run-timescaledb> server # [ 1.075116] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-timescaledb> server # [ 1.075669] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-timescaledb> server # [ 1.078780] usbcore: registered new interface driver usb-storage vm-test-run-timescaledb> server # [ 1.079783] usbcore: registered new interface driver usbserial_generic vm-test-run-timescaledb> server # [ 1.080022] usbserial: USB Serial support registered for generic vm-test-run-timescaledb> server # [ 1.080469] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-timescaledb> server # [ 1.089910] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-timescaledb> server # [ 1.091042] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-timescaledb> server # [ 1.090954] rtc-pl031 9010000.pl031: setting system clock to 2026-10-07T14:21:01 UTC (1791382861) vm-test-run-timescaledb> server # [ 1.093313] i2c_dev: i2c /dev entries driver vm-test-run-timescaledb> server # [ 1.098987] hub 1-0:1.0: USB hub found vm-test-run-timescaledb> server # [ 1.099648] hub 1-0:1.0: 6 ports detected vm-test-run-timescaledb> server # [ 1.111008] sdhci: Secure Digital Host Controller Interface driver vm-test-run-timescaledb> server # [ 1.111405] sdhci: Copyright(c) Pierre Ossman vm-test-run-timescaledb> server # [ 1.113056] Synopsys Designware Multimedia Card Interface Driver vm-test-run-timescaledb> server # [ 1.116488] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-timescaledb> server # [ 1.123143] hid: raw HID events driver (C) Jiri Kosina vm-test-run-timescaledb> server # [ 1.124862] usbcore: registered new interface driver usbhid vm-test-run-timescaledb> server # [ 1.124976] usbhid: USB HID core driver vm-test-run-timescaledb> server # [ 1.132389] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available vm-test-run-timescaledb> server # [ 1.143152] drop_monitor: Initializing network drop monitor service vm-test-run-timescaledb> server # [ 1.144783] NET: Registered PF_INET6 protocol family vm-test-run-timescaledb> server # [ 1.158975] Segment Routing with IPv6 vm-test-run-timescaledb> server # [ 1.159296] In-situ OAM (IOAM) with IPv6 vm-test-run-timescaledb> server # [ 1.159806] NET: Registered PF_PACKET protocol family vm-test-run-timescaledb> server # [ 1.161467] 9pnet: Installing 9P2000 support vm-test-run-timescaledb> server # [ 1.165635] Key type dns_resolver registered vm-test-run-timescaledb> server # [ 1.197814] registered taskstats version 1 vm-test-run-timescaledb> server # [ 1.200046] Loading compiled-in X.509 certificates vm-test-run-timescaledb> server # [ 1.249779] Demotion targets for Node 0: null vm-test-run-timescaledb> server # [ 1.251656] Key type .fscrypt registered vm-test-run-timescaledb> server # [ 1.251781] Key type fscrypt-provisioning registered vm-test-run-timescaledb> server # [ 1.259856] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-timescaledb> server # [ 1.298798] clk: Disabling unused clocks vm-test-run-timescaledb> server # [ 1.299053] PM: genpd: Disabling unused power domains vm-test-run-timescaledb> server # [ 1.299317] ALSA device list: vm-test-run-timescaledb> server # [ 1.300244] No soundcards found. vm-test-run-timescaledb> server # [ 1.368757] Freeing unused kernel memory: 4416K vm-test-run-timescaledb> server # [ 1.370319] Run /init as init process vm-test-run-timescaledb> server # [ 1.370916] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-timescaledb> server # [ 1.603760] 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.726903] 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.883057] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev vm-test-run-timescaledb> server # [ 1.884172] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-timescaledb> server # [ 2.016009] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-timescaledb> server # [ 2.017961] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-timescaledb> server # [ 2.017988] [drm] features: -context_init vm-test-run-timescaledb> server # [ 2.021758] [drm] number of scanouts: 1 vm-test-run-timescaledb> server # [ 2.021926] [drm] number of cap sets: 0 vm-test-run-timescaledb> server # [ 2.032454] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-timescaledb> server # [ 2.075656] 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.077614] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 vm-test-run-timescaledb> server # [ 2.083440] Console: switching to colour frame buffer device 160x50 vm-test-run-timescaledb> server # [ 2.095694] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-timescaledb> server # [ 4.887714] EXT4-fs (vda): mounted filesystem e0ade8bf-7736-4b20-84e8-779d7c29ee59 r/w with ordered data mode. Quota mode: none. vm-test-run-timescaledb> server # [ 7.238422] EXT4-fs (vda): re-mounted e0ade8bf-7736-4b20-84e8-779d7c29ee59. vm-test-run-timescaledb> server # [ 7.257155] booting system configuration /nix/store/rb7xbjjbx4v04r30l6v7agk4rq1bmx4h-nixos-system-server-test vm-test-run-timescaledb> server # [ 17.755257] systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN -IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) vm-test-run-timescaledb> server # [ 17.765488] systemd[1]: Detected virtualization qemu. vm-test-run-timescaledb> server # [ 17.770663] systemd[1]: Detected architecture arm64. vm-test-run-timescaledb> server # [ 17.775423] systemd[1]: Detected first boot. vm-test-run-timescaledb> server # [ 17.802264] systemd[1]: Initializing machine ID from random generator. vm-test-run-timescaledb> server # [ 17.831139] systemd[1]: Hostname set to . vm-test-run-timescaledb> server # [ 18.900870] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-timescaledb> server # [ 20.315635] systemd[1]: Applying preset policy. vm-test-run-timescaledb> server # [ 23.443096] systemd[1]: Populated /etc with preset unit settings. vm-test-run-timescaledb> server # [ 26.229596] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-timescaledb> server # [ 26.414021] systemd[1]: Created slice Slice /system/getty. vm-test-run-timescaledb> server # [ 26.428597] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-timescaledb> server # [ 26.440436] systemd[1]: Created slice User and Session Slice. vm-test-run-timescaledb> server # [ 26.449001] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-timescaledb> server # [ 26.454526] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-timescaledb> server # [ 26.460538] systemd[1]: Expecting device /dev/hvc0... vm-test-run-timescaledb> server # [ 26.463972] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-timescaledb> server # [ 26.468439] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... vm-test-run-timescaledb> server # [ 26.473563] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-timescaledb> server # [ 26.478610] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-timescaledb> server # [ 26.482778] systemd[1]: Reached target Path Units. vm-test-run-timescaledb> server # [ 26.486532] systemd[1]: Reached target Remote File Systems. vm-test-run-timescaledb> server # [ 26.490929] systemd[1]: Reached target Slice Units. vm-test-run-timescaledb> server # [ 26.493779] systemd[1]: Reached target Swaps. vm-test-run-timescaledb> server # [ 26.524199] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-timescaledb> server # [ 26.543996] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-timescaledb> server # [ 26.554844] systemd[1]: Listening on Journal Audit Socket. vm-test-run-timescaledb> server # [ 26.560107] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-timescaledb> server # [ 26.565284] systemd[1]: Listening on Journal Sockets. vm-test-run-timescaledb> server # [ 26.571977] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-timescaledb> server # [ 26.576168] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 26.580824] systemd[1]: Listening on udev Control Socket. vm-test-run-timescaledb> server # [ 26.585177] systemd[1]: Listening on udev Kernel Socket. vm-test-run-timescaledb> server # [ 26.629656] systemd[1]: Mounting Huge Pages File System... vm-test-run-timescaledb> server # [ 26.666612] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-timescaledb> server # [ 26.699688] systemd[1]: Mounting Kernel Debug File System... vm-test-run-timescaledb> server # [ 26.749409] systemd[1]: Mounting Kernel Trace File System... vm-test-run-timescaledb> server # [ 26.875645] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-timescaledb> server # [ 26.988371] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-timescaledb> server # [ 27.008104] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs). vm-test-run-timescaledb> server # [ 27.143628] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-timescaledb> server # [ 27.184802] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). vm-test-run-timescaledb> server # [ 27.200539] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore). vm-test-run-timescaledb> server # [ 27.319288] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-timescaledb> server # [ 27.331585] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). vm-test-run-timescaledb> server # [ 27.344145] 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 # [ 27.465319] systemd[1]: Starting Journal Service... vm-test-run-timescaledb> server # [ 27.563103] systemd[1]: Starting Load Kernel Modules... vm-test-run-timescaledb> server # [ 27.657616] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-timescaledb> server # [ 27.735896] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-timescaledb> server # [ 27.744082] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 27.801233] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-timescaledb> server # [ 27.893468] systemd[1]: Mounted Huge Pages File System. vm-test-run-timescaledb> server # [ 27.910667] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-timescaledb> server # [ 27.920601] systemd[1]: Mounted Kernel Debug File System. vm-test-run-timescaledb> server # [ 27.932968] systemd[1]: Mounted Kernel Trace File System. vm-test-run-timescaledb> server # [ 27.960501] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-timescaledb> server # [ 27.986948] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-timescaledb> server # [ 28.083547] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-timescaledb> server # [ 28.478608] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 28.492636] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-timescaledb> server # [ 29.005638] fuse: init (API version 7.41) vm-test-run-timescaledb> server # [ 29.066548] systemd[1]: Finished Load Kernel Modules. vm-test-run-timescaledb> server # [ 29.137441] systemd[1]: Starting Firewall... vm-test-run-timescaledb> server # [ 29.189053] EXT4-fs (vda): re-mounted e0ade8bf-7736-4b20-84e8-779d7c29ee59. vm-test-run-timescaledb> server # [ 29.204921] systemd[1]: Starting Apply Kernel Variables... vm-test-run-timescaledb> server # [ 29.244534] systemd[1]: modprobe@fuse.service: Deactivated successfully. 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.273538] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-timescaledb> server # [ 29.359873] systemd[1]: Mounting FUSE Control File System... vm-test-run-timescaledb> server # [ 29.426075] systemd-journald[398]: Collecting audit messages is enabled. vm-test-run-timescaledb> server # [ 29.539652] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-timescaledb> server # [ 29.553075] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). vm-test-run-timescaledb> server # [ 29.661993] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-timescaledb> server # [ 29.671617] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). vm-test-run-timescaledb> server # [ 29.707063] systemd[1]: Mounted FUSE Control File System. vm-test-run-timescaledb> server # [ 30.678358] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-timescaledb> server # [ 30.772102] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-timescaledb> server # [ 30.821259] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-timescaledb> server # [ 30.845586] systemd[1]: Reached target First Boot Complete. vm-test-run-timescaledb> server # [ 31.178113] systemd[1]: Finished Apply Kernel Variables. vm-test-run-timescaledb> server # [ 31.236265] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-timescaledb> server # [ 32.220572] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-timescaledb> server # [ 32.250167] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-timescaledb> server # [ 32.300559] systemd[1]: Mounting /run/wrappers... vm-test-run-timescaledb> server # [ 32.360788] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-timescaledb> server # [ 32.520950] systemd[1]: Started Journal Service. vm-test-run-timescaledb> server # [ 32.338318] systemd-modules-load[399]: Module 'atkbd' is built in vm-test-run-timescaledb> server # [ 32.372337] systemd-modules-load[399]: Module 'loop' is built in vm-test-run-timescaledb> server # [ 32.425786] systemd-oomd[400]: No swap; memory pressure usage will be degraded vm-test-run-timescaledb> server # [ 32.490306] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-timescaledb> server # [ 32.777234] systemd[1]: Mounted /run/wrappers. vm-test-run-timescaledb> server # [ 32.837988] systemd[1]: Reached target Local File Systems. vm-test-run-timescaledb> server # [ 32.878995] systemd[1]: Listening on Boot Entries Service Socket. vm-test-run-timescaledb> server # [ 32.948099] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-timescaledb> server # [ 32.954076] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. vm-test-run-timescaledb> server # [ 33.033891] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-timescaledb> server # [ 33.651505] systemd-journald[398]: Received client request to flush runtime journal. vm-test-run-timescaledb> server # [ 34.511406] systemd-udevd[426]: Using default interface naming scheme 'v258'. vm-test-run-timescaledb> server # [ 34.555242] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-timescaledb> server # [ 34.586826] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-timescaledb> server # [ 34.609143] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-timescaledb> server # [ 34.611586] systemd[1]: Starting Create System Files and Directories... vm-test-run-timescaledb> server # [ 36.862433] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-timescaledb> server # [ 36.888153] systemd[1]: Finished Create System Files and Directories. vm-test-run-timescaledb> server # [ 36.957296] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-timescaledb> server # [ 37.017697] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-timescaledb> server # [ 38.338650] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-timescaledb> server # [ 39.600653] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-timescaledb> server # [ 39.618211] systemd[1]: Starting Update is Completed... vm-test-run-timescaledb> server # [ 40.453089] systemd[1]: Finished Update is Completed. vm-test-run-timescaledb> server # [ 44.905642] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 44.927601] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-timescaledb> server # [ 44.939140] systemd[1]: suid-sgid-wrappers.service: Consumed 3.230s CPU time, 5.6M memory peak. vm-test-run-timescaledb> server # [ 47.639088] systemd[1]: Finished Firewall. vm-test-run-timescaledb> server # [ 49.315155] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-timescaledb> server # [ 49.327464] systemd[1]: Reached target System Initialization. vm-test-run-timescaledb> server # [ 49.346377] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-timescaledb> server # [ 49.351450] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-timescaledb> server # [ 49.359603] systemd[1]: Reached target Timer Units. vm-test-run-timescaledb> server # [ 49.379098] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-timescaledb> server # [ 49.383884] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-timescaledb> server # [ 49.388013] systemd[1]: Listening on Hostname Service Socket. vm-test-run-timescaledb> server # [ 49.392260] systemd[1]: Reached target Socket Units. vm-test-run-timescaledb> server # [ 49.406708] systemd[1]: Reached target Basic System. vm-test-run-timescaledb> server # [ 49.420831] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-timescaledb> server # [ 49.453015] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 49.503944] systemd[1]: Started Reset console on configuration changes. vm-test-run-timescaledb> server # [ 49.601801] systemd[1]: Starting resolvconf update... vm-test-run-timescaledb> server # [ 49.679257] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-timescaledb> server # [ 50.915693] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-timescaledb> server # [ 51.222395] nsncd[635]: Oct 07 14:21:51.740 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 51.239284] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 51.259122] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 51.279811] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 51.309028] systemd[1]: Starting User Login Management... vm-test-run-timescaledb> server # [ 51.388095] dbus-daemon[638]: dbus[638]: Unknown username "systemd-timesync" in message bus configuration file vm-test-run-timescaledb> server # [ 51.932122] systemd[1]: Started D-Bus System Message Bus. vm-test-run-timescaledb> server # [ 52.895405] systemd-logind[657]: New seat seat0. vm-test-run-timescaledb> server # [ 52.955716] systemd[1]: Started User Login Management. vm-test-run-timescaledb> server # [ 52.965966] systemd[1]: Starting linger-users.service... vm-test-run-timescaledb> server # [ 53.111215] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 53.135105] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-timescaledb> server # [ 53.152088] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 53.161564] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-timescaledb> server # [ 53.170734] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 53.194385] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 53.217637] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 53.392139] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-timescaledb> server # [ 53.665762] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-timescaledb> server # [ 53.681403] systemd[1]: Finished linger-users.service. vm-test-run-timescaledb> server # [ 54.165591] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-timescaledb> server # [ 54.176711] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-timescaledb> server # [ 54.186925] nsncd[695]: Oct 07 14:21:54.749 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-timescaledb> server # [ 54.195413] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-timescaledb> server # [ 54.617732] systemd[1]: Finished resolvconf update. vm-test-run-timescaledb> server # [ 54.627990] systemd[1]: Reached target Preparation for Network. vm-test-run-timescaledb> server # [ 54.673917] systemd[1]: Starting DHCP Client... vm-test-run-timescaledb> server # [ 56.305142] dhcpcd[746]: dhcpcd-10.2.4 starting vm-test-run-timescaledb> server # [ 56.377080] dhcpcd[750]: dev: loaded udev vm-test-run-timescaledb> server # [ 56.922758] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-timescaledb> server # [ 57.374357] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-timescaledb> server # [ 57.684568] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-timescaledb> server # [ 57.695025] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-timescaledb> server # [ 57.723693] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 vm-test-run-timescaledb> server # [ 57.728967] cfg80211: failed to load regulatory.db vm-test-run-timescaledb> server # [ 58.795077] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-timescaledb> server # [ 58.625950] dhcpcd[750]: eth0: waiting for carrier vm-test-run-timescaledb> server # [ 58.645264] dhcpcd[750]: libudev: received NULL device vm-test-run-timescaledb> server # [ 58.647042] dhcpcd[750]: libudev: received NULL device vm-test-run-timescaledb> server # [ 58.653420] dhcpcd[750]: eth0: carrier acquired vm-test-run-timescaledb> server # [ 58.767431] dhcpcd[750]: DUID 00:01:00:01:32:59:12:07:52:54:00:12:34:56 vm-test-run-timescaledb> server # [ 58.777396] dhcpcd[750]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 58.778456] dhcpcd[750]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-timescaledb> server # [ 59.078317] systemd[1]: Found device /dev/hvc0. vm-test-run-timescaledb> server: Guest root shell did not produce any data yet... vm-test-run-timescaledb> server: To debug, enter the VM and run 'systemctl status backdoor.service'. vm-test-run-timescaledb> server # [ 59.345308] dhcpcd[750]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 59.377721] dhcpcd[750]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 59.395598] dhcpcd[750]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 59.545595] systemd[1]: Found device /dev/ttyAMA0. vm-test-run-timescaledb> server # [ 59.606849] systemd[1]: Started backdoor.service. vm-test-run-timescaledb> server # connecting to host... vm-test-run-timescaledb> server: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-timescaledb> server: connected to guest root shell vm-test-run-timescaledb> server: (connecting took 61.36 seconds) vm-test-run-timescaledb> server: (finished: waiting for the VM to finish booting, in 61.36 seconds) vm-test-run-timescaledb> server # [ 60.938781] dhcpcd[750]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 60.955438] dhcpcd[750]: eth0: Router Advertisement from fe80::2 vm-test-run-timescaledb> server # [ 60.980413] dhcpcd[750]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-timescaledb> server # [ 60.982454] dhcpcd[750]: eth0: adding route to fec0::/64 vm-test-run-timescaledb> server # [ 60.996852] dhcpcd[750]: eth0: adding default route via fe80::2 vm-test-run-timescaledb> server # [ 62.988902] (udev-worker)[803]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 63.015350] (udev-worker)[813]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-timescaledb> server # [ 63.025243] (udev-worker)[813]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-timescaledb> server # [ 63.710542] dhcpcd[750]: eth0: IAID 00:12:34:56 vm-test-run-timescaledb> server # [ 63.756280] systemd[1]: Found device Virtio network device. vm-test-run-timescaledb> server # [ 63.813507] dhcpcd[750]: eth0: soliciting an IPv6 router vm-test-run-timescaledb> server # [ 63.829330] systemd[1]: Starting Address configuration of eth1... vm-test-run-timescaledb> server # [ 64.862511] dhcpcd[750]: eth0: soliciting a DHCP lease vm-test-run-timescaledb> server # [ 64.880787] dhcpcd[750]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-timescaledb> server # [ 64.886570] dhcpcd[750]: eth0: probing address 10.0.2.15/24 vm-test-run-timescaledb> server # [ 65.161760] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-timescaledb> server # [ 65.226153] network-addresses-eth1-start[833]: adding address 192.168.1.1/24... done vm-test-run-timescaledb> server # [ 65.322296] dhcpcd[750]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-timescaledb> server # [ 65.330116] dhcpcd[750]: eth0: adding route to 10.0.2.0/24 vm-test-run-timescaledb> server # [ 65.341087] dhcpcd[750]: eth0: adding default route via 10.0.2.2 vm-test-run-timescaledb> server # [ 65.461433] network-addresses-eth1-start[833]: adding address 2001:db8:1::1/64... done vm-test-run-timescaledb> server # [ 65.787013] systemd[1]: Finished Address configuration of eth1. vm-test-run-timescaledb> server # [ 65.816317] systemd[1]: Starting Networking Setup... vm-test-run-timescaledb> server # [ 68.843291] systemd[1]: Started DHCP Client. vm-test-run-timescaledb> server # [ 71.522804] systemd[1]: Finished Networking Setup. vm-test-run-timescaledb> server # [ 71.538554] systemd[1]: Reached target Network. vm-test-run-timescaledb> server # [ 71.590020] systemd[1]: Starting PostgreSQL Database Server... vm-test-run-timescaledb> server # [ 71.657293] systemd[1]: Starting Permit User Sessions... vm-test-run-timescaledb> server # [ 72.361806] systemd[1]: Finished Permit User Sessions. vm-test-run-timescaledb> server # [ 72.435236] systemd[1]: Started Getty on tty1. vm-test-run-timescaledb> server # [ 72.441794] systemd[1]: Reached target Login Prompts. vm-test-run-timescaledb> server # [ 73.162089] systemd-logind[657]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-timescaledb> server # [ 73.335295] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1035]: Initializing database at /var/lib/postgresql/data vm-test-run-timescaledb> server # [ 75.170597] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: The files belonging to this database system will be owned by user "postgres". vm-test-run-timescaledb> server # [ 75.186065] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: This user must also own the server process. vm-test-run-timescaledb> server # [ 75.264888] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: The database cluster will be initialized with locale "en_US.UTF-8". vm-test-run-timescaledb> server # [ 75.266624] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: The default database encoding has accordingly been set to "UTF8". vm-test-run-timescaledb> server # [ 75.271069] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: The default text search configuration will be set to "english". vm-test-run-timescaledb> server # [ 75.277801] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: Data page checksums are enabled. vm-test-run-timescaledb> server # [ 75.279233] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: fixing permissions on existing directory /var/lib/postgresql/data ... ok vm-test-run-timescaledb> server # [ 75.298721] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: creating subdirectories ... ok vm-test-run-timescaledb> server # [ 75.306871] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: selecting dynamic shared memory implementation ... posix vm-test-run-timescaledb> server # [ 76.503781] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: selecting default max_connections ... 100 vm-test-run-timescaledb> server # [ 77.143897] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: selecting default shared_buffers ... 128MB vm-test-run-timescaledb> server # [ 83.050986] mousedev: PS/2 mouse device common for all mice vm-test-run-timescaledb> server # [ 87.465305] systemd-logind[657]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-timescaledb> server # [ 88.518730] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: selecting default time zone ... UTC vm-test-run-timescaledb> server # [ 88.556507] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: creating configuration files ... ok vm-test-run-timescaledb> server # [ 93.811596] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: running bootstrap script ... ok vm-test-run-timescaledb> server # [ 108.697987] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: performing post-bootstrap initialization ... ok vm-test-run-timescaledb> server # [ 111.606271] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: syncing data to disk ... ok vm-test-run-timescaledb> server # [ 111.614091] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: initdb: warning: enabling "trust" authentication for local connections vm-test-run-timescaledb> server # [ 111.627077] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: 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 # [ 111.641546] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: Success. You can now start the database server using: vm-test-run-timescaledb> server # [ 111.642609] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1039]: /nix/store/2jmk0ipjl6m8ckpzhqyax62hqwcvkfyh-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start vm-test-run-timescaledb> server # [ 113.397743] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1035]: Validating PostgreSQL configuration... vm-test-run-timescaledb> server # [ 113.790943] bhawzfz2k1f6wx424afaa47fbk9av576-postgresql-init[1429]: 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 # [ 114.815166] postgres[1431]: 2026-10-07 14:22:55.388 UTC [1431] LOG: pgaudit extension initialized vm-test-run-timescaledb> server # [ 115.936032] postgres[1431]: 2026-10-07 14:22:56.527 UTC [1431] LOG: pgsodium primary server secret key loaded vm-test-run-timescaledb> server # [ 116.639428] postgres[1431]: 2026-10-07 14:22:57.234 UTC [1431] LOG: vault primary server secret key loaded vm-test-run-timescaledb> server # [ 117.010976] postgres[1431]: 2026-10-07 14:22:57.594 UTC [1431] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit vm-test-run-timescaledb> server # [ 117.013599] postgres[1431]: 2026-10-07 14:22:57.607 UTC [1431] LOG: listening on IPv4 address "0.0.0.0", port 5432 vm-test-run-timescaledb> server # [ 117.020050] postgres[1431]: 2026-10-07 14:22:57.614 UTC [1431] LOG: listening on IPv6 address "::", port 5432 vm-test-run-timescaledb> server # [ 117.038876] postgres[1431]: 2026-10-07 14:22:57.633 UTC [1431] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432" vm-test-run-timescaledb> server # [ 117.193737] postgres[1467]: 2026-10-07 14:22:57.779 UTC [1467] LOG: database system was shut down at 2026-10-07 14:22:49 UTC vm-test-run-timescaledb> server # [ 117.527252] postgres[1473]: 2026-10-07 14:22:58.114 UTC [1473] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 117.625468] postgres[1431]: 2026-10-07 14:22:58.218 UTC [1431] LOG: database system is ready to accept connections vm-test-run-timescaledb> server # [ 117.691475] postgres[1471]: 2026-10-07 14:22:58.273 UTC [1471] LOG: TimescaleDB background worker launcher connected to shared catalogs vm-test-run-timescaledb> server # [ 117.766359] systemd[1]: Started PostgreSQL Database Server. vm-test-run-timescaledb> server # [ 117.821356] systemd[1]: Starting Supabase Database Initialization... vm-test-run-timescaledb> server # [ 117.895303] postgres[1431]: 2026-10-07 14:22:58.488 UTC [1431] LOG: background worker "pg_net 0.20.4 worker" (PID 1473) exited with exit code 1 vm-test-run-timescaledb> server # [ 118.209198] postgres[1474]: 2026-10-07 14:22:58.796 UTC [1474] LOG: pg_cron scheduler started vm-test-run-timescaledb> server # [ 118.420318] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Waiting for PostgreSQL to be ready... vm-test-run-timescaledb> server # [ 118.978018] postgres[1492]: 2026-10-07 14:22:59.537 UTC [1492] FATAL: role "postgres" does not exist vm-test-run-timescaledb> server # [ 119.075587] postgres[1431]: 2026-10-07 14:22:59.665 UTC [1431] LOG: background worker "pg_net 0.20.4 worker" (PID 1492) exited with exit code 1 vm-test-run-timescaledb> server # [ 119.123387] postgres[1493]: ::1 2026-10-07 14:22:59.713 UTC [1493] root@root FATAL: role "root" does not exist vm-test-run-timescaledb> server # [ 119.179488] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: PostgreSQL is ready vm-test-run-timescaledb> server # [ 119.194381] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Creating postgres role... vm-test-run-timescaledb> server # [ 119.803389] postgres[1506]: ::1 2026-10-07 14:23:00.381 UTC [1506] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN; vm-test-run-timescaledb> server # [ 119.889155] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1498]: CREATE ROLE vm-test-run-timescaledb> server # [ 120.339860] postgres[1510]: ::1 2026-10-07 14:23:00.924 UTC [1510] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres; vm-test-run-timescaledb> server # [ 120.378616] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1508]: ALTER DATABASE vm-test-run-timescaledb> server # [ 120.434320] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000000-initial-schema.sql vm-test-run-timescaledb> server # [ 120.683148] postgres[1512]: ::1 2026-10-07 14:23:01.266 UTC [1512] postgres@postgres LOG: statement: create publication supabase_realtime; vm-test-run-timescaledb> server # [ 120.698475] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: CREATE PUBLICATION vm-test-run-timescaledb> server # [ 120.699632] postgres[1512]: ::1 2026-10-07 14:23:01.288 UTC [1512] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls; vm-test-run-timescaledb> server # [ 120.706588] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: ALTER ROLE vm-test-run-timescaledb> server # [ 120.718461] postgres[1512]: ::1 2026-10-07 14:23:01.305 UTC [1512] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication; vm-test-run-timescaledb> server # [ 120.721502] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: CREATE ROLE vm-test-run-timescaledb> server # [ 120.722085] postgres[1512]: ::1 2026-10-07 14:23:01.316 UTC [1512] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls; vm-test-run-timescaledb> server # [ 120.731127] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: CREATE ROLE vm-test-run-timescaledb> server # [ 120.737697] postgres[1512]: ::1 2026-10-07 14:23:01.330 UTC [1512] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin; vm-test-run-timescaledb> server # [ 120.750429] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: GRANT ROLE vm-test-run-timescaledb> server # [ 120.754918] postgres[1512]: ::1 2026-10-07 14:23:01.346 UTC [1512] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin; vm-test-run-timescaledb> server # [ 120.764030] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 120.767085] postgres[1512]: ::1 2026-10-07 14:23:01.358 UTC [1512] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls; vm-test-run-timescaledb> server # [ 120.777671] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: CREATE ROLE vm-test-run-timescaledb> server # [ 120.781779] postgres[1512]: ::1 2026-10-07 14:23:01.375 UTC [1512] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user; vm-test-run-timescaledb> server # [ 120.793985] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: GRANT ROLE vm-test-run-timescaledb> server # [ 120.795298] postgres[1512]: ::1 2026-10-07 14:23:01.384 UTC [1512] postgres@postgres LOG: statement: create schema if not exists extensions; vm-test-run-timescaledb> server # [ 120.803238] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 120.806887] postgres[1512]: ::1 2026-10-07 14:23:01.400 UTC [1512] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions; vm-test-run-timescaledb> server # [ 123.670415] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 123.687486] postgres[1512]: ::1 2026-10-07 14:23:04.244 UTC [1512] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions; vm-test-run-timescaledb> server # [ 124.714066] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 124.717685] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: CREATE ROLE vm-test-run-timescaledb> server # [ 124.722476] postgres[1512]: ::1 2026-10-07 14:23:05.300 UTC [1512] postgres@postgres LOG: statement: create role anon nologin noinherit; vm-test-run-timescaledb> server # [ 124.729775] postgres[1512]: ::1 2026-10-07 14:23:05.314 UTC [1512] postgres@postgres LOG: statement: create role authenticated nologin noinherit; vm-test-run-timescaledb> server # [ 124.735740] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: CREATE ROLE vm-test-run-timescaledb> server # [ 124.739216] postgres[1512]: ::1 2026-10-07 14:23:05.330 UTC [1512] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls; vm-test-run-timescaledb> server # [ 124.749877] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: CREATE ROLE vm-test-run-timescaledb> server # [ 124.751820] postgres[1512]: ::1 2026-10-07 14:23:05.344 UTC [1512] postgres@postgres LOG: statement: create user authenticator noinherit; vm-test-run-timescaledb> server # [ 124.758607] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: CREATE ROLE vm-test-run-timescaledb> server # [ 124.764805] postgres[1512]: ::1 2026-10-07 14:23:05.357 UTC [1512] postgres@postgres LOG: statement: grant anon to authenticator; vm-test-run-timescaledb> server # [ 124.771900] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: GRANT ROLE vm-test-run-timescaledb> server # [ 124.776842] postgres[1512]: ::1 2026-10-07 14:23:05.371 UTC [1512] postgres@postgres LOG: statement: grant authenticated to authenticator; vm-test-run-timescaledb> server # [ 124.785959] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: GRANT ROLE vm-test-run-timescaledb> server # [ 124.791324] postgres[1512]: ::1 2026-10-07 14:23:05.384 UTC [1512] postgres@postgres LOG: statement: grant service_role to authenticator; vm-test-run-timescaledb> server # [ 124.806630] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: GRANT ROLE vm-test-run-timescaledb> server # [ 124.812816] postgres[1512]: ::1 2026-10-07 14:23:05.405 UTC [1512] postgres@postgres LOG: statement: grant supabase_admin to authenticator; vm-test-run-timescaledb> server # [ 124.818817] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: GRANT ROLE vm-test-run-timescaledb> server # [ 124.823579] postgres[1512]: ::1 2026-10-07 14:23:05.418 UTC [1512] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.835944] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 124.839438] postgres[1512]: ::1 2026-10-07 14:23:05.431 UTC [1512] 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 # [ 124.856895] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.863865] postgres[1512]: ::1 2026-10-07 14:23:05.455 UTC [1512] 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 # [ 124.875961] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.879832] postgres[1512]: ::1 2026-10-07 14:23:05.474 UTC [1512] 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 # [ 124.895936] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.899188] postgres[1512]: ::1 2026-10-07 14:23:05.493 UTC [1512] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.909894] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: GRANT vm-test-run-timescaledb> server # [ 124.917840] postgres[1512]: ::1 2026-10-07 14:23:05.512 UTC [1512] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions; vm-test-run-timescaledb> server # [ 124.929088] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: ALTER ROLE vm-test-run-timescaledb> server # [ 124.935085] postgres[1512]: ::1 2026-10-07 14:23:05.527 UTC [1512] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 124.939818] postgres[1512]: on sequences to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.947881] postgres[1512]: ::1 2026-10-07 14:23:05.536 UTC [1512] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 124.948857] postgres[1512]: on tables to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.949421] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.965914] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.971784] postgres[1512]: ::1 2026-10-07 14:23:05.556 UTC [1512] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all vm-test-run-timescaledb> server # [ 124.978345] postgres[1512]: on functions to postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 124.997083] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 124.998077] postgres[1512]: ::1 2026-10-07 14:23:05.592 UTC [1512] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s'; vm-test-run-timescaledb> server # [ 125.016065] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: ALTER ROLE vm-test-run-timescaledb> server # [ 125.025512] postgres[1512]: ::1 2026-10-07 14:23:05.614 UTC [1512] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s'; vm-test-run-timescaledb> server # [ 125.033024] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1511]: ALTER ROLE vm-test-run-timescaledb> server # [ 125.102044] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000001-auth-schema.sql vm-test-run-timescaledb> server # [ 125.544232] postgres[1553]: ::1 2026-10-07 14:23:06.121 UTC [1553] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 125.581158] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 125.583419] postgres[1553]: ::1 2026-10-07 14:23:06.164 UTC [1553] postgres@postgres LOG: statement: CREATE TABLE auth.users ( vm-test-run-timescaledb> server # [ 125.593489] postgres[1553]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 125.594200] postgres[1553]: id uuid NOT NULL UNIQUE, vm-test-run-timescaledb> server # [ 125.594770] postgres[1553]: aud varchar(255) NULL, vm-test-run-timescaledb> server # [ 125.595775] postgres[1553]: "role" varchar(255) NULL, vm-test-run-timescaledb> server # [ 125.601428] postgres[1553]: email varchar(255) NULL UNIQUE, vm-test-run-timescaledb> server # [ 125.603073] postgres[1553]: encrypted_password varchar(255) NULL, vm-test-run-timescaledb> server # [ 125.609970] postgres[1553]: confirmed_at timestamptz NULL, vm-test-run-timescaledb> server # [ 125.611039] postgres[1553]: invited_at timestamptz NULL, vm-test-run-timescaledb> server # [ 125.611527] postgres[1553]: confirmation_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 125.616933] postgres[1553]: confirmation_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 125.619729] postgres[1553]: recovery_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 125.627939] postgres[1553]: recovery_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 125.635225] postgres[1553]: email_change_token varchar(255) NULL, vm-test-run-timescaledb> server # [ 125.642190] postgres[1553]: email_change varchar(255) NULL, vm-test-run-timescaledb> server # [ 125.642973] postgres[1553]: email_change_sent_at timestamptz NULL, vm-test-run-timescaledb> server # [ 125.643428] postgres[1553]: last_sign_in_at timestamptz NULL, vm-test-run-timescaledb> server # [ 125.643835] postgres[1553]: raw_app_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 125.649162] postgres[1553]: raw_user_meta_data jsonb NULL, vm-test-run-timescaledb> server # [ 125.650120] postgres[1553]: is_super_admin bool NULL, vm-test-run-timescaledb> server # [ 125.650575] postgres[1553]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 125.651098] postgres[1553]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 125.652019] postgres[1553]: CONSTRAINT users_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 125.661401] postgres[1553]: ); vm-test-run-timescaledb> server # [ 125.825800] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE TABLE vm-test-run-timescaledb> server # [ 125.837644] postgres[1553]: ::1 2026-10-07 14:23:06.428 UTC [1553] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email); vm-test-run-timescaledb> server # [ 125.951535] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE INDEX vm-test-run-timescaledb> server # [ 125.961384] postgres[1553]: ::1 2026-10-07 14:23:06.552 UTC [1553] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id); vm-test-run-timescaledb> server # [ 126.045646] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE INDEX vm-test-run-timescaledb> server # [ 126.089164] postgres[1553]: ::1 2026-10-07 14:23:06.637 UTC [1553] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.'; vm-test-run-timescaledb> server # [ 126.090242] postgres[1553]: ::1 2026-10-07 14:23:06.680 UTC [1553] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens ( vm-test-run-timescaledb> server # [ 126.105064] postgres[1553]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 126.108205] postgres[1553]: id bigserial NOT NULL, vm-test-run-timescaledb> server # [ 126.125465] postgres[1553]: "token" varchar(255) NULL, vm-test-run-timescaledb> server # [ 126.126075] postgres[1553]: user_id varchar(255) NULL, vm-test-run-timescaledb> server # [ 126.127209] postgres[1553]: revoked bool NULL, vm-test-run-timescaledb> server # [ 126.145359] postgres[1553]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 126.146278] postgres[1553]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 126.147145] postgres[1553]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 126.148171] postgres[1553]: ); vm-test-run-timescaledb> server # [ 126.178492] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: COMMENT vm-test-run-timescaledb> server # [ 126.247819] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE TABLE vm-test-run-timescaledb> server # [ 126.256927] postgres[1553]: ::1 2026-10-07 14:23:06.843 UTC [1553] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id); vm-test-run-timescaledb> server # [ 126.345169] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE INDEX vm-test-run-timescaledb> server # [ 126.346097] postgres[1553]: ::1 2026-10-07 14:23:06.932 UTC [1553] 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 # [ 126.389348] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE INDEX vm-test-run-timescaledb> server # [ 126.413857] postgres[1553]: ::1 2026-10-07 14:23:06.983 UTC [1553] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token); vm-test-run-timescaledb> server # [ 126.459402] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE INDEX vm-test-run-timescaledb> server # [ 126.469227] postgres[1553]: ::1 2026-10-07 14:23:07.058 UTC [1553] 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 # [ 126.492637] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: COMMENT vm-test-run-timescaledb> server # [ 126.495021] postgres[1553]: ::1 2026-10-07 14:23:07.086 UTC [1553] postgres@postgres LOG: statement: CREATE TABLE auth.instances ( vm-test-run-timescaledb> server # [ 126.496091] postgres[1553]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 126.503437] postgres[1553]: uuid uuid NULL, vm-test-run-timescaledb> server # [ 126.513545] postgres[1553]: raw_base_config text NULL, vm-test-run-timescaledb> server # [ 126.514946] postgres[1553]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 126.515458] postgres[1553]: updated_at timestamptz NULL, vm-test-run-timescaledb> server # [ 126.529086] postgres[1553]: CONSTRAINT instances_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 126.554152] postgres[1553]: ); vm-test-run-timescaledb> server # [ 126.618794] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE TABLE vm-test-run-timescaledb> server # [ 126.620364] postgres[1553]: ::1 2026-10-07 14:23:07.205 UTC [1553] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.'; vm-test-run-timescaledb> server # [ 126.622803] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: COMMENT vm-test-run-timescaledb> server # [ 126.626426] postgres[1553]: ::1 2026-10-07 14:23:07.221 UTC [1553] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries ( vm-test-run-timescaledb> server # [ 126.633775] postgres[1553]: instance_id uuid NULL, vm-test-run-timescaledb> server # [ 126.634878] postgres[1553]: id uuid NOT NULL, vm-test-run-timescaledb> server # [ 126.635537] postgres[1553]: payload json NULL, vm-test-run-timescaledb> server # [ 126.641781] postgres[1553]: created_at timestamptz NULL, vm-test-run-timescaledb> server # [ 126.648006] postgres[1553]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id) vm-test-run-timescaledb> server # [ 126.650747] postgres[1553]: ); vm-test-run-timescaledb> server # [ 126.699992] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE TABLE vm-test-run-timescaledb> server # [ 126.702321] postgres[1553]: ::1 2026-10-07 14:23:07.297 UTC [1553] 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 # [ 126.735903] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE INDEX vm-test-run-timescaledb> server # [ 126.745869] postgres[1553]: ::1 2026-10-07 14:23:07.335 UTC [1553] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.'; vm-test-run-timescaledb> server # [ 126.754112] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: COMMENT vm-test-run-timescaledb> server # [ 126.758421] postgres[1553]: ::1 2026-10-07 14:23:07.351 UTC [1553] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations ( vm-test-run-timescaledb> server # [ 126.759991] postgres[1553]: "version" varchar(255) NOT NULL, vm-test-run-timescaledb> server # [ 126.761945] postgres[1553]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version") vm-test-run-timescaledb> server # [ 126.762843] postgres[1553]: ); vm-test-run-timescaledb> server # [ 126.803608] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE TABLE vm-test-run-timescaledb> server # [ 126.805348] postgres[1553]: ::1 2026-10-07 14:23:07.398 UTC [1553] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.'; vm-test-run-timescaledb> server # [ 126.817983] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: COMMENT vm-test-run-timescaledb> server # [ 126.846956] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: INSERT 0 7 vm-test-run-timescaledb> server # [ 126.854142] postgres[1553]: ::1 2026-10-07 14:23:07.444 UTC [1553] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$ vm-test-run-timescaledb> server # [ 126.855361] postgres[1553]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid; vm-test-run-timescaledb> server # [ 126.859515] postgres[1553]: $$ language sql stable; vm-test-run-timescaledb> server # [ 126.866304] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.871380] postgres[1553]: ::1 2026-10-07 14:23:07.463 UTC [1553] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$ vm-test-run-timescaledb> server # [ 126.878916] postgres[1553]: select nullif(current_setting('request.jwt.claim.role', true), '')::text; vm-test-run-timescaledb> server # [ 126.884179] postgres[1553]: $$ language sql stable; vm-test-run-timescaledb> server # [ 126.887019] postgres[1553]: ::1 2026-10-07 14:23:07.481 UTC [1553] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$ vm-test-run-timescaledb> server # [ 126.887999] postgres[1553]: select nullif(current_setting('request.jwt.claim.email', true), '')::text; vm-test-run-timescaledb> server # [ 126.895137] postgres[1553]: $$ language sql stable; vm-test-run-timescaledb> server # [ 126.896029] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.909460] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 126.911080] postgres[1553]: ::1 2026-10-07 14:23:07.497 UTC [1553] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 126.915216] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: GRANT vm-test-run-timescaledb> server # [ 126.919138] postgres[1553]: ::1 2026-10-07 14:23:07.506 UTC [1553] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 126.929867] postgres[1553]: ::1 2026-10-07 14:23:07.517 UTC [1553] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 126.940710] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: CREATE ROLE vm-test-run-timescaledb> server # [ 126.943397] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: GRANT vm-test-run-timescaledb> server # [ 126.947511] postgres[1553]: ::1 2026-10-07 14:23:07.540 UTC [1553] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 126.968078] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: GRANT vm-test-run-timescaledb> server # [ 126.970410] postgres[1553]: ::1 2026-10-07 14:23:07.564 UTC [1553] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 126.979356] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: GRANT vm-test-run-timescaledb> server # [ 126.983879] postgres[1553]: ::1 2026-10-07 14:23:07.578 UTC [1553] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth"; vm-test-run-timescaledb> server # [ 126.996128] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: ALTER ROLE vm-test-run-timescaledb> server # [ 126.998824] postgres[1553]: ::1 2026-10-07 14:23:07.593 UTC [1553] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 127.013815] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: ALTER TABLE vm-test-run-timescaledb> server # [ 127.017116] postgres[1553]: ::1 2026-10-07 14:23:07.612 UTC [1553] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 127.030733] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: ALTER TABLE vm-test-run-timescaledb> server # [ 127.033228] postgres[1553]: ::1 2026-10-07 14:23:07.627 UTC [1553] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 127.045893] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: ALTER TABLE vm-test-run-timescaledb> server # [ 127.049213] postgres[1553]: ::1 2026-10-07 14:23:07.642 UTC [1553] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 127.061406] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: ALTER TABLE vm-test-run-timescaledb> server # [ 127.063895] postgres[1553]: ::1 2026-10-07 14:23:07.658 UTC [1553] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 127.074743] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1544]: ALTER TABLE vm-test-run-timescaledb> server # [ 127.138675] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000002-storage-schema.sql vm-test-run-timescaledb> server # [ 127.500582] postgres[1568]: ::1 2026-10-07 14:23:08.077 UTC [1568] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin; vm-test-run-timescaledb> server # [ 127.530336] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1567]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 127.532404] postgres[1568]: ::1 2026-10-07 14:23:08.110 UTC [1568] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 127.556420] postgres[1568]: ::1 2026-10-07 14:23:08.123 UTC [1568] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage"; vm-test-run-timescaledb> server # [ 127.570865] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1567]: CREATE ROLE vm-test-run-timescaledb> server # [ 127.572964] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1567]: ALTER ROLE vm-test-run-timescaledb> server # [ 127.579949] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1567]: GRANT vm-test-run-timescaledb> server # [ 127.581457] postgres[1568]: ::1 2026-10-07 14:23:08.134 UTC [1568] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin; vm-test-run-timescaledb> server # [ 127.624858] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1567]: DO vm-test-run-timescaledb> server # [ 127.691828] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000003-post-setup.sql vm-test-run-timescaledb> server # [ 128.080830] postgres[1574]: ::1 2026-10-07 14:23:08.657 UTC [1574] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions; vm-test-run-timescaledb> server # [ 128.098401] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.108006] postgres[1574]: ::1 2026-10-07 14:23:08.685 UTC [1574] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions; vm-test-run-timescaledb> server # [ 128.110867] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: ALTER ROLE vm-test-run-timescaledb> server # [ 128.117100] postgres[1574]: ::1 2026-10-07 14:23:08.708 UTC [1574] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() vm-test-run-timescaledb> server # [ 128.119048] postgres[1574]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 128.130096] postgres[1574]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 128.131013] postgres[1574]: AS $$ vm-test-run-timescaledb> server # [ 128.131964] postgres[1574]: DECLARE vm-test-run-timescaledb> server # [ 128.133692] postgres[1574]: schema_is_cron bool; vm-test-run-timescaledb> server # [ 128.138797] postgres[1574]: BEGIN vm-test-run-timescaledb> server # [ 128.145915] postgres[1574]: schema_is_cron = ( vm-test-run-timescaledb> server # [ 128.148268] postgres[1574]: SELECT n.nspname = 'cron' vm-test-run-timescaledb> server # [ 128.157378] postgres[1574]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 128.161042] postgres[1574]: LEFT JOIN pg_catalog.pg_namespace AS n vm-test-run-timescaledb> server # [ 128.162768] postgres[1574]: ON ev.objid = n.oid vm-test-run-timescaledb> server # [ 128.163503] postgres[1574]: ); vm-test-run-timescaledb> server # [ 128.164150] postgres[1574]: vm-test-run-timescaledb> server # [ 128.172349] postgres[1574]: IF schema_is_cron vm-test-run-timescaledb> server # [ 128.173278] postgres[1574]: THEN vm-test-run-timescaledb> server # [ 128.173742] postgres[1574]: grant usage on schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 128.174079] postgres[1574]: vm-test-run-timescaledb> server # [ 128.174831] postgres[1574]: alter default privileges in schema cron grant all on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 128.175904] postgres[1574]: alter default privileges in schema cron grant all on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 128.185070] postgres[1574]: alter default privileges in schema cron grant all on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 128.186855] postgres[1574]: vm-test-run-timescaledb> server # [ 128.187165] postgres[1574]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 128.187442] postgres[1574]: on sequences to postgres with grant option; vm-test-run-timescaledb> server # [ 128.187737] postgres[1574]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 128.188031] postgres[1574]: on tables to postgres with grant option; vm-test-run-timescaledb> server # [ 128.193803] postgres[1574]: alter default privileges for user supabase_admin in schema cron grant all vm-test-run-timescaledb> server # [ 128.194401] postgres[1574]: on functions to postgres with grant option; vm-test-run-timescaledb> server # [ 128.201637] postgres[1574]: vm-test-run-timescaledb> server # [ 128.202484] postgres[1574]: grant all privileges on all tables in schema cron to postgres with grant option; vm-test-run-timescaledb> server # [ 128.203441] postgres[1574]: vm-test-run-timescaledb> server # [ 128.203952] postgres[1574]: END IF; vm-test-run-timescaledb> server # [ 128.209592] postgres[1574]: vm-test-run-timescaledb> server # [ 128.210858] postgres[1574]: END; vm-test-run-timescaledb> server # [ 128.219802] postgres[1574]: $$; vm-test-run-timescaledb> server # [ 128.222527] postgres[1574]: ::1 2026-10-07 14:23:08.748 UTC [1574] 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 # [ 128.230380] postgres[1574]: EXECUTE PROCEDURE extensions.grant_pg_cron_access(); vm-test-run-timescaledb> server # [ 128.231442] postgres[1574]: ::1 2026-10-07 14:23:08.777 UTC [1574] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron'; vm-test-run-timescaledb> server # [ 128.232985] postgres[1574]: ::1 2026-10-07 14:23:08.793 UTC [1574] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access() vm-test-run-timescaledb> server # [ 128.233826] postgres[1574]: RETURNS event_trigger vm-test-run-timescaledb> server # [ 128.234445] postgres[1574]: LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 128.236528] postgres[1574]: AS $$ vm-test-run-timescaledb> server # [ 128.237234] postgres[1574]: BEGIN vm-test-run-timescaledb> server # [ 128.237505] postgres[1574]: IF EXISTS ( vm-test-run-timescaledb> server # [ 128.237817] postgres[1574]: SELECT 1 vm-test-run-timescaledb> server # [ 128.238724] postgres[1574]: FROM pg_event_trigger_ddl_commands() AS ev vm-test-run-timescaledb> server # [ 128.239496] postgres[1574]: JOIN pg_extension AS ext vm-test-run-timescaledb> server # [ 128.240432] postgres[1574]: ON ev.objid = ext.oid vm-test-run-timescaledb> server # [ 128.241264] postgres[1574]: WHERE ext.extname = 'pg_net' vm-test-run-timescaledb> server # [ 128.242283] postgres[1574]: ) vm-test-run-timescaledb> server # [ 128.242858] postgres[1574]: THEN vm-test-run-timescaledb> server # [ 128.243566] postgres[1574]: IF NOT EXISTS ( vm-test-run-timescaledb> server # [ 128.245204] postgres[1574]: SELECT 1 vm-test-run-timescaledb> server # [ 128.245543] postgres[1574]: FROM pg_roles vm-test-run-timescaledb> server # [ 128.246072] postgres[1574]: WHERE rolname = 'supabase_functions_admin' vm-test-run-timescaledb> server # [ 128.246671] postgres[1574]: ) vm-test-run-timescaledb> server # [ 128.247289] postgres[1574]: THEN vm-test-run-timescaledb> server # [ 128.248986] postgres[1574]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION; vm-test-run-timescaledb> server # [ 128.249638] postgres[1574]: END IF; vm-test-run-timescaledb> server # [ 128.249914] postgres[1574]: vm-test-run-timescaledb> server # [ 128.250161] postgres[1574]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role; vm-test-run-timescaledb> server # [ 128.251293] postgres[1574]: vm-test-run-timescaledb> server # [ 128.251556] postgres[1574]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 128.252669] postgres[1574]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER; vm-test-run-timescaledb> server # [ 128.254261] postgres[1574]: vm-test-run-timescaledb> server # [ 128.254616] postgres[1574]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net; vm-test-run-timescaledb> server # [ 128.256973] postgres[1574]: 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 # [ 128.258753] postgres[1574]: vm-test-run-timescaledb> server # [ 128.259139] postgres[1574]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC; vm-test-run-timescaledb> server # [ 128.260806] postgres[1574]: 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 # [ 128.261757] postgres[1574]: vm-test-run-timescaledb> server # [ 128.263225] postgres[1574]: 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 # [ 128.265600] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 128.266301] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: CREATE EVENT TRIGGER vm-test-run-timescaledb> server # [ 128.268151] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: COMMENT vm-test-run-timescaledb> server # [ 128.269310] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 128.269929] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: COMMENT vm-test-run-timescaledb> server # [ 128.270445] postgres[1574]: 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 # [ 128.271223] postgres[1574]: END IF; vm-test-run-timescaledb> server # [ 128.271519] postgres[1574]: END; vm-test-run-timescaledb> server # [ 128.271923] postgres[1574]: $$; vm-test-run-timescaledb> server # [ 128.272251] postgres[1574]: ::1 2026-10-07 14:23:08.810 UTC [1574] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net'; vm-test-run-timescaledb> server # [ 128.291890] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: DO vm-test-run-timescaledb> server # [ 128.293264] postgres[1574]: ::1 2026-10-07 14:23:08.884 UTC [1574] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION; vm-test-run-timescaledb> server # [ 128.304151] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: CREATE ROLE vm-test-run-timescaledb> server # [ 128.305689] postgres[1574]: ::1 2026-10-07 14:23:08.896 UTC [1574] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user; vm-test-run-timescaledb> server # [ 128.322403] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: GRANT vm-test-run-timescaledb> server # [ 128.341611] postgres[1574]: ::1 2026-10-07 14:23:08.932 UTC [1574] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 128.364853] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: GRANT vm-test-run-timescaledb> server # [ 128.377274] postgres[1574]: ::1 2026-10-07 14:23:08.965 UTC [1574] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 128.391068] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: GRANT vm-test-run-timescaledb> server # [ 128.405686] postgres[1574]: ::1 2026-10-07 14:23:08.992 UTC [1574] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 128.429601] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: GRANT vm-test-run-timescaledb> server # [ 128.437987] postgres[1574]: ::1 2026-10-07 14:23:09.028 UTC [1574] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 128.451293] postgres[1574]: ::1 2026-10-07 14:23:09.042 UTC [1574] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 128.458697] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: GRANT vm-test-run-timescaledb> server # [ 128.474463] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: GRANT vm-test-run-timescaledb> server # [ 128.485170] postgres[1574]: ::1 2026-10-07 14:23:09.067 UTC [1574] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 128.486296] postgres[1574]: ::1 2026-10-07 14:23:09.076 UTC [1574] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user; vm-test-run-timescaledb> server # [ 128.488057] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: GRANT vm-test-run-timescaledb> server # [ 128.537601] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: GRANT vm-test-run-timescaledb> server # [ 128.544658] postgres[1574]: ::1 2026-10-07 14:23:09.135 UTC [1574] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user; vm-test-run-timescaledb> server # [ 128.645472] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: GRANT vm-test-run-timescaledb> server # [ 128.674738] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1573]: DO vm-test-run-timescaledb> server # [ 128.748718] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running pgbouncer auth schema... vm-test-run-timescaledb> server # [ 129.166936] postgres[1590]: ::1 2026-10-07 14:23:09.752 UTC [1590] postgres@postgres LOG: statement: CREATE USER pgbouncer; vm-test-run-timescaledb> server # [ 129.184009] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1584]: CREATE ROLE vm-test-run-timescaledb> server # [ 129.194812] postgres[1590]: ::1 2026-10-07 14:23:09.774 UTC [1590] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer; vm-test-run-timescaledb> server # [ 129.201523] postgres[1590]: ::1 2026-10-07 14:23:09.793 UTC [1590] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer; vm-test-run-timescaledb> server # [ 129.204038] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1584]: REVOKE vm-test-run-timescaledb> server # [ 129.288779] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1584]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 129.300622] postgres[1590]: ::1 2026-10-07 14:23:09.890 UTC [1590] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT) vm-test-run-timescaledb> server # [ 129.303679] postgres[1590]: RETURNS TABLE(username TEXT, password TEXT) AS vm-test-run-timescaledb> server # [ 129.305583] postgres[1590]: $$ vm-test-run-timescaledb> server # [ 129.306377] postgres[1590]: BEGIN vm-test-run-timescaledb> server # [ 129.306984] postgres[1590]: RAISE WARNING 'PgBouncer auth request: %', p_usename; vm-test-run-timescaledb> server # [ 129.307733] postgres[1590]: vm-test-run-timescaledb> server # [ 129.308024] postgres[1590]: RETURN QUERY vm-test-run-timescaledb> server # [ 129.308646] postgres[1590]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow vm-test-run-timescaledb> server # [ 129.309133] postgres[1590]: WHERE usename = p_usename; vm-test-run-timescaledb> server # [ 129.310491] postgres[1590]: END; vm-test-run-timescaledb> server # [ 129.312735] postgres[1590]: $$ LANGUAGE plpgsql vm-test-run-timescaledb> server # [ 129.313180] postgres[1590]: SET search_path = '' vm-test-run-timescaledb> server # [ 129.313579] postgres[1590]: SECURITY DEFINER; vm-test-run-timescaledb> server # [ 129.335476] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1584]: CREATE FUNCTION vm-test-run-timescaledb> server # [ 129.343814] postgres[1590]: ::1 2026-10-07 14:23:09.933 UTC [1590] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC; vm-test-run-timescaledb> server # [ 129.368914] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1584]: REVOKE vm-test-run-timescaledb> server # [ 129.381165] postgres[1590]: ::1 2026-10-07 14:23:09.972 UTC [1590] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer; vm-test-run-timescaledb> server # [ 129.393847] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1584]: GRANT vm-test-run-timescaledb> server # [ 129.472673] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running stat extension... vm-test-run-timescaledb> server # [ 129.910788] postgres[1602]: ::1 2026-10-07 14:23:10.485 UTC [1602] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions; vm-test-run-timescaledb> server # [ 129.926935] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1599]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping vm-test-run-timescaledb> server # [ 129.966604] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1599]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 129.969933] postgres[1602]: ::1 2026-10-07 14:23:10.564 UTC [1602] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions; vm-test-run-timescaledb> server # [ 131.294493] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1599]: CREATE EXTENSION vm-test-run-timescaledb> server # [ 131.330126] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/10000000000000_demote-postgres.sql vm-test-run-timescaledb> server # [ 131.791235] postgres[1609]: ::1 2026-10-07 14:23:12.374 UTC [1609] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres; vm-test-run-timescaledb> server # [ 131.849626] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1603]: GRANT vm-test-run-timescaledb> server # [ 131.856724] postgres[1609]: ::1 2026-10-07 14:23:12.438 UTC [1609] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 131.869475] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1603]: GRANT vm-test-run-timescaledb> server # [ 131.873639] postgres[1609]: ::1 2026-10-07 14:23:12.468 UTC [1609] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 131.893375] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1603]: GRANT vm-test-run-timescaledb> server # [ 131.894741] postgres[1609]: ::1 2026-10-07 14:23:12.486 UTC [1609] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 131.914933] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1603]: GRANT vm-test-run-timescaledb> server # [ 131.921690] postgres[1609]: ::1 2026-10-07 14:23:12.511 UTC [1609] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 131.933409] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1603]: GRANT vm-test-run-timescaledb> server # [ 131.934956] postgres[1609]: ::1 2026-10-07 14:23:12.529 UTC [1609] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 131.946401] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1603]: GRANT vm-test-run-timescaledb> server # [ 131.948973] postgres[1609]: ::1 2026-10-07 14:23:12.541 UTC [1609] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 131.954672] postgres[1609]: ::1 2026-10-07 14:23:12.548 UTC [1609] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 131.961030] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1603]: GRANT vm-test-run-timescaledb> server # [ 131.982895] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1603]: GRANT vm-test-run-timescaledb> server # [ 131.997930] postgres[1609]: ::1 2026-10-07 14:23:12.581 UTC [1609] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres; vm-test-run-timescaledb> server # [ 132.201513] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1603]: GRANT vm-test-run-timescaledb> server # [ 132.331938] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1603]: DO vm-test-run-timescaledb> server # [ 132.339547] postgres[1609]: ::1 2026-10-07 14:23:12.928 UTC [1609] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS; vm-test-run-timescaledb> server # [ 132.360945] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1603]: ALTER ROLE vm-test-run-timescaledb> server # [ 132.489786] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211115181400_update-auth-permissions.sql vm-test-run-timescaledb> server # [ 132.935124] postgres[1628]: ::1 2026-10-07 14:23:13.493 UTC [1628] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 132.968320] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: GRANT vm-test-run-timescaledb> server # [ 132.973227] postgres[1628]: ::1 2026-10-07 14:23:13.541 UTC [1628] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 132.987331] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: GRANT vm-test-run-timescaledb> server # [ 132.990105] postgres[1628]: ::1 2026-10-07 14:23:13.584 UTC [1628] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 133.004809] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: GRANT vm-test-run-timescaledb> server # [ 133.016660] postgres[1628]: ::1 2026-10-07 14:23:13.605 UTC [1628] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 133.026326] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: ALTER TABLE vm-test-run-timescaledb> server # [ 133.031337] postgres[1628]: ::1 2026-10-07 14:23:13.623 UTC [1628] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 133.038977] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: ALTER TABLE vm-test-run-timescaledb> server # [ 133.041789] postgres[1628]: ::1 2026-10-07 14:23:13.636 UTC [1628] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 133.051107] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: ALTER TABLE vm-test-run-timescaledb> server # [ 133.055536] postgres[1628]: ::1 2026-10-07 14:23:13.646 UTC [1628] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 133.063783] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: ALTER TABLE vm-test-run-timescaledb> server # [ 133.069410] postgres[1628]: ::1 2026-10-07 14:23:13.661 UTC [1628] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin; vm-test-run-timescaledb> server # [ 133.076073] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: ALTER TABLE vm-test-run-timescaledb> server # [ 133.082732] postgres[1628]: ::1 2026-10-07 14:23:13.674 UTC [1628] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres; vm-test-run-timescaledb> server # [ 133.094165] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: GRANT vm-test-run-timescaledb> server # [ 133.098147] postgres[1628]: ::1 2026-10-07 14:23:13.693 UTC [1628] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 133.116922] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: GRANT vm-test-run-timescaledb> server # [ 133.118808] postgres[1628]: ::1 2026-10-07 14:23:13.709 UTC [1628] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 133.125740] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: GRANT vm-test-run-timescaledb> server # [ 133.126668] postgres[1628]: ::1 2026-10-07 14:23:13.718 UTC [1628] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 133.137155] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: GRANT vm-test-run-timescaledb> server # [ 133.138411] postgres[1628]: ::1 2026-10-07 14:23:13.729 UTC [1628] 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 # [ 133.144994] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.149265] postgres[1628]: ::1 2026-10-07 14:23:13.742 UTC [1628] 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 # [ 133.159487] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.163523] postgres[1628]: ::1 2026-10-07 14:23:13.756 UTC [1628] 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 # [ 133.174695] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1622]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 133.226219] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211118015519_create-realtime-schema.sql vm-test-run-timescaledb> server # [ 133.511199] postgres[1632]: ::1 2026-10-07 14:23:14.096 UTC [1632] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime; vm-test-run-timescaledb> server # [ 133.534251] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1631]: CREATE SCHEMA vm-test-run-timescaledb> server # [ 133.597216] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211122051245_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 134.016139] postgres[1638]: ::1 2026-10-07 14:23:14.581 UTC [1638] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres; vm-test-run-timescaledb> server # [ 134.022332] postgres[1638]: ::1 2026-10-07 14:23:14.608 UTC [1638] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 134.023683] postgres[1638]: ::1 2026-10-07 14:23:14.614 UTC [1638] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 134.032064] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1634]: GRANT vm-test-run-timescaledb> server # [ 134.041397] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1634]: GRANT vm-test-run-timescaledb> server # [ 134.042650] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1634]: GRANT vm-test-run-timescaledb> server # [ 134.043329] postgres[1638]: ::1 2026-10-07 14:23:14.631 UTC [1638] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user; vm-test-run-timescaledb> server # [ 134.058063] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1634]: GRANT vm-test-run-timescaledb> server # [ 134.114588] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211124212715_update-auth-owner.sql vm-test-run-timescaledb> server # [ 134.568939] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1639]: DO vm-test-run-timescaledb> server # [ 134.582228] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1639]: DO vm-test-run-timescaledb> server # [ 134.593912] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1639]: DO vm-test-run-timescaledb> server # [ 134.643932] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211130151719_update-realtime-permissions.sql vm-test-run-timescaledb> server # [ 135.071633] postgres[1646]: ::1 2026-10-07 14:23:15.637 UTC [1646] 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 # [ 135.116630] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1641]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.121013] postgres[1646]: ::1 2026-10-07 14:23:15.703 UTC [1646] 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 # [ 135.123058] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1641]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.123969] postgres[1646]: ::1 2026-10-07 14:23:15.718 UTC [1646] 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 # [ 135.137000] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1641]: ALTER DEFAULT PRIVILEGES vm-test-run-timescaledb> server # [ 135.202972] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql vm-test-run-timescaledb> server # [ 135.625858] postgres[1658]: ::1 2026-10-07 14:23:16.213 UTC [1658] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate'; vm-test-run-timescaledb> server # [ 135.682562] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1652]: ALTER ROLE vm-test-run-timescaledb> server # [ 135.733398] ak4b9qqqj5hgja8xh4mvwgi0yzg7aa94-supabase-db-init[1476]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql