vm-test-run-timescaledb
checks.aarch64-linux.ext-timescaledb
· build #474
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600 seconds5run the VM test script6additionally exposed symbols:7 server,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11server: starting vm12server # Disk image does not exist, creating the virtualisation disk image...13server # Formatting '/build/vm-state-server/tmp.YhmG3s5ht5', fmt=raw size=107374182414server # mke2fs 1.47.4 (6-Mar-2025)15server # Discarding device blocks: 0/262144 done16server # Creating filesystem with 262144 4k blocks and 65536 inodes17server # Filesystem UUID: e2a328ae-6853-4d60-8ae5-04eb35c416ef18server # Superblock backups stored on blocks:19server # 32768, 98304, 163840, 22937620server # 21server # Allocating group tables: 0/8 done22server # Writing inode tables: 0/8 done23server # Creating journal (8192 blocks): done24server # Writing superblocks and filesystem accounting information: 0/8 done25server # 26server # Virtualisation disk image created.27server # qemu-system-aarch64: Could not access KVM kernel module: No such file or directory28server # qemu-system-aarch64: failed to initialize kvm: No such file or directory29server # qemu-system-aarch64: falling back to tcg30server: QEMU running (pid 13)31(finished: start all VMs, in 0.24 seconds)32server: waiting for unit supabase-db-init.service33server: waiting for the VM to finish booting34server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]35server # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 202636server # [ 0.000000] KASLR enabled37server # [ 0.000000] random: crng init done38server # [ 0.000000] Machine model: linux,dummy-virt39server # [ 0.000000] efi: UEFI not found.40server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT41server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]42server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f6031c0-0x13f60693f]43server # [ 0.000000] Zone ranges:44server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff]45server # [ 0.000000] DMA32 empty46server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff]47server # [ 0.000000] Device empty48server # [ 0.000000] Movable zone start for each node49server # [ 0.000000] Early memory node ranges50server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff]51server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]52server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe00000053server # [ 0.000000] psci: probing for conduit method from DT.54server # [ 0.000000] psci: PSCIv1.1 detected in firmware.55server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs56server # [ 0.000000] psci: Trusted OS migration not required57server # [ 0.000000] psci: SMC Calling Convention v1.058server # [ 0.000000] percpu: Embedded 76 pages/cpu s186520 r8192 d116584 u31129659server # [ 0.000000] Detected PIPT I-cache on CPU060server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)61server # [ 0.000000] CPU features: detected: GICv3 CPU interface62server # [ 0.000000] CPU features: detected: HCRX_EL2 register63server # [ 0.000000] CPU features: detected: Stage-1 Permission Indirection Extension (S1PIE)64server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2)65server # [ 0.000000] CPU features: detected: Spectre-v466server # [ 0.000000] alternatives: applying boot alternatives67server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/98k940gqfarnmsxiry7yqi1w40453j1m-nixos-system-server-test/init regInfo=/nix/store/zri54rd94whqs6rhkh4bxy69132dqgkr-closure-info/registration console=ttyAMA0,115200n8 console=tty068server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/zri54rd94whqs6rhkh4bxy69132dqgkr-closure-info/registration", will be passed to user space.69server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes70server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)71server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)72server # [ 0.000000] software IO TLB: area num 2.73server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)74server # [ 0.000000] Fallback order for Node 0: 075server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 104857676server # [ 0.000000] Policy zone: Normal77server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off78server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=179server # [ 0.000000] allocated 8388608 bytes of page_ext80server # [ 0.000000] ftrace: allocating 74832 entries in 294 pages81server # [ 0.000000] ftrace: allocated 294 pages with 4 groups82server # [ 0.000000] rcu: Hierarchical RCU implementation.83server # [ 0.000000] rcu: RCU event tracing is enabled.84server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2.85server # [ 0.000000] Trampoline variant of Tasks RCU enabled.86server # [ 0.000000] Rude variant of Tasks RCU enabled.87server # [ 0.000000] Tracing variant of Tasks RCU enabled.88server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.89server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=290server # [ 0.000000] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.91server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.92server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.93server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 094server # [ 0.000000] GICv3: 256 SPIs implemented95server # [ 0.000000] GICv3: 0 Extended SPIs implemented96server # [ 0.000000] Root IRQ handler: gic_handle_irq97server # [ 0.000000] GICv3: GICv3 features: 16 PPIs98server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=099server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000100server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]101server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b00000 (indirect, esz 8, psz 64K, shr 1)102server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b10000 (flat, esz 8, psz 64K, shr 1)103server # [ 0.000000] GICv3: using LPI property table @0x0000000100b20000104server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b30000105server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.106server # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns107server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).108server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns109server # [ 0.000039] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns110server # [ 0.005270] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)111server # [ 0.017766] Console: colour dummy device 80x25112server # [ 0.019362] printk: legacy console [tty0] enabled113server # [ 0.025667] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)114server # [ 0.026133] pid_max: default: 32768 minimum: 301115server # [ 0.028942] LSM: initializing lsm=capability,landlock,yama,bpf,ima116server # [ 0.031681] landlock: Up and running.117server # [ 0.031772] Yama: becoming mindful.118server # [ 0.034427] LSM support for eBPF active119server # [ 0.038477] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)120server # [ 0.038717] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)121server # [ 0.084198] rcu: Hierarchical SRCU implementation.122server # [ 0.084309] rcu: Max phase no-delay instances is 1000.123server # [ 0.086256] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level124server # [ 0.094188] fsl-mc MSI: its@8080000 domain created125server # [ 0.096267] EFI services will not be available.126server # [ 0.098548] smp: Bringing up secondary CPUs ...127server # [ 0.103716] Detected PIPT I-cache on CPU1128server # [ 0.105319] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000129server # [ 0.106009] GICv3: CPU1: using allocated LPI pending table @0x0000000100b40000130server # [ 0.107540] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]131server # [ 0.112168] smp: Brought up 1 node, 2 CPUs132server # [ 0.112337] SMP: Total of 2 processors activated.133server # [ 0.112382] CPU: All CPU(s) started at EL1134server # [ 0.112598] CPU features: detected: Branch Target Identification135server # [ 0.112649] CPU features: detected: 32-bit EL0 Support136server # [ 0.112685] CPU features: detected: 32-bit EL1 Support137server # [ 0.112714] CPU features: detected: ARMv8.4 Translation Table Level138server # [ 0.112752] CPU features: detected: Instruction cache invalidation not required for I/D coherence139server # [ 0.112797] CPU features: detected: Data cache clean to the PoU not required for I/D coherence140server # [ 0.112866] CPU features: detected: Common not Private translations141server # [ 0.112897] CPU features: detected: CRC32 instructions142server # [ 0.112926] CPU features: detected: Data cache clean to Point of Deep Persistence143server # [ 0.112959] CPU features: detected: Data cache clean to Point of Persistence144server # [ 0.112991] CPU features: detected: Data independent timing control (DIT)145server # [ 0.113022] CPU features: detected: E0PD146server # [ 0.113043] CPU features: detected: Enhanced Counter Virtualization147server # [ 0.113118] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)148server # [ 0.113160] CPU features: detected: Enhanced Privileged Access Never149server # [ 0.113195] CPU features: detected: Enhanced Virtualization Traps150server # [ 0.113228] CPU features: detected: Fine Grained Traps151server # [ 0.113253] CPU features: detected: Guarded Control Stack (GCS)152server # [ 0.113313] CPU features: detected: Generic authentication (IMP DEF algorithm)153server # [ 0.113404] CPU features: detected: RCpc load-acquire (LDAPR)154server # [ 0.113455] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)155server # [ 0.113488] CPU features: detected: LSE atomic instructions156server # [ 0.113517] CPU features: detected: Memory Copy and Memory Set instructions157server # [ 0.113550] CPU features: detected: Privileged Access Never158server # [ 0.113602] CPU features: detected: PMUv3159server # [ 0.113624] CPU features: detected: SCTLR2160server # [ 0.113649] CPU features: detected: RAS Extension Support161server # [ 0.113717] CPU features: detected: RASv1p1 Extension Support162server # [ 0.113749] CPU features: detected: Random Number Generator163server # [ 0.113776] CPU features: detected: Speculation barrier (SB)164server # [ 0.113806] CPU features: detected: Stage-2 Force Write-Back165server # [ 0.113836] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality166server # [ 0.113872] CPU features: detected: TLB range maintenance instructions167server # [ 0.113904] CPU features: detected: WFx with timeout168server # [ 0.113977] CPU features: detected: Scalable Matrix Extension169server # [ 0.114005] CPU features: detected: FA64170server # [ 0.114029] CPU features: detected: SME2171server # [ 0.114053] CPU features: detected: Speculative Store Bypassing Safe (SSBS)172server # [ 0.114086] CPU features: detected: Scalable Vector Extension173server # [ 0.122279] alternatives: applying system-wide alternatives174server # [ 0.137867] CPU features: detected: Hardware dirty bit management on CPU0-1175server # [ 0.138588] SVE: maximum available vector length 256 bytes per vector176server # [ 0.138678] SVE: default vector length 64 bytes per vector177server # [ 0.139755] SME: minimum available vector length 16 bytes per vector178server # [ 0.139807] SME: maximum available vector length 256 bytes per vector179server # [ 0.139854] SME: default vector length 32 bytes per vector180server # [ 0.155682] Memory: 3904064K/4194304K available (24320K kernel code, 7090K rwdata, 26572K rodata, 4736K init, 1103K bss, 241772K reserved, 32768K cma-reserved)181server # [ 0.179579] devtmpfs: initialized182server # [ 0.213938] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear)183server # [ 0.214275] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear).184server # [ 0.217309] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL185server # [ 0.217396] 0 pages in range for non-PLT usage186server # [ 0.217453] 508272 pages in range for PLT usage187server # [ 0.220657] pinctrl core: initialized pinctrl subsystem188server # [ 0.233403] DMI not present or invalid.189server # [ 0.255986] NET: Registered PF_NETLINK/PF_ROUTE protocol family190server # [ 0.268432] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations191server # [ 0.270098] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations192server # [ 0.271439] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations193server # [ 0.271765] audit: initializing netlink subsys (disabled)194server # [ 0.274331] audit: type=2000 audit(0.220:1): state=initialized audit_enabled=0 res=1195server # [ 0.280585] thermal_sys: Registered thermal governor 'fair_share'196server # [ 0.280645] thermal_sys: Registered thermal governor 'bang_bang'197server # [ 0.280704] thermal_sys: Registered thermal governor 'step_wise'198server # [ 0.280735] thermal_sys: Registered thermal governor 'user_space'199server # [ 0.280766] thermal_sys: Registered thermal governor 'power_allocator'200server # [ 0.282215] cpuidle: using governor ladder201server # [ 0.282505] cpuidle: using governor menu202server # [ 0.284736] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.203server # [ 0.285482] ASID allocator initialised with 65536 entries204server # [ 0.292796] Serial: AMBA PL011 UART driver205server # [ 0.352184] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1206server # [ 0.355260] printk: console [ttyAMA0] enabled207server # [ 0.414157] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages208server # [ 0.414241] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page209server # [ 0.414287] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages210server # [ 0.414318] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page211server # [ 0.414349] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages212server # [ 0.414377] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page213server # [ 0.414407] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages214server # [ 0.414435] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page215server # [ 0.454581] fbcon: Taking over console216server # [ 0.454872] ACPI: Interpreter disabled.217server # [ 0.465104] iommu: Default domain type: Translated218server # [ 0.465201] iommu: DMA domain TLB invalidation policy: strict mode219server # [ 0.476729] SCSI subsystem initialized220server # [ 0.480186] usbcore: registered new interface driver usbfs221server # [ 0.480506] usbcore: registered new interface driver hub222server # [ 0.480706] usbcore: registered new device driver usb223server # [ 0.485167] pps_core: LinuxPPS API ver. 1 registered224server # [ 0.485244] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>225server # [ 0.485340] PTP clock support registered226server # [ 0.485733] EDAC MC: Ver: 3.0.0227server # [ 0.492272] scmi_core: SCMI protocol bus registered228server # [ 0.498490] FPGA manager framework229server # [ 0.509760] vgaarb: loaded230server # [ 0.514363] clocksource: Switched to clocksource arch_sys_counter231server # [ 0.520330] VFS: Disk quotas dquot_6.6.0232server # [ 0.520550] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)233server # [ 0.529655] netfs: FS-Cache loaded234server # [ 0.532702] pnp: PnP ACPI: disabled235server # [ 0.589682] NET: Registered PF_INET protocol family236server # [ 0.590917] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)237server # [ 0.703407] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)238server # [ 0.703607] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)239server # [ 0.703758] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)240server # [ 0.704192] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)241server # [ 0.704514] TCP: Hash tables configured (established 32768 bind 32768)242server # [ 0.705871] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)243server # [ 0.706185] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)244server # [ 0.706410] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)245server # [ 0.708980] NET: Registered PF_UNIX/PF_LOCAL protocol family246server # [ 0.711069] NET: Registered PF_XDP protocol family247server # [ 0.712742] PCI: CLS 0 bytes, default 64248server # [ 0.715126] kvm [1]: HYP mode not available249server # [ 0.717491] Trying to unpack rootfs image as initramfs...250server # [ 0.875997] Initialise system trusted keyrings251server # [ 0.879462] workingset: timestamp_bits=42 max_order=20 bucket_order=0252server # [ 0.889729] squashfs: version 4.0 (2009/01/31) Phillip Lougher253server # [ 0.890397] 9p: Installing v9fs 9p2000 file system support254server # [ 0.960574] Key type asymmetric registered255server # [ 0.960735] Asymmetric key parser 'x509' registered256server # [ 0.961145] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)257server # [ 0.965344] io scheduler mq-deadline registered258server # [ 0.965477] io scheduler kyber registered259server # [ 1.010046] pl061_gpio 9030000.pl061: PL061 GPIO chip registered260server # [ 1.018725] ledtrig-cpu: registered to indicate activity on CPUs261server # [ 1.023139] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:262server # [ 1.023719] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000263server # [ 1.024884] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000264server # [ 1.025128] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000265server # [ 1.026250] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits266server # [ 1.028385] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]267server # [ 1.030204] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00268server # [ 1.030539] pci_bus 0000:00: root bus resource [bus 00-ff]269server # [ 1.030648] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]270server # [ 1.030723] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]271server # [ 1.030772] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]272server # [ 1.032387] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint273server # [ 1.038142] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint274server # [ 1.038968] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]275server # [ 1.039270] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]276server # [ 1.039405] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]277server # [ 1.039743] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]278server # [ 1.041580] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint279server # [ 1.041708] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]280server # [ 1.041756] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]281server # [ 1.042079] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282server # [ 1.043548] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint283server # [ 1.043931] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]284server # [ 1.044268] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]285server # [ 1.045174] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]286server # [ 1.045868] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint287server # [ 1.046108] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]288server # [ 1.046155] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]289server # [ 1.046201] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290server # [ 1.048921] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint291server # [ 1.049051] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]292server # [ 1.049308] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]293server # [ 1.049365] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]294server # [ 1.053611] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint295server # [ 1.053729] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]296server # [ 1.055092] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]297server # [ 1.055176] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298server # [ 1.056788] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint299server # [ 1.057021] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]300server # [ 1.057059] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]301server # [ 1.057204] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]302server # [ 1.057255] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]303server # [ 1.057807] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint304server # [ 1.057910] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]305server # [ 1.057951] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]306server # [ 1.058871] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint307server # [ 1.058983] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]308server # [ 1.059035] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]309server # [ 1.059611] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint310server # [ 1.059708] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]311server # [ 1.060259] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint312server # [ 1.060378] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]313server # [ 1.060566] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]314server # [ 1.060613] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]315server # [ 1.061185] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint316server # [ 1.061288] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]317server # [ 1.061336] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]318server # [ 1.061374] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]319server # [ 1.064624] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned320server # [ 1.065305] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned321server # [ 1.065813] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned322server # [ 1.066297] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned323server # [ 1.066702] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned324server # [ 1.067030] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned325server # [ 1.067350] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned326server # [ 1.067610] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned327server # [ 1.067723] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned328server # [ 1.067953] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned329server # [ 1.068264] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned330server # [ 1.068873] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned331server # [ 1.068982] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned332server # [ 1.069482] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned333server # [ 1.069556] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned334server # [ 1.069917] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned335server # [ 1.069979] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned336server # [ 1.070023] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned337server # [ 1.070069] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned338server # [ 1.070109] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned339server # [ 1.070450] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned340server # [ 1.071190] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned341server # [ 1.071246] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned342server # [ 1.071569] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned343server # [ 1.071631] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned344server # [ 1.071847] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned345server # [ 1.072150] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned346server # [ 1.072460] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned347server # [ 1.073301] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned348server # [ 1.073380] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned349server # [ 1.073433] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned350server # [ 1.073483] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned351server # [ 1.073792] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned352server # [ 1.074107] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned353server # [ 1.076025] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]354server # [ 1.076111] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]355server # [ 1.076247] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]356server # [ 1.088230] pci 0000:00:0a.0: enabling device (0000 -> 0002)357server # [ 1.170467] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)358server # [ 1.174582] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)359server # [ 1.177906] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)360server # [ 1.180388] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)361server # [ 1.182378] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)362server # [ 1.187702] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)363server # [ 1.189856] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)364server # [ 1.194157] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)365server # [ 1.196490] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)366server # [ 1.199797] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)367server # [ 1.203161] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)368server # [ 1.223988] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled369server # [ 1.234500] msm_serial: driver initialized370server # [ 1.235467] SuperH (H)SCI(F) driver initialized371server # [ 1.235941] STM32 USART driver initialized372server # [ 1.297997] loop: module loaded373server # [ 1.298578] virtio_blk virtio5: 2/0/0 default/read/poll queues374server # [ 1.303383] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)375server # [ 1.317046] megasas: 07.734.00.00-rc1376server # [ 1.323322] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]377server # [ 1.325324] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000378server # [ 1.325788] Intel/Sharp Extended Query Table at 0x0031379server # [ 1.327325] Using buffer write method380server # [ 1.327845] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]381server # [ 1.329312] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000382server # [ 1.329537] Intel/Sharp Extended Query Table at 0x0031383server # [ 1.331185] Using buffer write method384server # [ 1.332547] Concatenating MTD devices:385server # [ 1.332592] (0): "0.flash"386server # [ 1.332628] (1): "0.flash"387server # [ 1.332657] into device "0.flash"388server # [ 1.935105] Freeing initrd memory: 25488K389server # [ 2.044320] tun: Universal TUN/TAP device driver, 1.6390server # [ 2.057681] thunder_xcv, ver 1.0391server # [ 2.057863] thunder_bgx, ver 1.0392server # [ 2.057988] nicpf, ver 1.0393server # [ 2.061694] e1000: Intel(R) PRO/1000 Network Driver394server # [ 2.061751] e1000: Copyright (c) 1999-2006 Intel Corporation.395server # [ 2.061930] e1000e: Intel(R) PRO/1000 Network Driver396server # [ 2.061970] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.397server # [ 2.062107] igb: Intel(R) Gigabit Ethernet Network Driver398server # [ 2.062138] igb: Copyright (c) 2007-2014 Intel Corporation.399server # [ 2.062262] igbvf: Intel(R) Gigabit Virtual Function Network Driver400server # [ 2.062295] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.401server # [ 2.064121] sky2: driver version 1.30402server # [ 2.074922] ehci-pci 0000:00:0a.0: EHCI Host Controller403server # [ 2.075354] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1404server # [ 2.075869] usbcore: registered new interface driver usb-storage405server # [ 2.076298] usbcore: registered new interface driver usbserial_generic406server # [ 2.076527] usbserial: USB Serial support registered for generic407server # [ 2.077541] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000408server # [ 2.079577] hv_vmbus: registering driver hyperv_keyboard409server # [ 2.087401] rtc-pl031 9010000.pl031: registered as rtc0410server # [ 2.087890] rtc-pl031 9010000.pl031: setting system clock to 2026-10-27T16:07:59 UTC (1793117279)411server # [ 2.089642] i2c_dev: i2c /dev entries driver412server # [ 2.090517] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00413server # [ 2.100025] hub 1-0:1.0: USB hub found414server # [ 2.100539] hub 1-0:1.0: 6 ports detected415server # [ 2.107460] sdhci: Secure Digital Host Controller Interface driver416server # [ 2.107516] sdhci: Copyright(c) Pierre Ossman417server # [ 2.109018] Synopsys Designware Multimedia Card Interface Driver418server # [ 2.111813] sdhci-pltfm: SDHCI platform and OF driver helper419server # [ 2.121153] hid: raw HID events driver (C) Jiri Kosina420server # [ 2.122893] usbcore: registered new interface driver usbhid421server # [ 2.122947] usbhid: USB HID core driver422server # [ 2.132786] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available423server # [ 2.142510] drop_monitor: Initializing network drop monitor service424server # [ 2.143654] NET: Registered PF_INET6 protocol family425server # [ 2.153698] Segment Routing with IPv6426server # [ 2.153948] In-situ OAM (IOAM) with IPv6427server # [ 2.154709] NET: Registered PF_PACKET protocol family428server # [ 2.156438] 9pnet: Installing 9P2000 support429server # [ 2.161368] Key type dns_resolver registered430server # [ 2.204789] registered taskstats version 1431server # [ 2.207096] Loading compiled-in X.509 certificates432server # [ 2.275639] Demotion targets for Node 0: null433server # [ 2.276957] Key type .fscrypt registered434server # [ 2.277010] Key type fscrypt-provisioning registered435server # [ 2.279310] ima: No TPM chip found, activating TPM-bypass!436server # [ 2.279425] ima: Allocated hash algorithm: sha1437server # [ 2.280914] ima: No architecture policies found438server # [ 2.290955] input: gpio-keys as /devices/platform/gpio-keys/input/input0439server # [ 2.340380] clk: Disabling unused clocks440server # [ 2.340641] PM: genpd: Disabling unused power domains441server # [ 2.359496] usb 1-1: new high-speed USB device number 2 using ehci-pci442server # [ 2.558225] 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/input1443server # [ 2.631052] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0444server # [ 2.711333] Freeing unused kernel memory: 4736K445server # [ 2.712661] Run /init as init process446server # [ 2.749005] usb 1-2: new high-speed USB device number 3 using ehci-pci447server # [ 2.854335] systemd[1]: Successfully made /usr/ read-only.448server # [ 2.920079] 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/input2449server # [ 2.920969] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0450server # [ 3.205982] systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)451server # [ 3.206223] systemd[1]: Detected virtualization qemu.452server # [ 3.206528] systemd[1]: Detected architecture arm64.453server # [ 3.206591] systemd[1]: Running in initrd.454server # [ 3.217785] systemd[1]: Initializing machine ID from random generator.455server # [ 3.221013] systemd[1]: Hostname set to <server>.456server # [ 3.910925] systemd[1]: Queued start job for default target Initrd Default Target.457server # [ 3.977979] systemd[1]: Created slice Slice /system/modprobe.458server # [ 3.982217] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.459server # [ 3.982919] systemd[1]: Expecting device /dev/disk/by-label/nixos...460server # [ 3.983295] systemd[1]: Reached target Path Units.461server # [ 3.983497] systemd[1]: Reached target Slice Units.462server # [ 3.983651] systemd[1]: Reached target Swaps.463server # [ 3.984179] systemd[1]: Reached target Timer Units.464server # [ 3.988425] systemd[1]: Listening on D-Bus System Message Bus Socket.465server # [ 3.989884] systemd[1]: Listening on Journal Socket (/dev/log).466server # [ 3.991857] systemd[1]: Listening on Journal Sockets.467server # [ 3.992863] systemd[1]: Listening on udev Control Socket.468server # [ 3.993593] systemd[1]: Listening on udev Kernel Socket.469server # [ 3.993819] systemd[1]: Reached target Socket Units.470server # [ 4.014432] systemd[1]: Starting Create List of Static Device Nodes...471server # [ 4.031772] systemd[1]: Starting Load Kernel Module 9pnet_virtio...472server # [ 4.033157] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs473server # [ 4.085292] systemd[1]: Mounting Kernel Configuration File System...474server # [ 4.184387] systemd[1]: Starting Journal Service...475server # [ 4.226870] systemd[1]: Starting Load Kernel Modules...476server # [ 4.228081] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki477server # [ 4.251860] systemd[1]: Starting Coldplug All udev Devices...478server # [ 4.338209] systemd[1]: Finished Create List of Static Device Nodes.479server # [ 4.376453] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.480server # [ 4.391846] systemd[1]: Finished Load Kernel Module 9pnet_virtio.481server # [ 4.401756] systemd[1]: Mounted Kernel Configuration File System.482server # [ 4.443771] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...483server # [ 4.716120] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0484server # [ 4.716710] [drm] features: -virgl +edid -resource_blob -host_visible485server # [ 4.716743] [drm] features: -context_init486server # [ 4.718701] [drm] number of scanouts: 1487server # [ 4.718775] [drm] number of cap sets: 0488server # [ 4.731952] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.489server # [ 4.743307] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev490server # [ 4.755499] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.491server # [ 4.777610] systemd-journald[81]: Collecting audit messages is disabled.492server # [ 4.787385] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic493server # [ 4.787529] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0494server # [ 4.796496] systemd[1]: Starting Create Static Device Nodes in /dev...495server # [ 4.884998] Console: switching to colour frame buffer device 160x50496server # [ 4.897510] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device497server # [ 4.942384] systemd[1]: Finished Load Kernel Modules.498server # [ 4.980994] systemd[1]: Starting Apply Kernel Variables...499server # [ 5.015765] systemd[1]: Finished Create Static Device Nodes in /dev.500server # [ 5.035042] systemd[1]: Reached target Preparation for Local File Systems.501server # [ 5.036774] systemd[1]: Reached target Local File Systems.502server # [ 5.092767] systemd[1]: Starting Rule-based Manager for Device Events and Files...503server # [ 5.292278] systemd[1]: Finished Apply Kernel Variables.504server # [ 5.764127] systemd[1]: Started Journal Service.505server # [ 5.677136] systemd-modules-load[82]: Using 2 probe threads506server # [ 5.693624] systemd-modules-load[82]: Module 'virtio_balloon' is built in507server # [ 5.700453] systemd-modules-load[82]: Module 'virtio_console' is built in508server # [ 5.713880] systemd-modules-load[82]: Inserted module 'dm_mod'509server # [ 5.717961] systemd-modules-load[82]: Module 'virtio_rng' is built in510server # [ 5.726510] systemd-modules-load[82]: Inserted module 'virtio_gpu'511server # [ 5.738279] systemd-udevd[89]: Using default interface naming scheme 'v260'.512server # [ 5.751702] systemd[1]: Starting Create System Files and Directories...513server # [ 5.885914] systemd[1]: Started Rule-based Manager for Device Events and Files.514server # [ 5.951358] systemd[1]: Finished Create System Files and Directories.515server # [ 6.319494] systemd[1]: Starting Virtual Console Setup...516server # [ 6.583790] systemd-vconsole-setup[112]: Configuration of first virtual console was skipped, ignoring remaining ones.517server # [ 6.607452] systemd[1]: Finished Virtual Console Setup.518server # [ 10.395821] systemd[1]: Finished Coldplug All udev Devices.519server # [ 10.399066] systemd[1]: Reached target System Initialization.520server # [ 10.400020] systemd[1]: Reached target Basic System.521server # [ 12.520114] (udev-worker)[129]: Network interface NamePolicy= disabled on kernel command line.522server # [ 12.614779] (udev-worker)[118]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.523server # [ 12.636658] (udev-worker)[118]: Network interface NamePolicy= disabled on kernel command line.524server # [ 12.871053] systemd[1]: Found device /dev/disk/by-label/nixos.525server # [ 12.918157] systemd[1]: Reached target Initrd Root Device.526server # [ 12.938639] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...527server # [ 13.271934] systemd-fsck[140]: nixos: clean, 12/65536 files, 13019/262144 blocks528server # [ 13.326965] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.529server # [ 13.362205] systemd[1]: Mounting /sysroot...530server # [ 13.697251] EXT4-fs (vda): mounted filesystem e2a328ae-6853-4d60-8ae5-04eb35c416ef r/w with ordered data mode. Quota mode: none.531server # [ 13.675084] systemd[1]: Mounted /sysroot.532server # [ 13.693483] systemd[1]: Reached target Initrd Root File System.533server # [ 13.749191] systemd[1]: Mounting /sysroot/nix/.ro-store...534server # [ 13.793375] systemd[1]: Mounting /sysroot/nix/.rw-store...535server # [ 13.853116] systemd[1]: Mounting /sysroot/run...536server # [ 13.928240] systemd[1]: Mounting /sysroot/tmp/shared...537server # [ 14.013694] systemd[1]: Mounting /sysroot/tmp/xchg...538server # [ 14.073476] systemd[1]: Starting Mountpoints Configured in the Real Root...539server # [ 14.193793] systemd[1]: Mounted /sysroot/nix/.ro-store.540server # [ 14.203812] systemd[1]: Mounted /sysroot/nix/.rw-store.541server # [ 14.320371] systemd-sysroot-fstab-check[153]: /sysroot should be mounted in the initrd, will request daemon-reload.542server # [ 14.331176] systemd[1]: Mounted /sysroot/run.543server # [ 14.334432] systemd[1]: Mounted /sysroot/tmp/shared.544server # [ 14.335990] systemd[1]: Mounted /sysroot/tmp/xchg.545server # [ 14.388690] systemd[1]: Starting rw-sysroot-nix-store.service...546server # [ 14.391337] systemd[1]: Reload requested from client PID 153 ('systemd-sysroot') (unit initrd-parse-etc.service)...547server # [ 14.393452] systemd[1]: Reloading...548server # [ 15.528015] systemd[1]: Reloading finished in 1127 ms.549server # [ 15.600530] systemd-sysroot-fstab-check[153]: Requesting initrd-fs.target/start/replace...550server # [ 15.610384] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.551server # [ 15.613416] systemd[1]: Finished rw-sysroot-nix-store.service.552server # [ 15.625574] systemd-sysroot-fstab-check[153]: Requesting swap.target/start/replace...553server # [ 15.658496] systemd[1]: initrd-parse-etc.service: Deactivated successfully.554server # [ 15.661508] systemd[1]: Finished Mountpoints Configured in the Real Root.555server # [ 15.663798] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.556server # [ 15.679057] systemd[1]: Starting rw-sysroot-nix-store.service...557server # [ 15.763748] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.558server # [ 15.769293] systemd[1]: Finished rw-sysroot-nix-store.service.559server # [ 15.787971] systemd[1]: Mounting /sysroot/nix/store...560server # [ 16.069163] systemd[1]: Mounted /sysroot/nix/store.561server # [ 16.096907] systemd[1]: Reached target Initrd File Systems.562server # [ 16.151049] systemd[1]: Starting Find NixOS closure...563server # [ 16.187445] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...564server # [ 16.470367] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.565server # [ 16.498199] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.566server # [ 16.708363] systemd[1]: Finished Find NixOS closure.567server # [ 16.713818] systemd[1]: Reached target Initrd Default Target.568server # [ 16.725083] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...569server # [ 16.913692] systemd[1]: Stopped target Initrd Default Target.570server # [ 16.917056] systemd[1]: Stopped target Basic System.571server # [ 16.919874] systemd[1]: Stopped target Initrd Root Device.572server # [ 16.925952] systemd[1]: Stopped target Path Units.573server # [ 16.933596] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.574server # [ 16.938411] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.575server # [ 16.943220] systemd[1]: Stopped target Slice Units.576server # [ 16.944278] systemd[1]: Stopped target Socket Units.577server # [ 16.947531] systemd[1]: Stopped target System Initialization.578server # [ 16.951383] systemd[1]: Stopped target Swaps.579server # [ 16.955567] systemd[1]: Stopped target Timer Units.580server # [ 16.957702] systemd[1]: dbus.socket: Deactivated successfully.581server # [ 16.962218] systemd[1]: Closed D-Bus System Message Bus Socket.582server # [ 16.963328] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.583server # [ 16.967549] systemd[1]: Stopped Find NixOS closure.584server # [ 16.986849] systemd[1]: Starting Load Kernel Module 9pnet_virtio...585server # [ 17.018717] systemd[1]: Starting rw-sysroot-nix-store.service...586server # [ 17.026041] systemd[1]: systemd-sysctl.service: Deactivated successfully.587server # [ 17.034117] systemd[1]: Stopped Apply Kernel Variables.588server # [ 17.042805] systemd[1]: systemd-modules-load.service: Deactivated successfully.589server # [ 17.050610] systemd[1]: Stopped Load Kernel Modules.590server # [ 17.061052] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.591server # [ 17.078832] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.592server # [ 17.083500] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.593server # [ 17.104155] systemd[1]: Stopped Create System Files and Directories.594server # [ 17.115461] systemd[1]: Stopped target Local File Systems.595server # [ 17.125122] systemd[1]: Stopped target Preparation for Local File Systems.596server # [ 17.130032] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.597server # [ 17.138748] systemd[1]: Stopped Coldplug All udev Devices.598server # [ 17.145346] systemd[1]: systemd-udev-trigger.service: Consumed 5.077s CPU time over 12.983s wall clock time, 9.5M memory peak.599server # [ 17.155721] systemd[1]: Stopping Rule-based Manager for Device Events and Files...600server # [ 17.158139] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.601server # [ 17.163684] systemd[1]: Stopped Virtual Console Setup.602server # [ 17.273036] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.603server # [ 17.275752] systemd[1]: Finished Load Kernel Module 9pnet_virtio.604server # [ 17.289564] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.605server # [ 17.293878] systemd[1]: Finished rw-sysroot-nix-store.service.606server # [ 17.334856] systemd[1]: initrd-cleanup.service: Deactivated successfully.607server # [ 17.338554] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.608server # [ 17.671366] systemd[1]: systemd-udevd.service: Deactivated successfully.609server # [ 17.677000] systemd[1]: Stopped Rule-based Manager for Device Events and Files.610server # [ 17.681621] systemd[1]: systemd-udevd.service: Consumed 8.637s CPU time over 12.677s wall clock time, 22.9M memory peak.611server # [ 17.683384] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.612server # [ 17.686542] systemd[1]: Closed udev Control Socket.613server # [ 17.697402] systemd[1]: Starting Cleanup udev Database...614server # [ 17.698523] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.615server # [ 17.699606] systemd[1]: Stopped Create Static Device Nodes in /dev.616server # [ 17.707152] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.617server # [ 17.708404] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.618server # [ 17.710923] systemd[1]: kmod-static-nodes.service: Deactivated successfully.619server # [ 17.713818] systemd[1]: Stopped Create List of Static Device Nodes.620server # [ 17.854696] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.621server # [ 17.858438] systemd[1]: Finished Cleanup udev Database.622server # [ 17.863237] systemd[1]: Reached target Switch Root.623server # [ 17.874231] systemd[1]: Starting NixOS Activation...624server # [ 19.334857] initrd-nixos-activation-start[220]: booting system configuration /nix/store/98k940gqfarnmsxiry7yqi1w40453j1m-nixos-system-server-test625server # [ 19.861400] initrd-nixos-activation-start[220]: running activation script...626server # [ 23.766752] initrd-nixos-activation-start[243]: setting up /etc...627server # [ 25.796527] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.628server # [ 25.801185] systemd[1]: Finished NixOS Activation.629server # [ 25.803559] systemd[1]: initrd-nixos-activation.service: Consumed 4.274s CPU time over 7.919s wall clock time, 22.6M memory peak.630server # [ 25.814558] systemd[1]: Starting Switch Root...631server # [ 25.925937] systemd[1]: Switching root.632server # [ 26.149149] systemd-journald[81]: Received SIGTERM from PID 1 (systemd).633server # [ 28.168852] systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)634server # [ 28.170180] systemd[1]: Detected virtualization qemu.635server # [ 28.172896] systemd[1]: Detected architecture arm64.636server # [ 28.176048] systemd[1]: Detected first boot.637server # [ 28.208771] systemd[1]: Initializing machine ID from random generator.638server: Guest root shell did not produce any data yet...639server: To debug, enter the VM and run 'systemctl status backdoor.service'.640server # [ 29.462309] systemd[1]: bpf-restrict-fs: LSM BPF program attached641server # [ 30.787578] systemd[1]: Applying preset policy.642server # [ 34.208787] systemd[1]: Populated /etc with preset unit settings.643server # [ 38.227725] systemd[1]: initrd-switch-root.service: Deactivated successfully.644server # [ 38.234955] systemd[1]: Stopped initrd-switch-root.service.645server # [ 38.255777] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.646server # [ 38.271438] systemd[1]: Created slice Slice /system/getty.647server # [ 38.283851] systemd[1]: Created slice User and Session Slice.648server # [ 38.289588] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.649server # [ 38.295678] systemd[1]: Started Forward Password Requests to Wall Directory Watch.650server # [ 38.299005] systemd[1]: Expecting device /dev/hvc0...651server # [ 38.304502] systemd[1]: Expecting device /dev/ttyAMA0...652server # [ 38.308292] systemd[1]: Reached target Local Encrypted Volumes.653server # [ 38.310308] systemd[1]: Stopped target initrd-fs.target.654server # [ 38.315686] systemd[1]: Stopped target initrd-root-fs.target.655server # [ 38.320010] systemd[1]: Stopped target initrd-switch-root.target.656server # [ 38.323452] systemd[1]: Reached target Virtual Machines and Containers.657server # [ 38.327590] systemd[1]: Reached target Path Units.658server # [ 38.330621] systemd[1]: Reached target Remote File Systems.659server # [ 38.335129] systemd[1]: Reached target Slice Units.660server # [ 38.338298] systemd[1]: Reached target Swaps.661server # [ 38.369622] systemd[1]: Listening on Process Core Dump Socket.662server # [ 38.393006] systemd[1]: Listening on Credential Encryption/Decryption.663server # [ 38.430489] systemd[1]: Starting Journal Log Access Socket...664server # [ 38.441708] systemd[1]: Listening on Journal Audit Socket.665server # [ 38.452526] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.666server # [ 38.459346] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki667server # [ 38.468737] systemd[1]: Listening on udev Control Socket.668server # [ 38.506101] systemd[1]: Mounting Huge Pages File System...669server # [ 38.544636] systemd[1]: Mounting POSIX Message Queue File System...670server # [ 38.593364] systemd[1]: Mounting Kernel Debug File System...671server # [ 38.643709] systemd[1]: Mounting Kernel Trace File System...672server # [ 38.745174] systemd[1]: Starting Create List of Static Device Nodes...673server # [ 38.827187] systemd[1]: Starting Load Kernel Module 9pnet_virtio...674server # [ 38.838055] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs675server # [ 38.918210] systemd[1]: Mounting Kernel Configuration File System...676server # [ 38.943885] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm677server # [ 38.967408] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore678server # [ 39.089279] systemd[1]: Starting Load Kernel Module fuse...679server # [ 39.132135] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67680server # [ 39.235567] systemd[1]: Starting Journal Service...681server # [ 39.525279] systemd[1]: Starting Load Kernel Modules...682server # [ 39.802127] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...683server # [ 39.979931] systemd[1]: Starting Remount Root and Kernel File Systems...684server # [ 39.993047] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki685server # [ 40.003786] fuse: init (API version 7.45)686server # [ 40.064385] systemd[1]: Starting Coldplug All udev Devices...687server # [ 40.195287] systemd[1]: Listening on Journal Log Access Socket.688server # [ 40.234492] systemd[1]: Mounted Huge Pages File System.689server # [ 40.277332] systemd[1]: Mounted POSIX Message Queue File System.690server # [ 40.371387] systemd[1]: Mounted Kernel Debug File System.691server # [ 40.417819] systemd[1]: Mounted Kernel Trace File System.692server # [ 40.464822] systemd[1]: Finished Create List of Static Device Nodes.693server # [ 40.489477] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.694server # [ 40.500627] systemd[1]: Finished Load Kernel Module 9pnet_virtio.695server # [ 40.509674] systemd[1]: Mounted Kernel Configuration File System.696server # [ 40.519498] systemd[1]: modprobe@fuse.service: Deactivated successfully.697server # [ 40.526104] systemd[1]: Finished Load Kernel Module fuse.698server # [ 40.540572] systemd[1]: Finished Load Kernel Modules.699server # [ 40.601632] systemd[1]: Mounting FUSE Control File System...700server # [ 40.647318] systemd[1]: Starting Firewall...701server # [ 40.699185] systemd-journald[314]: Collecting audit messages is enabled.702server # [ 40.824922] systemd[1]: Starting Apply Kernel Variables...703server # [ 40.874355] systemd[1]: Queued start job for default target Multi-User System.704server # [ 40.891617] systemd[1]: systemd-journald.service: Deactivated successfully.705server # [ 40.903966] systemd[1]: systemd-journald.service: Consumed 1.151s CPU time over 33.970s wall clock time, 9.8M memory peak.706server # [ 41.015370] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...707server # [ 40.926285] systemd-modules-load[315]: Using 2 probe threads708server # [ 40.942580] systemd-modules-load[315]: Module 'atkbd' is built in709server # [ 40.947920] systemd-modules-load[315]: Module 'loop' is built in710server # [ 41.059871] EXT4-fs (vda): re-mounted e2a328ae-6853-4d60-8ae5-04eb35c416ef.711server # [ 41.076425] systemd[1]: Started Journal Service.712server # [ 41.172986] systemd[1]: Finished Remount Root and Kernel File Systems.713server # [ 41.647328] systemd-oomd[316]: No swap; memory pressure usage will be degraded714server # [ 41.810646] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.715server # [ 41.855205] systemd[1]: Mounted FUSE Control File System.716server # [ 42.291795] systemd[1]: Starting Flush Journal to Persistent Storage...717server # [ 42.312071] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore718server # [ 42.409390] systemd[1]: Starting Load/Save OS Random Seed...719server # [ 42.410694] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki720server # [ 42.480959] systemd[1]: Finished Apply Kernel Variables.721server # [ 42.693476] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.722server # [ 42.907632] systemd[1]: Starting Create Static Device Nodes in /dev...723server # [ 43.175469] systemd-journald[314]: Received client request to flush runtime journal.724server # [ 43.587309] systemd[1]: Finished Load/Save OS Random Seed.725server # [ 43.601941] systemd[1]: Reached target First Boot Complete.726server # [ 43.653171] systemd[1]: Finished Flush Journal to Persistent Storage.727server # [ 43.922573] systemd[1]: Finished Create Static Device Nodes in /dev.728server # [ 43.942654] systemd[1]: Reached target Preparation for Local File Systems.729server # [ 44.011833] systemd[1]: Mounting /run/wrappers...730server # [ 44.079626] systemd[1]: Starting Rule-based Manager for Device Events and Files...731server # [ 44.537836] systemd[1]: Mounted /run/wrappers.732server # [ 44.588925] systemd[1]: Reached target Local File Systems.733server # [ 44.646477] systemd[1]: Listening on Boot Loader Control Service Socket.734server # [ 44.721056] systemd[1]: Starting register-nix-paths.service...735server # [ 44.841339] systemd[1]: Starting Create SUID/SGID Wrappers...736server # [ 44.857584] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.737server # [ 45.024467] systemd[1]: Starting Save Transient machine-id to Disk...738server # [ 45.179400] systemd[1]: Starting Create System Files and Directories...739server # [ 46.283377] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.740server # [ 46.330331] systemd[1]: Finished Save Transient machine-id to Disk.741server # [ 47.751266] systemd[1]: Finished Create System Files and Directories.742server # [ 47.946492] systemd[1]: Starting Rebuild Journal Catalog...743server # [ 48.089303] systemd[1]: Starting Record System Boot/Shutdown in UTMP...744server # [ 49.400066] systemd[1]: Finished Record System Boot/Shutdown in UTMP.745server # [ 50.635805] systemd[1]: Finished Rebuild Journal Catalog.746server # [ 50.779661] systemd[1]: Starting Update is Completed...747server # [ 51.706685] systemd[1]: Finished Update is Completed.748server # [ 55.066955] systemd-udevd[363]: Using default interface naming scheme 'v260'.749server # [ 56.022066] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.750server # [ 56.057797] systemd[1]: Finished Create SUID/SGID Wrappers.751server # [ 56.068071] systemd[1]: suid-sgid-wrappers.service: Consumed 2.746s CPU time over 11.185s wall clock time, 5.3M memory peak.752server # [ 57.091564] systemd[1]: Started Rule-based Manager for Device Events and Files.753server # [ 57.968865] systemd[1]: Finished register-nix-paths.service.754server: Guest root shell did not produce any data yet...755server: To debug, enter the VM and run 'systemctl status backdoor.service'.756server # [ 59.327115] systemd[1]: Finished Firewall.757server # [ 61.975367] systemd[1]: Finished Coldplug All udev Devices.758server # [ 61.982703] systemd[1]: Reached target System Initialization.759server # [ 61.984164] systemd[1]: Started Discard unused filesystem blocks once a week.760server # [ 61.990949] systemd[1]: Started Daily Cleanup of Temporary Directories.761server # [ 61.995399] systemd[1]: Reached target Timer Units.762server # [ 62.002501] systemd[1]: Listening on D-Bus System Message Bus Socket.763server # [ 62.010625] systemd[1]: Listening on Nix Daemon Socket.764server # [ 62.017534] systemd[1]: Listening on Hostname Service Socket.765server # [ 62.020632] systemd[1]: Reached target Socket Units.766server # [ 62.023443] systemd[1]: Reached target Basic System.767server # [ 62.031958] systemd[1]: Starting Import lastlog data into lastlog2 database...768server # [ 62.098174] systemd[1]: Starting Name Service Cache Daemon (nsncd)...769server # [ 62.181263] systemd[1]: Starting Post-Boot Actions...770server # [ 62.379527] systemd[1]: Started Reset console on configuration changes.771server # [ 62.545708] systemd[1]: Starting resolvconf update...772server # [ 62.991731] systemd[1]: Finished Post-Boot Actions.773server # [ 63.090084] nsncd[571]: Oct 27 16:09:00.576 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"774server # [ 63.099889] systemd[1]: Started Name Service Cache Daemon (nsncd).775server # [ 63.242940] systemd[1]: Reached target Host and Network Name Lookups.776server # [ 63.251468] systemd[1]: Reached target User and Group Name Lookups.777server # [ 63.298305] systemd[1]: Starting D-Bus System Message Bus...778server # [ 63.506727] systemd[1]: Starting User Login Management...779server # [ 63.587569] systemd[1]: Finished Import lastlog data into lastlog2 database.780server # [ 64.654063] dbus-broker-launch[590]: Looking up NSS user entry for 'systemd-timesync'...781server # [ 64.813784] dbus-broker-launch[590]: NSS returned no entry for 'systemd-timesync'782server # [ 64.821215] dbus-broker-launch[590]: Invalid user-name in /nix/store/3h8rckbl9vs21jahmva0fpck4y03w9xg-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"783server # [ 65.075736] systemd[1]: Started D-Bus System Message Bus.784server # [ 65.438579] systemd-logind[592]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)785server # [ 65.455776] systemd-logind[592]: New seat seat0.786server # [ 65.496834] systemd[1]: Started User Login Management.787server # [ 65.556480] systemd[1]: Starting linger-users.service...788server # [ 65.606330] dbus-broker-launch[590]: Ready789server # [ 66.037902] systemd[1]: Stopped target Host and Network Name Lookups.790server # [ 66.045082] systemd[1]: Stopping Host and Network Name Lookups...791server # [ 66.054284] systemd[1]: Stopped target User and Group Name Lookups.792server # [ 66.063021] systemd[1]: Stopping User and Group Name Lookups...793server # [ 66.071813] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...794server # [ 66.105073] systemd[1]: nscd.service: Deactivated successfully.795server # [ 66.112107] systemd[1]: Stopped Name Service Cache Daemon (nsncd).796server # [ 66.178954] systemd[1]: linger-users.service: Deactivated successfully.797server # [ 66.188166] systemd[1]: Finished linger-users.service.798server # [ 66.397912] systemd[1]: Starting Name Service Cache Daemon (nsncd)...799server # [ 66.942673] systemd[1]: Started Name Service Cache Daemon (nsncd).800server # [ 66.962654] nsncd[646]: Oct 27 16:09:04.452 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"801server # [ 66.978631] systemd[1]: Reached target Host and Network Name Lookups.802server # [ 66.983324] systemd[1]: Reached target User and Group Name Lookups.803server # [ 67.331412] systemd[1]: Finished resolvconf update.804server # [ 67.343480] systemd[1]: Reached target Preparation for Network.805server # [ 67.399522] systemd[1]: Starting DHCP Client...806server # [ 67.457417] systemd[1]: Starting Extra networking commands....807server # [ 69.333282] dhcpcd[692]: dhcpcd-10.3.1 starting808server # [ 69.549236] dhcpcd[729]: dev: loaded udev809server # [ 69.686771] dhcpcd[729]: no valid interfaces found810server # [ 69.694042] dhcpcd[729]: no valid interfaces found811server # [ 69.698849] dhcpcd[729]: libudev: received NULL device812server # [ 69.707144] dhcpcd[729]: libudev: received NULL device813server # [ 70.375880] systemd[1]: Finished Extra networking commands..814server # [ 70.385576] systemd[1]: Reached target Network.815server # [ 70.427365] systemd[1]: Starting PostgreSQL Database Server...816server # [ 70.494029] systemd[1]: Starting Permit User Sessions...817server # [ 71.024014] systemd[1]: Finished Permit User Sessions.818server # [ 71.083203] systemd[1]: Started Getty on tty1.819server # [ 71.098244] systemd[1]: Reached target Login Prompts.820server # [ 71.579714] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[769]: Initializing database at /var/lib/postgresql/data821server # [ 73.034521] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: The files belonging to this database system will be owned by user "postgres".822server # [ 73.042582] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: This user must also own the server process.823server # [ 73.100896] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: The database cluster will be initialized with locale "en_US.UTF-8".824server # [ 73.105212] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: The default database encoding has accordingly been set to "UTF8".825server # [ 73.106605] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: The default text search configuration will be set to "english".826server # [ 73.109342] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: Data page checksums are enabled.827server # [ 73.113077] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: fixing permissions on existing directory /var/lib/postgresql/data ... ok828server # [ 73.114335] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: creating subdirectories ... ok829server # [ 73.118912] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: selecting dynamic shared memory implementation ... posix830server # [ 73.875362] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: selecting default max_connections ... 100831server # [ 74.525435] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: selecting default shared_buffers ... 128MB832server # [ 83.153774] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: selecting default time zone ... UTC833server # [ 83.184186] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: creating configuration files ... ok834server # [ 86.157958] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: running bootstrap script ... ok835server: Guest root shell did not produce any data yet...836server: To debug, enter the VM and run 'systemctl status backdoor.service'.837server # [ 94.047355] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: performing post-bootstrap initialization ... ok838server # [ 94.362978] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3839server # [ 96.006318] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: syncing data to disk ... ok840server # [ 96.013387] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: initdb: warning: enabling "trust" authentication for local connections841server # [ 96.025961] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: 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.842server # [ 96.035909] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: Success. You can now start the database server using:843server # [ 96.051802] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[770]: /nix/store/8f61g0kn68hhlcd0wj7h40w8h17hfb75-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start844server # [ 97.487432] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[769]: Validating PostgreSQL configuration...845server # [ 97.900010] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[969]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault846server # [ 98.743404] postgres[975]: 2026-10-27 16:09:36.245 UTC [975] LOG: pgaudit extension initialized847server # [ 99.279865] postgres[975]: 2026-10-27 16:09:36.790 UTC [975] LOG: pgsodium primary server secret key loaded848server # [ 99.730892] dhcpcd[729]: timed out849server # [ 99.748996] dhcpcd[729]: timed out850server # [ 99.766585] systemd[1]: Started DHCP Client.851server # [ 99.815237] postgres[975]: 2026-10-27 16:09:37.314 UTC [975] LOG: vault primary server secret key loaded852server # [ 100.339695] postgres[975]: 2026-10-27 16:09:37.848 UTC [975] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.3.0, 64-bit853server # [ 100.352012] postgres[975]: 2026-10-27 16:09:37.862 UTC [975] LOG: listening on IPv4 address "0.0.0.0", port 5432854server # [ 100.358514] postgres[975]: 2026-10-27 16:09:37.866 UTC [975] LOG: listening on IPv6 address "::", port 5432855server # [ 100.371687] postgres[975]: 2026-10-27 16:09:37.880 UTC [975] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"856server # [ 100.448005] postgres[992]: 2026-10-27 16:09:37.953 UTC [992] LOG: database system was shut down at 2026-10-27 16:09:31 UTC857server # [ 100.679972] postgres[997]: 2026-10-27 16:09:38.151 UTC [997] LOG: TimescaleDB background worker launcher connected to shared catalogs858server # [ 100.705859] postgres[998]: 2026-10-27 16:09:38.169 UTC [998] FATAL: role "postgres" does not exist859server # [ 100.723941] postgres[975]: 2026-10-27 16:09:38.180 UTC [975] LOG: database system is ready to accept connections860server # [ 100.794707] systemd[1]: Started PostgreSQL Database Server.861server # [ 100.851147] postgres[975]: 2026-10-27 16:09:38.331 UTC [975] LOG: background worker "pg_net 0.20.4 worker" (PID 998) exited with exit code 1862server # [ 100.891733] systemd[1]: Starting Supabase Database Initialization...863server # [ 100.970732] postgres[1000]: 2026-10-27 16:09:38.473 UTC [1000] LOG: pg_cron scheduler started864server # [ 101.329373] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Waiting for PostgreSQL to be ready...865server # [ 101.883545] postgres[1012]: 2026-10-27 16:09:39.368 UTC [1012] FATAL: role "postgres" does not exist866server # [ 101.918551] postgres[975]: 2026-10-27 16:09:39.420 UTC [975] LOG: background worker "pg_net 0.20.4 worker" (PID 1012) exited with exit code 1867server # [ 101.994586] postgres[1013]: ::1 2026-10-27 16:09:39.485 UTC [1013] root@root FATAL: role "root" does not exist868server # [ 102.010350] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: PostgreSQL is ready869server # [ 102.021660] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Creating postgres role...870server # [ 102.374383] postgres[1015]: ::1 2026-10-27 16:09:39.873 UTC [1015] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN;871server # [ 102.391740] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1014]: CREATE ROLE872server # [ 102.639959] postgres[1017]: ::1 2026-10-27 16:09:40.139 UTC [1017] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres;873server # [ 102.662117] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1016]: ALTER DATABASE874server # [ 102.725183] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql875server # [ 103.027471] postgres[1020]: ::1 2026-10-27 16:09:40.523 UTC [1020] postgres@postgres LOG: statement: create publication supabase_realtime;876server # [ 103.089682] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: CREATE PUBLICATION877server # [ 103.096603] postgres[1020]: ::1 2026-10-27 16:09:40.593 UTC [1020] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls;878server # [ 103.113788] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: ALTER ROLE879server # [ 103.126357] postgres[1020]: ::1 2026-10-27 16:09:40.620 UTC [1020] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication;880server # [ 103.135778] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: CREATE ROLE881server # [ 103.138155] postgres[1020]: ::1 2026-10-27 16:09:40.646 UTC [1020] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls;882server # [ 103.148769] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: CREATE ROLE883server # [ 103.150398] postgres[1020]: ::1 2026-10-27 16:09:40.657 UTC [1020] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin;884server # [ 103.159856] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: GRANT ROLE885server # [ 103.165887] postgres[1020]: ::1 2026-10-27 16:09:40.671 UTC [1020] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin;886server # [ 103.175886] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: GRANT887server # [ 103.178496] postgres[1020]: ::1 2026-10-27 16:09:40.688 UTC [1020] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls;888server # [ 103.191929] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: CREATE ROLE889server # [ 103.195212] postgres[1020]: ::1 2026-10-27 16:09:40.700 UTC [1020] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user;890server # [ 103.201532] postgres[1020]: ::1 2026-10-27 16:09:40.708 UTC [1020] postgres@postgres LOG: statement: create schema if not exists extensions;891server # [ 103.203498] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: GRANT ROLE892server # [ 103.209528] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: CREATE SCHEMA893server # [ 103.211067] postgres[1020]: ::1 2026-10-27 16:09:40.720 UTC [1020] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions;894server # [ 105.390770] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: CREATE EXTENSION895server # [ 105.398744] postgres[1020]: ::1 2026-10-27 16:09:42.901 UTC [1020] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions;896server # [ 106.298004] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: CREATE EXTENSION897server # [ 106.303095] postgres[1020]: ::1 2026-10-27 16:09:43.812 UTC [1020] postgres@postgres LOG: statement: create role anon nologin noinherit;898server # [ 106.313758] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: CREATE ROLE899server # [ 106.316774] postgres[1020]: ::1 2026-10-27 16:09:43.821 UTC [1020] postgres@postgres LOG: statement: create role authenticated nologin noinherit;900server # [ 106.323783] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: CREATE ROLE901server # [ 106.326052] postgres[1020]: ::1 2026-10-27 16:09:43.834 UTC [1020] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls;902server # [ 106.333550] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: CREATE ROLE903server # [ 106.338248] postgres[1020]: ::1 2026-10-27 16:09:43.848 UTC [1020] postgres@postgres LOG: statement: create user authenticator noinherit;904server # [ 106.346052] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: CREATE ROLE905server # [ 106.349846] postgres[1020]: ::1 2026-10-27 16:09:43.858 UTC [1020] postgres@postgres LOG: statement: grant anon to authenticator;906server # [ 106.357446] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: GRANT ROLE907server # [ 106.359824] postgres[1020]: ::1 2026-10-27 16:09:43.867 UTC [1020] postgres@postgres LOG: statement: grant authenticated to authenticator;908server # [ 106.374103] postgres[1020]: ::1 2026-10-27 16:09:43.873 UTC [1020] postgres@postgres LOG: statement: grant service_role to authenticator;909server # [ 106.375876] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: GRANT ROLE910server # [ 106.381111] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: GRANT ROLE911server # [ 106.398183] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: GRANT ROLE912server # [ 106.409035] postgres[1020]: ::1 2026-10-27 16:09:43.886 UTC [1020] postgres@postgres LOG: statement: grant supabase_admin to authenticator;913server # [ 106.415101] postgres[1020]: ::1 2026-10-27 16:09:43.900 UTC [1020] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role;914server # [ 106.423236] postgres[1020]: ::1 2026-10-27 16:09:43.909 UTC [1020] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;915server # [ 106.437211] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: GRANT916server # [ 106.439610] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: ALTER DEFAULT PRIVILEGES917server # [ 106.446216] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: ALTER DEFAULT PRIVILEGES918server # [ 106.449925] postgres[1020]: ::1 2026-10-27 16:09:43.928 UTC [1020] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;919server # [ 106.453135] postgres[1020]: ::1 2026-10-27 16:09:43.948 UTC [1020] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;920server # [ 106.458044] postgres[1020]: ::1 2026-10-27 16:09:43.962 UTC [1020] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role;921server # [ 106.465687] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: ALTER DEFAULT PRIVILEGES922server # [ 106.466822] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: GRANT923server # [ 106.468169] postgres[1020]: ::1 2026-10-27 16:09:43.976 UTC [1020] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions;924server # [ 106.475379] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: ALTER ROLE925server # [ 106.485942] postgres[1020]: ::1 2026-10-27 16:09:43.991 UTC [1020] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all926server # [ 106.489329] postgres[1020]: on sequences to postgres, anon, authenticated, service_role;927server # [ 106.495041] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: ALTER DEFAULT PRIVILEGES928server # [ 106.501501] postgres[1020]: ::1 2026-10-27 16:09:44.008 UTC [1020] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all929server # [ 106.503232] postgres[1020]: on tables to postgres, anon, authenticated, service_role;930server # [ 106.510890] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: ALTER DEFAULT PRIVILEGES931server # [ 106.513973] postgres[1020]: ::1 2026-10-27 16:09:44.023 UTC [1020] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all932server # [ 106.515945] postgres[1020]: on functions to postgres, anon, authenticated, service_role;933server # [ 106.526003] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: ALTER DEFAULT PRIVILEGES934server # [ 106.531551] postgres[1020]: ::1 2026-10-27 16:09:44.038 UTC [1020] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s';935server # [ 106.539361] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: ALTER ROLE936server # [ 106.550666] postgres[1020]: ::1 2026-10-27 16:09:44.056 UTC [1020] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s';937server # [ 106.557293] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1018]: ALTER ROLE938server # [ 106.625918] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql939server # [ 106.947752] postgres[1062]: ::1 2026-10-27 16:09:44.447 UTC [1062] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;940server # [ 106.957750] postgres[1062]: ::1 2026-10-27 16:09:44.462 UTC [1062] postgres@postgres LOG: statement: CREATE TABLE auth.users (941server # [ 106.958960] postgres[1062]: instance_id uuid NULL,942server # [ 106.964075] postgres[1062]: id uuid NOT NULL UNIQUE,943server # [ 106.965855] postgres[1062]: aud varchar(255) NULL,944server # [ 106.969315] postgres[1062]: "role" varchar(255) NULL,945server # [ 106.970433] postgres[1062]: email varchar(255) NULL UNIQUE,946server # [ 106.973218] postgres[1062]: encrypted_password varchar(255) NULL,947server # [ 106.974142] postgres[1062]: confirmed_at timestamptz NULL,948server # [ 106.978528] postgres[1062]: invited_at timestamptz NULL,949server # [ 106.981399] postgres[1062]: confirmation_token varchar(255) NULL,950server # [ 106.983709] postgres[1062]: confirmation_sent_at timestamptz NULL,951server # [ 106.993655] postgres[1062]: recovery_token varchar(255) NULL,952server # [ 106.994793] postgres[1062]: recovery_sent_at timestamptz NULL,953server # [ 107.009065] postgres[1062]: email_change_token varchar(255) NULL,954server # [ 107.010166] postgres[1062]: email_change varchar(255) NULL,955server # [ 107.010817] postgres[1062]: email_change_sent_at timestamptz NULL,956server # [ 107.011571] postgres[1062]: last_sign_in_at timestamptz NULL,957server # [ 107.012306] postgres[1062]: raw_app_meta_data jsonb NULL,958server # [ 107.014325] postgres[1062]: raw_user_meta_data jsonb NULL,959server # [ 107.017505] postgres[1062]: is_super_admin bool NULL,960server # [ 107.019870] postgres[1062]: created_at timestamptz NULL,961server # [ 107.026394] postgres[1062]: updated_at timestamptz NULL,962server # [ 107.030178] postgres[1062]: CONSTRAINT users_pkey PRIMARY KEY (id)963server # [ 107.031364] postgres[1062]: );964server # [ 107.042428] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE SCHEMA965server # [ 107.109212] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE TABLE966server # [ 107.120495] postgres[1062]: ::1 2026-10-27 16:09:44.623 UTC [1062] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);967server # [ 107.153716] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE INDEX968server # [ 107.161930] postgres[1062]: ::1 2026-10-27 16:09:44.667 UTC [1062] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);969server # [ 107.197446] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE INDEX970server # [ 107.203818] postgres[1062]: ::1 2026-10-27 16:09:44.713 UTC [1062] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';971server # [ 107.214204] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: COMMENT972server # [ 107.215832] postgres[1062]: ::1 2026-10-27 16:09:44.724 UTC [1062] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens (973server # [ 107.218183] postgres[1062]: instance_id uuid NULL,974server # [ 107.219906] postgres[1062]: id bigserial NOT NULL,975server # [ 107.225434] postgres[1062]: "token" varchar(255) NULL,976server # [ 107.227231] postgres[1062]: user_id varchar(255) NULL,977server # [ 107.232364] postgres[1062]: revoked bool NULL,978server # [ 107.234363] postgres[1062]: created_at timestamptz NULL,979server # [ 107.242015] postgres[1062]: updated_at timestamptz NULL,980server # [ 107.243203] postgres[1062]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)981server # [ 107.243864] postgres[1062]: );982server # [ 107.315900] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE TABLE983server # [ 107.318499] postgres[1062]: ::1 2026-10-27 16:09:44.825 UTC [1062] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);984server # [ 107.357049] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE INDEX985server # [ 107.360366] postgres[1062]: ::1 2026-10-27 16:09:44.870 UTC [1062] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id);986server # [ 107.397279] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE INDEX987server # [ 107.402789] postgres[1062]: ::1 2026-10-27 16:09:44.900 UTC [1062] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);988server # [ 107.423637] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE INDEX989server # [ 107.430257] postgres[1062]: ::1 2026-10-27 16:09:44.939 UTC [1062] postgres@postgres LOG: statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.';990server # [ 107.444177] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: COMMENT991server # [ 107.451024] postgres[1062]: ::1 2026-10-27 16:09:44.957 UTC [1062] postgres@postgres LOG: statement: CREATE TABLE auth.instances (992server # [ 107.454365] postgres[1062]: id uuid NOT NULL,993server # [ 107.465801] postgres[1062]: uuid uuid NULL,994server # [ 107.469362] postgres[1062]: raw_base_config text NULL,995server # [ 107.471666] postgres[1062]: created_at timestamptz NULL,996server # [ 107.474522] postgres[1062]: updated_at timestamptz NULL,997server # [ 107.477156] postgres[1062]: CONSTRAINT instances_pkey PRIMARY KEY (id)998server # [ 107.479953] postgres[1062]: );999server # [ 107.541230] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE TABLE1000server # [ 107.551626] postgres[1062]: ::1 2026-10-27 16:09:45.046 UTC [1062] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';1001server # [ 107.565608] postgres[1062]: ::1 2026-10-27 16:09:45.071 UTC [1062] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries (1002server # [ 107.567826] postgres[1062]: instance_id uuid NULL,1003server # [ 107.577893] postgres[1062]: id uuid NOT NULL,1004server # [ 107.585773] postgres[1062]: payload json NULL,1005server # [ 107.593709] postgres[1062]: created_at timestamptz NULL,1006server # [ 107.595227] postgres[1062]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)1007server # [ 107.597293] postgres[1062]: );1008server # [ 107.598151] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: COMMENT1009server # [ 107.662181] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE TABLE1010server # [ 107.664867] postgres[1062]: ::1 2026-10-27 16:09:45.165 UTC [1062] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);1011server # [ 107.689926] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE INDEX1012server # [ 107.694555] postgres[1062]: ::1 2026-10-27 16:09:45.202 UTC [1062] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';1013server # [ 107.705628] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: COMMENT1014server # [ 107.713910] postgres[1062]: ::1 2026-10-27 16:09:45.215 UTC [1062] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations (1015server # [ 107.716726] postgres[1062]: "version" varchar(255) NOT NULL,1016server # [ 107.718689] postgres[1062]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")1017server # [ 107.726082] postgres[1062]: );1018server # [ 107.732130] systemd[1]: Starting Virtual Console Setup...1019server # [ 107.768810] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE TABLE1020server # [ 107.771663] postgres[1062]: ::1 2026-10-27 16:09:45.275 UTC [1062] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';1021server # [ 107.782506] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: COMMENT1022server # [ 107.798517] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: INSERT 0 71023server # [ 107.810299] postgres[1062]: ::1 2026-10-27 16:09:45.310 UTC [1062] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$1024server # [ 107.812315] postgres[1062]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;1025server # [ 107.815966] postgres[1062]: $$ language sql stable;1026server # [ 107.824085] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE FUNCTION1027server # [ 107.829324] postgres[1062]: ::1 2026-10-27 16:09:45.337 UTC [1062] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$1028server # [ 107.833128] postgres[1062]: select nullif(current_setting('request.jwt.claim.role', true), '')::text;1029server # [ 107.838730] postgres[1062]: $$ language sql stable;1030server # [ 107.851058] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE FUNCTION1031server # [ 107.862179] postgres[1062]: ::1 2026-10-27 16:09:45.365 UTC [1062] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$1032server # [ 107.867414] postgres[1062]: select nullif(current_setting('request.jwt.claim.email', true), '')::text;1033server # [ 107.874717] postgres[1062]: $$ language sql stable;1034server # [ 107.885626] postgres[1062]: ::1 2026-10-27 16:09:45.385 UTC [1062] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;1035server # [ 107.887214] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE FUNCTION1036server # [ 107.887875] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: GRANT1037server # [ 107.890634] postgres[1062]: ::1 2026-10-27 16:09:45.400 UTC [1062] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1038server # [ 107.908249] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: CREATE ROLE1039server # [ 107.909875] postgres[1062]: ::1 2026-10-27 16:09:45.416 UTC [1062] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1040server # [ 107.920877] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: GRANT1041server # [ 107.923369] postgres[1062]: ::1 2026-10-27 16:09:45.428 UTC [1062] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1042server # [ 107.949706] postgres[1062]: ::1 2026-10-27 16:09:45.446 UTC [1062] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1043server # [ 107.958513] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: GRANT1044server # [ 107.961697] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: GRANT1045server # [ 107.969026] postgres[1062]: ::1 2026-10-27 16:09:45.465 UTC [1062] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth";1046server # [ 107.977815] postgres[1062]: ::1 2026-10-27 16:09:45.483 UTC [1062] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin;1047server # [ 107.979845] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: ALTER ROLE1048server # [ 107.993125] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: ALTER TABLE1049server # [ 107.997760] postgres[1062]: ::1 2026-10-27 16:09:45.502 UTC [1062] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;1050server # [ 108.012132] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: ALTER TABLE1051server # [ 108.021216] postgres[1062]: ::1 2026-10-27 16:09:45.528 UTC [1062] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;1052server # [ 108.043648] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: ALTER TABLE1053server # [ 108.051341] postgres[1062]: ::1 2026-10-27 16:09:45.547 UTC [1062] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;1054server # [ 108.061923] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: ALTER TABLE1055server # [ 108.066147] postgres[1062]: ::1 2026-10-27 16:09:45.575 UTC [1062] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;1056server # [ 108.090202] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1061]: ALTER TABLE1057server # [ 108.155502] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql1058server # [ 108.459845] postgres[1069]: ::1 2026-10-27 16:09:45.964 UTC [1069] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;1059server # [ 108.509035] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1067]: CREATE SCHEMA1060server # [ 108.515076] postgres[1069]: ::1 2026-10-27 16:09:46.000 UTC [1069] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1061server # [ 108.532998] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1067]: CREATE ROLE1062server # [ 108.542420] postgres[1069]: ::1 2026-10-27 16:09:46.052 UTC [1069] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage";1063server # [ 108.613181] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1067]: ALTER ROLE1064server # [ 108.622489] postgres[1069]: ::1 2026-10-27 16:09:46.132 UTC [1069] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;1065server # [ 108.664285] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1067]: GRANT1066server # [ 108.857641] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1067]: DO1067server # [ 108.897312] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql1068server # [ 109.295618] postgres[1071]: ::1 2026-10-27 16:09:46.784 UTC [1071] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;1069server # [ 109.310609] postgres[1071]: ::1 2026-10-27 16:09:46.808 UTC [1071] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;1070server # [ 109.375899] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: ALTER ROLE1071server # [ 109.385856] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: ALTER ROLE1072server # [ 109.400510] postgres[1071]: ::1 2026-10-27 16:09:46.827 UTC [1071] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()1073server # [ 109.402264] postgres[1071]: RETURNS event_trigger1074server # [ 109.414133] postgres[1071]: LANGUAGE plpgsql1075server # [ 109.417378] postgres[1071]: AS $$1076server # [ 109.433147] postgres[1071]: DECLARE1077server # [ 109.438263] postgres[1071]: schema_is_cron bool;1078server # [ 109.445376] postgres[1071]: BEGIN1079server # [ 109.447898] postgres[1071]: schema_is_cron = (1080server # [ 109.450202] postgres[1071]: SELECT n.nspname = 'cron'1081server # [ 109.452072] postgres[1071]: FROM pg_event_trigger_ddl_commands() AS ev1082server # [ 109.455194] postgres[1071]: LEFT JOIN pg_catalog.pg_namespace AS n1083server # [ 109.458275] postgres[1071]: ON ev.objid = n.oid1084server # [ 109.462700] postgres[1071]: );1085server # [ 109.467824] postgres[1071]:1086server # [ 109.473588] postgres[1071]: IF schema_is_cron1087server # [ 109.476829] postgres[1071]: THEN1088server # [ 109.482889] postgres[1071]: grant usage on schema cron to postgres with grant option;1089server # [ 109.490017] postgres[1071]:1090server # [ 109.495367] postgres[1071]: alter default privileges in schema cron grant all on tables to postgres with grant option;1091server # [ 109.499497] postgres[1071]: alter default privileges in schema cron grant all on functions to postgres with grant option;1092server # [ 109.503016] postgres[1071]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1093server # [ 109.511367] postgres[1071]:1094server # [ 109.521438] postgres[1071]: alter default privileges for user supabase_admin in schema cron grant all1095server # [ 109.525254] postgres[1071]: on sequences to postgres with grant option;1096server # [ 109.533915] postgres[1071]: alter default privileges for user supabase_admin in schema cron grant all1097server # [ 109.540041] postgres[1071]: on tables to postgres with grant option;1098server # [ 109.545077] postgres[1071]: alter default privileges for user supabase_admin in schema cron grant all1099server # [ 109.550371] postgres[1071]: on functions to postgres with grant option;1100server # [ 109.555848] postgres[1071]:1101server # [ 109.570109] postgres[1071]: grant all privileges on all tables in schema cron to postgres with grant option;1102server # [ 109.586460] postgres[1071]:1103server # [ 109.598360] postgres[1071]: END IF;1104server # [ 109.599490] postgres[1071]:1105server # [ 109.619287] postgres[1071]: END;1106server # [ 109.626616] postgres[1071]: $$;1107server # [ 109.632684] postgres[1071]: ::1 2026-10-27 16:09:46.882 UTC [1071] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')1108server # [ 109.639131] postgres[1071]: EXECUTE PROCEDURE extensions.grant_pg_cron_access();1109server # [ 109.645662] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: CREATE FUNCTION1110server # [ 109.651407] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: CREATE EVENT TRIGGER1111server # [ 109.664066] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: COMMENT1112server # [ 109.677422] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: CREATE FUNCTION1113server # [ 109.678745] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: COMMENT1114server # [ 109.679696] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: DO1115server # [ 109.682275] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: CREATE ROLE1116server # [ 109.690789] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: GRANT1117server # [ 109.705821] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: GRANT1118server # [ 109.707265] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: GRANT1119server # [ 109.708936] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: GRANT1120server # [ 109.710216] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: GRANT1121server # [ 109.711103] postgres[1071]: ::1 2026-10-27 16:09:46.916 UTC [1071] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';1122server # [ 109.711981] postgres[1071]: ::1 2026-10-27 16:09:46.930 UTC [1071] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()1123server # [ 109.725237] postgres[1071]: RETURNS event_trigger1124server # [ 109.734776] postgres[1071]: LANGUAGE plpgsql1125server # [ 109.744373] postgres[1071]: AS $$1126server # [ 109.753760] postgres[1071]: BEGIN1127server # [ 109.767174] postgres[1071]: IF EXISTS (1128server # [ 109.775059] postgres[1071]: SELECT 11129server # [ 109.777866] postgres[1071]: FROM pg_event_trigger_ddl_commands() AS ev1130server # [ 109.780130] postgres[1071]: JOIN pg_extension AS ext1131server # [ 109.782766] postgres[1071]: ON ev.objid = ext.oid1132server # [ 109.785614] postgres[1071]: WHERE ext.extname = 'pg_net'1133server # [ 109.788780] postgres[1071]: )1134server # [ 109.791287] postgres[1071]: THEN1135server # [ 109.793235] postgres[1071]: IF NOT EXISTS (1136server # [ 109.795117] postgres[1071]: SELECT 11137server # [ 109.797418] postgres[1071]: FROM pg_roles1138server # [ 109.798221] postgres[1071]: WHERE rolname = 'supabase_functions_admin'1139server # [ 109.799291] postgres[1071]: )1140server # [ 109.800868] postgres[1071]: THEN1141server # [ 109.802613] postgres[1071]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1142server # [ 109.807039] postgres[1071]: END IF;1143server # [ 109.809462] postgres[1071]:1144server # [ 109.811984] postgres[1071]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;1145server # [ 109.815132] postgres[1071]:1146server # [ 109.818576] postgres[1071]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1147server # [ 109.822283] postgres[1071]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1148server # [ 109.823532] postgres[1071]:1149server # [ 109.829890] postgres[1071]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1150server # [ 109.832218] postgres[1071]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1151server # [ 109.835198] postgres[1071]:1152server # [ 109.837225] postgres[1071]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1153server # [ 109.839255] postgres[1071]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1154server # [ 109.845725] postgres[1071]:1155server # [ 109.846634] postgres[1071]: 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;1156server # [ 109.851287] postgres[1071]: 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;1157server # [ 109.858038] postgres[1071]: END IF;1158server # [ 109.860017] postgres[1071]: END;1159server # [ 109.862869] postgres[1071]: $$;1160server # [ 109.870307] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: GRANT1161server # [ 109.872991] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: GRANT1162server # [ 109.874917] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: GRANT1163server # [ 109.881827] postgres[1071]: ::1 2026-10-27 16:09:46.950 UTC [1071] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';1164server # [ 109.883111] postgres[1071]: ::1 2026-10-27 16:09:47.040 UTC [1071] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;1165server # [ 109.889923] postgres[1071]: ::1 2026-10-27 16:09:47.054 UTC [1071] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user;1166server # [ 109.893823] postgres[1071]: ::1 2026-10-27 16:09:47.071 UTC [1071] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user;1167server # [ 109.897486] postgres[1071]: ::1 2026-10-27 16:09:47.089 UTC [1071] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;1168server # [ 109.901608] postgres[1071]: ::1 2026-10-27 16:09:47.103 UTC [1071] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;1169server # [ 109.905659] postgres[1071]: ::1 2026-10-27 16:09:47.129 UTC [1071] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;1170server # [ 109.912597] postgres[1071]: ::1 2026-10-27 16:09:47.147 UTC [1071] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;1171server # [ 109.922043] postgres[1071]: ::1 2026-10-27 16:09:47.171 UTC [1071] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;1172server # [ 109.925543] postgres[1071]: ::1 2026-10-27 16:09:47.187 UTC [1071] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;1173server # [ 109.928106] postgres[1071]: ::1 2026-10-27 16:09:47.260 UTC [1071] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;1174server # [ 110.022766] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: GRANT1175server # [ 110.071797] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1070]: DO1176server # [ 110.151891] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running pgbouncer auth schema...1177server # [ 110.666617] postgres[1088]: ::1 2026-10-27 16:09:48.164 UTC [1088] postgres@postgres LOG: statement: CREATE USER pgbouncer;1178server # [ 110.690694] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1080]: CREATE ROLE1179server # [ 110.702338] postgres[1088]: ::1 2026-10-27 16:09:48.188 UTC [1088] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;1180server # [ 110.709633] postgres[1088]: ::1 2026-10-27 16:09:48.216 UTC [1088] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;1181server # [ 110.718421] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1080]: REVOKE1182server # [ 110.773671] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1080]: CREATE SCHEMA1183server # [ 110.775918] postgres[1088]: ::1 2026-10-27 16:09:48.279 UTC [1088] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)1184server # [ 110.783717] postgres[1088]: RETURNS TABLE(username TEXT, password TEXT) AS1185server # [ 110.786540] postgres[1088]: $$1186server # [ 110.793228] postgres[1088]: BEGIN1187server # [ 110.801182] postgres[1088]: RAISE WARNING 'PgBouncer auth request: %', p_usename;1188server # [ 110.805658] postgres[1088]:1189server # [ 110.810831] postgres[1088]: RETURN QUERY1190server # [ 110.814542] postgres[1088]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow1191server # [ 110.817981] postgres[1088]: WHERE usename = p_usename;1192server # [ 110.823718] postgres[1088]: END;1193server # [ 110.833132] postgres[1088]: $$ LANGUAGE plpgsql1194server # [ 110.839243] postgres[1088]: SET search_path = ''1195server # [ 110.847732] postgres[1088]: SECURITY DEFINER;1196server # [ 110.850326] postgres[1088]: ::1 2026-10-27 16:09:48.329 UTC [1088] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;1197server # [ 110.853541] postgres[1088]: ::1 2026-10-27 16:09:48.344 UTC [1088] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;1198server # [ 110.854752] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1080]: CREATE FUNCTION1199server # [ 110.855527] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1080]: REVOKE1200server # [ 110.859361] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1080]: GRANT1201server # [ 110.903615] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running stat extension...1202server # [ 111.383771] postgres[1093]: ::1 2026-10-27 16:09:48.875 UTC [1093] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions;1203server # [ 111.414673] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1092]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping1204server # [ 111.477553] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1092]: CREATE SCHEMA1205server # [ 111.480980] postgres[1093]: ::1 2026-10-27 16:09:48.984 UTC [1093] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;1206server # [ 112.316053] systemd-vconsole-setup[1066]: Configuration of first virtual console was skipped, ignoring remaining ones.1207server # [ 112.344059] systemd[1]: Finished Virtual Console Setup.1208server # [ 112.643132] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1092]: CREATE EXTENSION1209server # [ 112.702590] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql1210server # [ 112.947534] postgres[1108]: ::1 2026-10-27 16:09:50.452 UTC [1108] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres;1211server # [ 112.958339] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1102]: GRANT1212server # [ 112.960057] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1102]: GRANT1213server # [ 112.962008] postgres[1108]: ::1 2026-10-27 16:09:50.460 UTC [1108] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres;1214server # [ 112.964812] postgres[1108]: ::1 2026-10-27 16:09:50.470 UTC [1108] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres;1215server # [ 112.972006] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1102]: GRANT1216server # [ 112.973834] postgres[1108]: ::1 2026-10-27 16:09:50.483 UTC [1108] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;1217server # [ 112.986504] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1102]: GRANT1218server # [ 112.987827] postgres[1108]: ::1 2026-10-27 16:09:50.497 UTC [1108] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;1219server # [ 113.006378] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1102]: GRANT1220server # [ 113.007831] postgres[1108]: ::1 2026-10-27 16:09:50.513 UTC [1108] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;1221server # [ 113.012182] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1102]: GRANT1222server # [ 113.017429] postgres[1108]: ::1 2026-10-27 16:09:50.524 UTC [1108] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;1223server # [ 113.021904] postgres[1108]: ::1 2026-10-27 16:09:50.530 UTC [1108] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;1224server # [ 113.026424] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1102]: GRANT1225server # [ 113.049493] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1102]: GRANT1226server # [ 113.051589] postgres[1108]: ::1 2026-10-27 16:09:50.554 UTC [1108] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;1227server # [ 113.095543] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1102]: GRANT1228server # [ 113.134907] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1102]: DO1229server # [ 113.147746] postgres[1108]: ::1 2026-10-27 16:09:50.642 UTC [1108] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;1230server # [ 113.157068] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1102]: ALTER ROLE1231server # [ 113.184273] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql1232server # [ 113.371248] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1233server # [ 113.376208] postgres[1119]: ::1 2026-10-27 16:09:50.878 UTC [1119] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1234server # [ 113.389686] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: GRANT1235server # [ 113.399819] postgres[1119]: ::1 2026-10-27 16:09:50.904 UTC [1119] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1236server # [ 113.407886] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: GRANT1237server # [ 113.410404] postgres[1119]: ::1 2026-10-27 16:09:50.920 UTC [1119] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1238server # [ 113.424644] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: GRANT1239server # [ 113.426864] postgres[1119]: ::1 2026-10-27 16:09:50.933 UTC [1119] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;1240server # [ 113.440637] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: ALTER TABLE1241server # [ 113.442616] postgres[1119]: ::1 2026-10-27 16:09:50.949 UTC [1119] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;1242server # [ 113.451500] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: ALTER TABLE1243server # [ 113.455523] postgres[1119]: ::1 2026-10-27 16:09:50.964 UTC [1119] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;1244server # [ 113.461043] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: ALTER TABLE1245server # [ 113.465396] postgres[1119]: ::1 2026-10-27 16:09:50.972 UTC [1119] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;1246server # [ 113.470325] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: ALTER TABLE1247server # [ 113.474707] postgres[1119]: ::1 2026-10-27 16:09:50.982 UTC [1119] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;1248server # [ 113.479341] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: ALTER TABLE1249server # [ 113.483958] postgres[1119]: ::1 2026-10-27 16:09:50.991 UTC [1119] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres;1250server # [ 113.494071] postgres[1119]: ::1 2026-10-27 16:09:50.997 UTC [1119] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;1251server # [ 113.495622] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: GRANT1252server # [ 113.496301] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: GRANT1253server # [ 113.500482] postgres[1119]: ::1 2026-10-27 16:09:51.005 UTC [1119] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;1254server # [ 113.505707] postgres[1119]: ::1 2026-10-27 16:09:51.013 UTC [1119] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;1255server # [ 113.507585] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: GRANT1256server # [ 113.513248] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: GRANT1257server # [ 113.517345] postgres[1119]: ::1 2026-10-27 16:09:51.025 UTC [1119] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user;1258server # [ 113.532193] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: ALTER DEFAULT PRIVILEGES1259server # [ 113.534282] postgres[1119]: ::1 2026-10-27 16:09:51.040 UTC [1119] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1260server # [ 113.540630] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: ALTER DEFAULT PRIVILEGES1261server # [ 113.542003] postgres[1119]: ::1 2026-10-27 16:09:51.050 UTC [1119] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user;1262server # [ 113.549086] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1118]: ALTER DEFAULT PRIVILEGES1263server # [ 113.590291] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql1264server # [ 113.766455] postgres[1121]: ::1 2026-10-27 16:09:51.272 UTC [1121] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime;1265server # [ 113.792077] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1120]: CREATE SCHEMA1266server # [ 113.829961] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql1267server # [ 114.000817] postgres[1123]: ::1 2026-10-27 16:09:51.508 UTC [1123] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres;1268server # [ 114.027925] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1122]: GRANT1269server # [ 114.035338] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1122]: GRANT1270server # [ 114.041416] postgres[1123]: ::1 2026-10-27 16:09:51.531 UTC [1123] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;1271server # [ 114.053932] postgres[1123]: ::1 2026-10-27 16:09:51.541 UTC [1123] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;1272server # [ 114.068898] postgres[1123]: ::1 2026-10-27 16:09:51.548 UTC [1123] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;1273server # [ 114.074021] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1122]: GRANT1274server # [ 114.079656] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1122]: GRANT1275server # [ 114.084556] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql1276server # [ 114.259453] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1124]: DO1277server # [ 114.266274] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1124]: DO1278server # [ 114.275565] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1124]: DO1279server # [ 114.314913] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql1280server # [ 114.450255] postgres[1127]: ::1 2026-10-27 16:09:51.954 UTC [1127] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user;1281server # [ 114.461301] postgres[1127]: ::1 2026-10-27 16:09:51.968 UTC [1127] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1282server # [ 114.472610] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1126]: ALTER DEFAULT PRIVILEGES1283server # [ 114.479380] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1126]: ALTER DEFAULT PRIVILEGES1284server # [ 114.487782] postgres[1127]: ::1 2026-10-27 16:09:51.975 UTC [1127] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user;1285server # [ 114.493590] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1126]: ALTER DEFAULT PRIVILEGES1286server # [ 114.495850] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql1287server # [ 114.657548] postgres[1129]: ::1 2026-10-27 16:09:52.164 UTC [1129] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';1288server # [ 114.677122] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1128]: ALTER ROLE1289server # [ 114.690969] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql1290server # [ 114.893245] postgres[1131]: ::1 2026-10-27 16:09:52.391 UTC [1131] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1291server # [ 114.895551] postgres[1131]: ::1 2026-10-27 16:09:52.400 UTC [1131] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1292server # [ 114.918569] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1293server # [ 114.923245] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: DROP EVENT TRIGGER1294server # [ 114.930418] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1295server # [ 114.933371] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: DROP FUNCTION1296server # [ 114.940109] postgres[1131]: ::1 2026-10-27 16:09:52.412 UTC [1131] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1297server # [ 114.945732] postgres[1131]: DECLARE1298server # [ 114.950422] postgres[1131]: cmd record;1299server # [ 114.954089] postgres[1131]: BEGIN1300server # [ 114.959790] postgres[1131]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1301server # [ 114.965776] postgres[1131]: LOOP1302server # [ 114.970874] postgres[1131]: IF cmd.command_tag IN (1303server # [ 114.979691] postgres[1131]: 'CREATE SCHEMA', 'ALTER SCHEMA'1304server # [ 114.990621] postgres[1131]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1305server # [ 115.004637] postgres[1131]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1306server # [ 115.006322] postgres[1131]: , 'CREATE VIEW', 'ALTER VIEW'1307server # [ 115.012630] postgres[1131]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1308server # [ 115.021825] postgres[1131]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1309server # [ 115.023370] postgres[1131]: , 'CREATE TRIGGER'1310server # [ 115.025338] postgres[1131]: , 'CREATE TYPE'1311server # [ 115.026528] postgres[1131]: , 'CREATE RULE'1312server # [ 115.029176] postgres[1131]: , 'COMMENT'1313server # [ 115.033375] postgres[1131]: )1314server # [ 115.037085] postgres[1131]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1315server # [ 115.039041] postgres[1131]: AND cmd.schema_name is distinct from 'pg_temp'1316server # [ 115.041477] postgres[1131]: THEN1317server # [ 115.050073] postgres[1131]: NOTIFY pgrst, 'reload schema';1318server # [ 115.052559] postgres[1131]: END IF;1319server # [ 115.060763] postgres[1131]: END LOOP;1320server # [ 115.062292] postgres[1131]: END; $$ LANGUAGE plpgsql;1321server # [ 115.064616] postgres[1131]: ::1 2026-10-27 16:09:52.429 UTC [1131] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1322server # [ 115.066622] postgres[1131]: DECLARE1323server # [ 115.072906] postgres[1131]: obj record;1324server # [ 115.074157] postgres[1131]: BEGIN1325server # [ 115.075566] postgres[1131]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1326server # [ 115.076314] postgres[1131]: LOOP1327server # [ 115.083663] postgres[1131]: IF obj.object_type IN (1328server # [ 115.085856] postgres[1131]: 'schema'1329server # [ 115.087415] postgres[1131]: , 'table'1330server # [ 115.089982] postgres[1131]: , 'foreign table'1331server # [ 115.091291] postgres[1131]: , 'view'1332server # [ 115.096782] postgres[1131]: , 'materialized view'1333server # [ 115.099091] postgres[1131]: , 'function'1334server # [ 115.100734] postgres[1131]: , 'trigger'1335server # [ 115.101818] postgres[1131]: , 'type'1336server # [ 115.102806] postgres[1131]: , 'rule'1337server # [ 115.111185] postgres[1131]: )1338server # [ 115.113216] postgres[1131]: AND obj.is_temporary IS false -- no pg_temp objects1339server # [ 115.115126] postgres[1131]: THEN1340server # [ 115.116697] postgres[1131]: NOTIFY pgrst, 'reload schema';1341server # [ 115.119202] postgres[1131]: END IF;1342server # [ 115.125920] postgres[1131]: END LOOP;1343server # [ 115.134588] postgres[1131]: END; $$ LANGUAGE plpgsql;1344server # [ 115.135806] postgres[1131]: ::1 2026-10-27 16:09:52.439 UTC [1131] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1345server # [ 115.138084] postgres[1131]: ::1 2026-10-27 16:09:52.444 UTC [1131] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1346server # [ 115.140841] postgres[1131]: ON ddl_command_end1347server # [ 115.144757] postgres[1131]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1348server # [ 115.146325] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: CREATE FUNCTION1349server # [ 115.155485] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: CREATE FUNCTION1350server # [ 115.161960] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping1351server # [ 115.164087] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: DROP EVENT TRIGGER1352server # [ 115.165844] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: CREATE EVENT TRIGGER1353server # [ 115.167567] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping1354server # [ 115.173775] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: DROP EVENT TRIGGER1355server # [ 115.175712] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1130]: CREATE EVENT TRIGGER1356server # [ 115.186183] postgres[1131]: ::1 2026-10-27 16:09:52.452 UTC [1131] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1357server # [ 115.188173] postgres[1131]: ::1 2026-10-27 16:09:52.458 UTC [1131] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1358server # [ 115.190675] postgres[1131]: ON sql_drop1359server # [ 115.197763] postgres[1131]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1360server # [ 115.203247] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql1361server # [ 115.848280] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1132]: DO1362server # [ 115.870550] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql1363server # [ 116.231419] postgres[1155]: ::1 2026-10-27 16:09:53.729 UTC [1155] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public;1364server # [ 116.294277] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: CREATE SCHEMA1365server # [ 116.321263] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping1366server # [ 116.323444] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: DROP FUNCTION1367server # [ 116.329085] postgres[1155]: ::1 2026-10-27 16:09:53.799 UTC [1155] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb);1368server # [ 116.330625] postgres[1155]: ::1 2026-10-27 16:09:53.815 UTC [1155] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1369server # [ 116.332405] postgres[1155]: "operationName" text default null,1370server # [ 116.337679] postgres[1155]: query text default null,1371server # [ 116.338925] postgres[1155]: variables jsonb default null,1372server # [ 116.343766] postgres[1155]: extensions jsonb default null1373server # [ 116.345942] postgres[1155]: )1374server # [ 116.347678] postgres[1155]: returns jsonb1375server # [ 116.349614] postgres[1155]: language plpgsql1376server # [ 116.352930] postgres[1155]: as $$1377server # [ 116.354570] postgres[1155]: DECLARE1378server # [ 116.361363] postgres[1155]: server_version float;1379server # [ 116.362591] postgres[1155]: BEGIN1380server # [ 116.368781] postgres[1155]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1381server # [ 116.370351] postgres[1155]:1382server # [ 116.372352] postgres[1155]: IF server_version >= 14 THEN1383server # [ 116.374264] postgres[1155]: RETURN jsonb_build_object(1384server # [ 116.376649] postgres[1155]: 'data', null::jsonb,1385server # [ 116.379134] postgres[1155]: 'errors', array['pg_graphql extension is not enabled.']1386server # [ 116.381564] postgres[1155]: );1387server # [ 116.383507] postgres[1155]: ELSE1388server # [ 116.385333] postgres[1155]: RETURN jsonb_build_object(1389server # [ 116.387449] postgres[1155]: 'data', null::jsonb,1390server # [ 116.389641] postgres[1155]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1391server # [ 116.391469] postgres[1155]: );1392server # [ 116.393126] postgres[1155]: END IF;1393server # [ 116.394212] postgres[1155]: END;1394server # [ 116.396901] postgres[1155]: $$;1395server # [ 116.398536] postgres[1155]: ::1 2026-10-27 16:09:53.867 UTC [1155] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;1396server # [ 116.402277] postgres[1155]: ::1 2026-10-27 16:09:53.892 UTC [1155] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;1397server # [ 116.404739] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: CREATE FUNCTION1398server # [ 116.407336] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: GRANT1399server # [ 116.409047] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: ALTER DEFAULT PRIVILEGES1400server # [ 116.410442] postgres[1155]: ::1 2026-10-27 16:09:53.917 UTC [1155] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;1401server # [ 116.419169] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: ALTER DEFAULT PRIVILEGES1402server # [ 116.420536] postgres[1155]: ::1 2026-10-27 16:09:53.929 UTC [1155] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;1403server # [ 116.431249] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: ALTER DEFAULT PRIVILEGES1404server # [ 116.433279] postgres[1155]: ::1 2026-10-27 16:09:53.942 UTC [1155] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1405server # [ 116.435692] postgres[1155]: on sequences to postgres, anon, authenticated, service_role;1406server # [ 116.440901] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: ALTER DEFAULT PRIVILEGES1407server # [ 116.442109] postgres[1155]: ::1 2026-10-27 16:09:53.951 UTC [1155] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1408server # [ 116.445274] postgres[1155]: on tables to postgres, anon, authenticated, service_role;1409server # [ 116.448650] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: ALTER DEFAULT PRIVILEGES1410server # [ 116.454616] postgres[1155]: ::1 2026-10-27 16:09:53.963 UTC [1155] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1411server # [ 116.459157] postgres[1155]: on functions to postgres, anon, authenticated, service_role;1412server # [ 116.462389] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: ALTER DEFAULT PRIVILEGES1413server # [ 116.465519] postgres[1155]: ::1 2026-10-27 16:09:53.974 UTC [1155] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()1414server # [ 116.468142] postgres[1155]: RETURNS event_trigger1415server # [ 116.470211] postgres[1155]: LANGUAGE plpgsql1416server # [ 116.473997] postgres[1155]: AS $func$1417server # [ 116.475485] postgres[1155]: DECLARE1418server # [ 116.476760] postgres[1155]: func_is_graphql_resolve bool;1419server # [ 116.478480] postgres[1155]: BEGIN1420server # [ 116.480501] postgres[1155]: func_is_graphql_resolve = (1421server # [ 116.482620] postgres[1155]: SELECT n.proname = 'resolve'1422server # [ 116.484914] postgres[1155]: FROM pg_event_trigger_ddl_commands() AS ev1423server # [ 116.489545] postgres[1155]: LEFT JOIN pg_catalog.pg_proc AS n1424server # [ 116.490675] postgres[1155]: ON ev.objid = n.oid1425server # [ 116.492729] postgres[1155]: );1426server # [ 116.493467] postgres[1155]:1427server # [ 116.496963] postgres[1155]: IF func_is_graphql_resolve1428server # [ 116.497844] postgres[1155]: THEN1429server # [ 116.500825] postgres[1155]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1430server # [ 116.502221] postgres[1155]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1431server # [ 116.512043] postgres[1155]:1432server # [ 116.513366] postgres[1155]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1433server # [ 116.514022] postgres[1155]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1434server # [ 116.514718] postgres[1155]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1435server # [ 116.515756] postgres[1155]:1436server # [ 116.517107] postgres[1155]: DROP FUNCTION IF EXISTS graphql_public.graphql;1437server # [ 116.518394] postgres[1155]: create or replace function graphql_public.graphql(1438server # [ 116.519924] postgres[1155]: "operationName" text default null,1439server # [ 116.521794] postgres[1155]: query text default null,1440server # [ 116.523335] postgres[1155]: variables jsonb default null,1441server # [ 116.527341] postgres[1155]: extensions jsonb default null1442server # [ 116.529105] postgres[1155]: )1443server # [ 116.529897] postgres[1155]: returns jsonb1444server # [ 116.534515] postgres[1155]: language sql1445server # [ 116.535693] postgres[1155]: as $$1446server # [ 116.537777] postgres[1155]: SELECT graphql.resolve(query, coalesce(variables, '{}'));1447server # [ 116.543101] postgres[1155]: $$;1448server # [ 116.546047] postgres[1155]:1449server # [ 116.549600] postgres[1155]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1450server # [ 116.550810] postgres[1155]: END IF;1451server # [ 116.554477] postgres[1155]:1452server # [ 116.557394] postgres[1155]: END;1453server # [ 116.563576] postgres[1155]: $func$;1454server # [ 116.567240] postgres[1155]: ::1 2026-10-27 16:09:53.990 UTC [1155] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;1455server # [ 116.579065] postgres[1155]: ::1 2026-10-27 16:09:53.994 UTC [1155] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')1456server # [ 116.579988] postgres[1155]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access();1457server # [ 116.585795] postgres[1155]: ::1 2026-10-27 16:09:54.000 UTC [1155] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';1458server # [ 116.591763] postgres[1155]: ::1 2026-10-27 16:09:54.009 UTC [1155] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1459server # [ 116.597301] postgres[1155]: RETURNS event_trigger1460server # [ 116.599385] postgres[1155]: LANGUAGE plpgsql1461server # [ 116.606045] postgres[1155]: AS $func$1462server # [ 116.607696] postgres[1155]: DECLARE1463server # [ 116.609992] postgres[1155]: graphql_is_dropped bool;1464server # [ 116.611494] postgres[1155]: BEGIN1465server # [ 116.612980] postgres[1155]: graphql_is_dropped = (1466server # [ 116.614970] postgres[1155]: SELECT ev.schema_name = 'graphql_public'1467server # [ 116.617380] postgres[1155]: FROM pg_event_trigger_dropped_objects() AS ev1468server # [ 116.619482] postgres[1155]: WHERE ev.schema_name = 'graphql_public'1469server # [ 116.623420] postgres[1155]: );1470server # [ 116.626844] postgres[1155]:1471server # [ 116.633284] postgres[1155]: IF graphql_is_dropped1472server # [ 116.634338] postgres[1155]: THEN1473server # [ 116.636151] postgres[1155]: create or replace function graphql_public.graphql(1474server # [ 116.637888] postgres[1155]: "operationName" text default null,1475server # [ 116.641157] postgres[1155]: query text default null,1476server # [ 116.646411] postgres[1155]: variables jsonb default null,1477server # [ 116.647392] postgres[1155]: extensions jsonb default null1478server # [ 116.647851] postgres[1155]: )1479server # [ 116.649534] postgres[1155]: returns jsonb1480server # [ 116.651682] postgres[1155]: language plpgsql1481server # [ 116.654493] postgres[1155]: as $$1482server # [ 116.655913] postgres[1155]: DECLARE1483server # [ 116.657767] postgres[1155]: server_version float;1484server # [ 116.661425] postgres[1155]: BEGIN1485server # [ 116.664134] postgres[1155]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1486server # [ 116.666263] postgres[1155]:1487server # [ 116.670351] postgres[1155]: IF server_version >= 14 THEN1488server # [ 116.672724] postgres[1155]: RETURN jsonb_build_object(1489server # [ 116.674406] postgres[1155]: 'data', null::jsonb,1490server # [ 116.675838] postgres[1155]: 'errors', array['pg_graphql extension is not enabled.']1491server # [ 116.681433] postgres[1155]: );1492server # [ 116.682338] postgres[1155]: ELSE1493server # [ 116.683577] postgres[1155]: RETURN jsonb_build_object(1494server # [ 116.685498] postgres[1155]: 'data', null::jsonb,1495server # [ 116.686948] postgres[1155]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1496server # [ 116.688058] postgres[1155]: );1497server # [ 116.690493] postgres[1155]: END IF;1498server # [ 116.697606] postgres[1155]: END;1499server # [ 116.701206] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: CREATE FUNCTION1500server # [ 116.702314] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping1501server # [ 116.705102] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: DROP EVENT TRIGGER1502server # [ 116.706236] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: CREATE EVENT TRIGGER1503server # [ 116.707414] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: COMMENT1504server # [ 116.709767] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: CREATE FUNCTION1505server # [ 116.713587] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping1506server # [ 116.716747] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: DROP EVENT TRIGGER1507server # [ 116.722248] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: CREATE EVENT TRIGGER1508server # [ 116.723526] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1153]: COMMENT1509server # [ 116.725088] postgres[1155]: $$;1510server # [ 116.726225] postgres[1155]: END IF;1511server # [ 116.727304] postgres[1155]:1512server # [ 116.739267] postgres[1155]: END;1513server # [ 116.741601] postgres[1155]: $func$;1514server # [ 116.742862] postgres[1155]: ::1 2026-10-27 16:09:54.035 UTC [1155] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;1515server # [ 116.746136] postgres[1155]: ::1 2026-10-27 16:09:54.044 UTC [1155] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')1516server # [ 116.748339] postgres[1155]: EXECUTE PROCEDURE extensions.set_graphql_placeholder();1517server # [ 116.749670] postgres[1155]: ::1 2026-10-27 16:09:54.052 UTC [1155] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';1518server # [ 116.760898] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql1519server # [ 116.850215] postgres[1157]: ::1 2026-10-27 16:09:54.356 UTC [1157] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1520server # [ 116.858674] postgres[1157]: ::1 2026-10-27 16:09:54.363 UTC [1157] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1521server # [ 116.878430] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1522server # [ 116.886817] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: DROP EVENT TRIGGER1523server # [ 116.891110] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1524server # [ 116.896316] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: DROP FUNCTION1525server # [ 116.899349] postgres[1157]: ::1 2026-10-27 16:09:54.379 UTC [1157] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1526server # [ 116.905516] postgres[1157]: DECLARE1527server # [ 116.913361] postgres[1157]: cmd record;1528server # [ 116.914731] postgres[1157]: BEGIN1529server # [ 116.916577] postgres[1157]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1530server # [ 116.918188] postgres[1157]: LOOP1531server # [ 116.921665] postgres[1157]: IF cmd.command_tag IN (1532server # [ 116.923160] postgres[1157]: 'CREATE SCHEMA', 'ALTER SCHEMA'1533server # [ 116.932682] postgres[1157]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1534server # [ 116.935194] postgres[1157]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1535server # [ 116.936033] postgres[1157]: , 'CREATE VIEW', 'ALTER VIEW'1536server # [ 116.937887] postgres[1157]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1537server # [ 116.938582] postgres[1157]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1538server # [ 116.939997] postgres[1157]: , 'CREATE TRIGGER'1539server # [ 116.945101] postgres[1157]: , 'CREATE TYPE', 'ALTER TYPE'1540server # [ 116.946234] postgres[1157]: , 'CREATE RULE'1541server # [ 116.955698] postgres[1157]: , 'COMMENT'1542server # [ 116.958176] postgres[1157]: )1543server # [ 116.959335] postgres[1157]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1544server # [ 116.962193] postgres[1157]: AND cmd.schema_name is distinct from 'pg_temp'1545server # [ 116.971744] postgres[1157]: THEN1546server # [ 116.990385] postgres[1157]: NOTIFY pgrst, 'reload schema';1547server # [ 116.998650] postgres[1157]: END IF;1548server # [ 117.004305] postgres[1157]: END LOOP;1549server # [ 117.024990] postgres[1157]: END; $$ LANGUAGE plpgsql;1550server # [ 117.031481] postgres[1157]: ::1 2026-10-27 16:09:54.421 UTC [1157] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1551server # [ 117.041458] postgres[1157]: DECLARE1552server # [ 117.043777] postgres[1157]: obj record;1553server # [ 117.045468] postgres[1157]: BEGIN1554server # [ 117.046694] postgres[1157]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1555server # [ 117.051409] postgres[1157]: LOOP1556server # [ 117.055373] postgres[1157]: IF obj.object_type IN (1557server # [ 117.057022] postgres[1157]: 'schema'1558server # [ 117.062233] postgres[1157]: , 'table'1559server # [ 117.063952] postgres[1157]: , 'foreign table'1560server # [ 117.066417] postgres[1157]: , 'view'1561server # [ 117.069218] postgres[1157]: , 'materialized view'1562server # [ 117.070498] postgres[1157]: , 'function'1563server # [ 117.071361] postgres[1157]: , 'trigger'1564server # [ 117.077004] postgres[1157]: , 'type'1565server # [ 117.081268] postgres[1157]: , 'rule'1566server # [ 117.082315] postgres[1157]: )1567server # [ 117.089473] postgres[1157]: AND obj.is_temporary IS false -- no pg_temp objects1568server # [ 117.092017] postgres[1157]: THEN1569server # [ 117.095138] postgres[1157]: NOTIFY pgrst, 'reload schema';1570server # [ 117.103266] postgres[1157]: END IF;1571server # [ 117.110078] postgres[1157]: END LOOP;1572server # [ 117.115547] postgres[1157]: END; $$ LANGUAGE plpgsql;1573server # [ 117.117480] postgres[1157]: ::1 2026-10-27 16:09:54.445 UTC [1157] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1574server # [ 117.118956] postgres[1157]: ::1 2026-10-27 16:09:54.456 UTC [1157] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1575server # [ 117.121928] postgres[1157]: ON ddl_command_end1576server # [ 117.123841] postgres[1157]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1577server # [ 117.126866] postgres[1157]: ::1 2026-10-27 16:09:54.463 UTC [1157] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1578server # [ 117.129756] postgres[1157]: ::1 2026-10-27 16:09:54.469 UTC [1157] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1579server # [ 117.132875] postgres[1157]: ON sql_drop1580server # [ 117.135155] postgres[1157]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1581server # [ 117.137745] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: CREATE FUNCTION1582server # [ 117.138608] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: CREATE FUNCTION1583server # [ 117.140687] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: DROP EVENT TRIGGER1584server # [ 117.142821] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: CREATE EVENT TRIGGER1585server # [ 117.145486] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: DROP EVENT TRIGGER1586server # [ 117.147516] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: CREATE EVENT TRIGGER1587server # [ 117.157471] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1588server # [ 117.169069] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql1589server # [ 117.320975] postgres[1160]: ::1 2026-10-27 16:09:54.825 UTC [1160] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;1590server # [ 117.350364] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1158]: ALTER ROLE1591server # [ 117.395596] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql1592server # [ 117.678777] postgres[1163]: ::1 2026-10-27 16:09:55.182 UTC [1163] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1593server # [ 117.686923] postgres[1163]: returns event_trigger1594server # [ 117.699275] postgres[1163]: language plpgsql1595server # [ 117.711140] postgres[1163]: AS $func$1596server # [ 117.714785] postgres[1163]: DECLARE1597server # [ 117.723122] postgres[1163]: func_is_graphql_resolve bool;1598server # [ 117.733255] postgres[1163]: BEGIN1599server # [ 117.738035] postgres[1163]: func_is_graphql_resolve = (1600server # [ 117.743544] postgres[1163]: SELECT n.proname = 'resolve'1601server # [ 117.748446] postgres[1163]: FROM pg_event_trigger_ddl_commands() AS ev1602server # [ 117.751770] postgres[1163]: LEFT JOIN pg_catalog.pg_proc AS n1603server # [ 117.777799] postgres[1163]: ON ev.objid = n.oid1604server # [ 117.783528] postgres[1163]: );1605server # [ 117.791164] postgres[1163]:1606server # [ 117.805829] postgres[1163]: IF func_is_graphql_resolve1607server # [ 117.810389] postgres[1163]: THEN1608server # [ 117.811430] postgres[1163]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1609server # [ 117.811978] postgres[1163]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1610server # [ 117.817045] postgres[1163]:1611server # [ 117.822092] postgres[1163]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1612server # [ 117.837321] postgres[1163]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1613server # [ 117.838687] postgres[1163]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1614server # [ 117.839680] postgres[1163]:1615server # [ 117.840182] postgres[1163]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1616server # [ 117.842298] postgres[1163]: DROP FUNCTION IF EXISTS graphql_public.graphql;1617server # [ 117.843721] postgres[1163]: create or replace function graphql_public.graphql(1618server # [ 117.845258] postgres[1163]: "operationName" text default null,1619server # [ 117.850113] postgres[1163]: query text default null,1620server # [ 117.851273] postgres[1163]: variables jsonb default null,1621server # [ 117.854841] postgres[1163]: extensions jsonb default null1622server # [ 117.869227] postgres[1163]: )1623server # [ 117.870210] postgres[1163]: returns jsonb1624server # [ 117.871277] postgres[1163]: language sql1625server # [ 117.871792] postgres[1163]: as $$1626server # [ 117.873932] postgres[1163]: -- This changed1627server # [ 117.875796] postgres[1163]: select graphql.resolve(1628server # [ 117.883724] postgres[1163]: query := query,1629server # [ 117.893205] postgres[1163]: variables := coalesce(variables, '{}'),1630server # [ 117.907328] postgres[1163]: "operationName" := "operationName",1631server # [ 117.909627] postgres[1163]: extensions := extensions1632server # [ 117.921111] postgres[1163]: );1633server # [ 117.922549] postgres[1163]: $$;1634server # [ 117.924533] postgres[1163]:1635server # [ 117.927354] postgres[1163]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1636server # [ 118.030070] 8021q: 802.1Q VLAN Support v1.81637server # [ 117.937257] postgres[1163]: END IF;1638server # [ 117.938754] postgres[1163]:1639server # [ 117.944015] postgres[1163]: END;1640server # [ 117.947935] postgres[1163]: $func$;1641server # [ 117.983480] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1161]: CREATE FUNCTION1642server # [ 117.987813] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1161]: CREATE FUNCTION1643server # [ 117.998470] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1161]: CREATE FUNCTION1644server # [ 118.005034] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1161]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping1645server # [ 118.010710] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1161]: DROP EXTENSION1646server # [ 118.014817] postgres[1163]: ::1 2026-10-27 16:09:55.279 UTC [1163] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1647server # [ 118.019781] postgres[1163]: RETURNS event_trigger1648server # [ 118.021872] postgres[1163]: LANGUAGE plpgsql1649server # [ 118.024899] postgres[1163]: AS $func$1650server # [ 118.028006] postgres[1163]: DECLARE1651server # [ 118.030320] postgres[1163]: graphql_is_dropped bool;1652server # [ 118.031726] postgres[1163]: BEGIN1653server # [ 118.034011] postgres[1163]: graphql_is_dropped = (1654server # [ 118.037518] postgres[1163]: SELECT ev.schema_name = 'graphql_public'1655server # [ 118.039430] postgres[1163]: FROM pg_event_trigger_dropped_objects() AS ev1656server # [ 118.041448] postgres[1163]: WHERE ev.schema_name = 'graphql_public'1657server # [ 118.042703] postgres[1163]: );1658server # [ 118.043820] postgres[1163]:1659server # [ 118.046218] postgres[1163]: IF graphql_is_dropped1660server # [ 118.050592] postgres[1163]: THEN1661server # [ 118.053379] postgres[1163]: create or replace function graphql_public.graphql(1662server # [ 118.055064] postgres[1163]: "operationName" text default null,1663server # [ 118.056708] postgres[1163]: query text default null,1664server # [ 118.059843] postgres[1163]: variables jsonb default null,1665server # [ 118.063737] postgres[1163]: extensions jsonb default null1666server # [ 118.066850] postgres[1163]: )1667server # [ 118.068044] postgres[1163]: returns jsonb1668server # [ 118.072570] postgres[1163]: language plpgsql1669server # [ 118.074802] postgres[1163]: as $$1670server # [ 118.078177] postgres[1163]: DECLARE1671server # [ 118.086112] postgres[1163]: server_version float;1672server # [ 118.090766] postgres[1163]: BEGIN1673server # [ 118.097998] postgres[1163]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1674server # [ 118.105607] postgres[1163]:1675server # [ 118.113696] postgres[1163]: IF server_version >= 14 THEN1676server # [ 118.125975] postgres[1163]: RETURN jsonb_build_object(1677server # [ 118.141487] postgres[1163]: 'errors', jsonb_build_array(1678server # [ 118.158530] postgres[1163]: jsonb_build_object(1679server # [ 118.173321] postgres[1163]: 'message', 'pg_graphql extension is not enabled.'1680server # [ 118.182430] postgres[1163]: )1681server # [ 118.189646] postgres[1163]: )1682server # [ 118.209711] postgres[1163]: );1683server # [ 118.217163] postgres[1163]: ELSE1684server # [ 118.219347] postgres[1163]: RETURN jsonb_build_object(1685server # [ 118.225261] postgres[1163]: 'errors', jsonb_build_array(1686server # [ 118.233631] postgres[1163]: jsonb_build_object(1687server # [ 118.235340] postgres[1163]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1688server # [ 118.246072] postgres[1163]: )1689server # [ 118.249299] postgres[1163]: )1690server # [ 118.254338] postgres[1163]: );1691server # [ 118.262366] postgres[1163]: END IF;1692server # [ 118.276326] postgres[1163]: END;1693server # [ 118.277835] postgres[1163]: $$;1694server # [ 118.278575] postgres[1163]: END IF;1695server # [ 118.285016] postgres[1163]:1696server # [ 118.286699] postgres[1163]: END;1697server # [ 118.293079] postgres[1163]: $func$;1698server # [ 118.305019] postgres[1163]: ::1 2026-10-27 16:09:55.309 UTC [1163] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1699server # [ 118.310181] postgres[1163]: "operationName" text default null,1700server # [ 118.314523] postgres[1163]: query text default null,1701server # [ 118.322304] postgres[1163]: variables jsonb default null,1702server # [ 118.327311] postgres[1163]: extensions jsonb default null1703server # [ 118.337318] postgres[1163]: )1704server # [ 118.345859] postgres[1163]: returns jsonb1705server # [ 118.347542] postgres[1163]: language plpgsql1706server # [ 118.352999] postgres[1163]: as $$1707server # [ 118.355274] postgres[1163]: DECLARE1708server # [ 118.365123] postgres[1163]: server_version float;1709server # [ 118.366282] postgres[1163]: BEGIN1710server # [ 118.367378] postgres[1163]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1711server # [ 118.374690] postgres[1163]:1712server # [ 118.382046] postgres[1163]: IF server_version >= 14 THEN1713server # [ 118.383495] postgres[1163]: RETURN jsonb_build_object(1714server # [ 118.385528] postgres[1163]: 'errors', jsonb_build_array(1715server # [ 118.389512] postgres[1163]: jsonb_build_object(1716server # [ 118.393916] postgres[1163]: 'message', 'pg_graphql extension is not enabled.'1717server # [ 118.403428] postgres[1163]: )1718server # [ 118.410423] postgres[1163]: )1719server # [ 118.417092] postgres[1163]: );1720server # [ 118.427431] postgres[1163]: ELSE1721server # [ 118.433498] postgres[1163]: RETURN jsonb_build_object(1722server # [ 118.436032] postgres[1163]: 'errors', jsonb_build_array(1723server # [ 118.445255] postgres[1163]: jsonb_build_object(1724server # [ 118.446564] postgres[1163]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1725server # [ 118.451597] postgres[1163]: )1726server # [ 118.458484] postgres[1163]: )1727server # [ 118.466913] postgres[1163]: );1728server # [ 118.471765] postgres[1163]: END IF;1729server # [ 118.477189] postgres[1163]: END;1730server # [ 118.479700] postgres[1163]: $$;1731server # [ 118.482854] postgres[1163]: ::1 2026-10-27 16:09:55.334 UTC [1163] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1732server # [ 119.012573] cfg80211: Loading compiled-in X.509 certificates for regulatory database1733server: Guest root shell did not produce any data yet...1734server: To debug, enter the VM and run 'systemctl status backdoor.service'.1735server # [ 119.320870] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1736server # [ 119.321718] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1737server # [ 119.345266] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21738server # [ 119.345923] cfg80211: failed to load regulatory.db1739server # [ 119.644004] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1161]: DO1740server # [ 119.691384] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql1741server # [ 119.963935] postgres[1181]: ::1 2026-10-27 16:09:57.469 UTC [1181] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres;1742server # [ 119.998805] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1174]: GRANT ROLE1743server # [ 120.021100] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql1744server # [ 120.250677] postgres[1191]: ::1 2026-10-27 16:09:57.757 UTC [1191] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1745server # [ 120.259828] postgres[1191]: returns event_trigger1746server # [ 120.261392] postgres[1191]: language plpgsql1747server # [ 120.262401] postgres[1191]: AS $func$1748server # [ 120.263451] postgres[1191]: DECLARE1749server # [ 120.268750] postgres[1191]: func_is_graphql_resolve bool;1750server # [ 120.269931] postgres[1191]: BEGIN1751server # [ 120.270688] postgres[1191]: func_is_graphql_resolve = (1752server # [ 120.273503] postgres[1191]: SELECT n.proname = 'resolve'1753server # [ 120.275406] postgres[1191]: FROM pg_event_trigger_ddl_commands() AS ev1754server # [ 120.281260] postgres[1191]: LEFT JOIN pg_catalog.pg_proc AS n1755server # [ 120.282142] postgres[1191]: ON ev.objid = n.oid1756server # [ 120.283154] postgres[1191]: );1757server # [ 120.284048] postgres[1191]:1758server # [ 120.289073] postgres[1191]: IF func_is_graphql_resolve1759server # [ 120.289995] postgres[1191]: THEN1760server # [ 120.291150] postgres[1191]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1761server # [ 120.299854] postgres[1191]: DROP FUNCTION IF EXISTS graphql_public.graphql;1762server # [ 120.301658] postgres[1191]: create or replace function graphql_public.graphql(1763server # [ 120.302597] postgres[1191]: "operationName" text default null,1764server # [ 120.303161] postgres[1191]: query text default null,1765server # [ 120.303664] postgres[1191]: variables jsonb default null,1766server # [ 120.304378] postgres[1191]: extensions jsonb default null1767server # [ 120.306207] postgres[1191]: )1768server # [ 120.312634] postgres[1191]: returns jsonb1769server # [ 120.313785] postgres[1191]: language sql1770server # [ 120.314594] postgres[1191]: as $$1771server # [ 120.315521] postgres[1191]: select graphql.resolve(1772server # [ 120.316867] postgres[1191]: query := query,1773server # [ 120.321849] postgres[1191]: variables := coalesce(variables, '{}'),1774server # [ 120.322878] postgres[1191]: "operationName" := "operationName",1775server # [ 120.324288] postgres[1191]: extensions := extensions1776server # [ 120.325738] postgres[1191]: );1777server # [ 120.326600] postgres[1191]: $$;1778server # [ 120.331483] postgres[1191]:1779server # [ 120.333432] postgres[1191]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1780server # [ 120.335193] postgres[1191]: -- function in the extension so we need to grant permissions on existing entities AND1781server # [ 120.342439] postgres[1191]: -- update default permissions to any others that are created after `graphql.resolve`1782server # [ 120.344040] postgres[1191]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1783server # [ 120.345772] postgres[1191]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1784server # [ 120.347595] postgres[1191]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1785server # [ 120.354817] postgres[1191]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1786server # [ 120.357564] postgres[1191]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1787server # [ 120.365811] postgres[1191]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1788server # [ 120.369239] postgres[1191]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1789server # [ 120.371200] postgres[1191]: END IF;1790server # [ 120.377797] postgres[1191]:1791server # [ 120.379240] postgres[1191]: END;1792server # [ 120.381720] postgres[1191]: $func$;1793server # [ 120.382882] postgres[1191]: ::1 2026-10-27 16:09:57.827 UTC [1191] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1794server # [ 120.395396] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1189]: CREATE FUNCTION1795server # [ 120.404930] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1189]: DROP EXTENSION1796server # [ 121.553482] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1189]: DO1797server # [ 121.603282] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql1798server # [ 122.453562] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1193]: DO1799server # [ 122.611598] (udev-worker)[1197]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1800server # [ 122.625331] (udev-worker)[1197]: Network interface NamePolicy= disabled on kernel command line.1801server # [ 123.006064] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1193]: DO1802server # [ 123.055931] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql1803server # [ 123.252316] (udev-worker)[1196]: Network interface NamePolicy= disabled on kernel command line.1804server # [ 123.430870] postgres[1217]: ::1 2026-10-27 16:10:00.920 UTC [1217] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s';1805server # [ 123.454458] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1216]: ALTER ROLE1806server # [ 123.477972] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql1807server # [ 123.718148] postgres[1221]: ::1 2026-10-27 16:10:01.216 UTC [1221] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator;1808server # [ 123.738046] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1219]: REVOKE ROLE1809server # [ 123.766131] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql1810server # [ 123.806391] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1811server # [ 123.846956] systemd[1]: Started backdoor.service.1812server # [ 124.499482] systemd[1]: Condition check resulted in Virtio network device being skipped.1813server # [ 124.569077] systemd[1]: Starting Address configuration of eth1...1814server # connecting to host...1815server: Guest shell says: b'Spawning backdoor root shell...\n'1816server: connected to guest root shell1817server: (connecting took 126.18 seconds)1818server: (finished: waiting for the VM to finish booting, in 126.18 seconds)1819server # [ 126.061312] 8021q: adding VLAN 0 to HW filter on device eth11820server # [ 126.305402] network-addresses-eth1-start[1228]: adding address 192.168.1.1/24... done1821server # [ 126.481931] 8021q: adding VLAN 0 to HW filter on device eth01822server # [ 126.422757] dhcpcd[729]: eth0: waiting for carrier1823server # [ 126.434522] dhcpcd[729]: eth0: carrier acquired1824server # [ 126.579267] network-addresses-eth1-start[1228]: adding address 2001:db8:1::1/64... done1825server # [ 126.626883] dhcpcd[729]: DUID 00:01:00:01:32:73:89:5c:52:54:00:12:34:561826server # [ 126.633590] dhcpcd[729]: eth0: IAID 00:12:34:561827server # [ 126.635444] dhcpcd[729]: eth0: adding address fe80::5054:ff:fe12:34561828server # [ 126.652716] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1222]: DO1829server # [ 126.710909] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql1830server # [ 126.898883] systemd[1]: Finished Address configuration of eth1.1831server # [ 127.024929] postgres[1253]: ::1 2026-10-27 16:10:04.525 UTC [1253] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres;1832server # [ 127.046774] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1250]: GRANT ROLE1833server # [ 127.069283] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql1834server # [ 127.374256] postgres[1255]: ::1 2026-10-27 16:10:04.868 UTC [1255] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option;1835server # [ 127.419757] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1254]: GRANT1836server # [ 127.430708] postgres[1255]: ::1 2026-10-27 16:10:04.924 UTC [1255] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option;1837server # [ 127.479086] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1254]: GRANT1838server # [ 127.483882] postgres[1255]: ::1 2026-10-27 16:10:04.994 UTC [1255] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option;1839server # [ 127.493205] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1254]: GRANT1840server # [ 127.495418] postgres[1255]: ::1 2026-10-27 16:10:05.005 UTC [1255] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;1841server # [ 127.506326] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1254]: ALTER DEFAULT PRIVILEGES1842server # [ 127.512770] postgres[1255]: ::1 2026-10-27 16:10:05.020 UTC [1255] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;1843server # [ 127.523146] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1254]: ALTER DEFAULT PRIVILEGES1844server # [ 127.533080] postgres[1255]: ::1 2026-10-27 16:10:05.031 UTC [1255] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;1845server # [ 127.535432] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1254]: ALTER DEFAULT PRIVILEGES1846server # [ 127.577069] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql1847server # [ 127.819907] postgres[1257]: ::1 2026-10-27 16:10:05.318 UTC [1257] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres;1848server # [ 127.845124] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1256]: GRANT ROLE1849server # [ 127.858840] dhcpcd[729]: eth0: soliciting a DHCP lease1850server # [ 127.873504] dhcpcd[729]: eth0: offered 10.0.2.15 from 10.0.2.21851server # [ 127.917526] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql1852server # [ 127.922322] dhcpcd[729]: eth0: probing address 10.0.2.15/241853server # [ 128.199863] postgres[1263]: ::1 2026-10-27 16:10:05.691 UTC [1263] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin;1854server # [ 128.243250] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1258]: GRANT ROLE1855server # [ 128.250596] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql1856server # [ 128.590768] postgres[1265]: ::1 2026-10-27 16:10:06.079 UTC [1265] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit;1857server # [ 128.598944] postgres[1265]: ::1 2026-10-27 16:10:06.100 UTC [1265] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit;1858server # [ 128.621320] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1264]: ALTER ROLE1859server # [ 128.623038] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1264]: ALTER ROLE1860server # [ 128.624047] postgres[1265]: ::1 2026-10-27 16:10:06.118 UTC [1265] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit;1861server # [ 128.638946] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1264]: ALTER ROLE1862server # [ 128.653240] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1264]: DO1863server # [ 128.693578] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql1864server # [ 128.987793] postgres[1267]: ::1 2026-10-27 16:10:06.486 UTC [1267] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin;1865server # [ 129.010562] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1266]: GRANT ROLE1866server # [ 129.016125] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1266]: REVOKE ROLE1867server # [ 129.029002] postgres[1267]: ::1 2026-10-27 16:10:06.510 UTC [1267] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin;1868server # [ 129.084133] dhcpcd[729]: eth0: soliciting an IPv6 router1869server # [ 129.120042] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql1870server # [ 129.139560] dhcpcd[729]: eth0: Router Advertisement from fe80::21871server # [ 129.142919] dhcpcd[729]: eth0: adding address fec0::5054:ff:fe12:3456/641872server # [ 129.143958] dhcpcd[729]: eth0: adding route to fec0::/641873server # [ 129.150195] dhcpcd[729]: eth0: adding default route via fe80::21874server # [ 129.453819] postgres[1280]: ::1 2026-10-27 16:10:06.949 UTC [1280] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1875server # [ 129.455432] postgres[1280]: returns event_trigger1876server # [ 129.456974] postgres[1280]: language plpgsql1877server # [ 129.457868] postgres[1280]: AS $func$1878server # [ 129.458661] postgres[1280]: DECLARE1879server # [ 129.459479] postgres[1280]: func_is_graphql_resolve bool;1880server # [ 129.469020] postgres[1280]: BEGIN1881server # [ 129.469872] postgres[1280]: func_is_graphql_resolve = (1882server # [ 129.470697] postgres[1280]: SELECT n.proname = 'resolve'1883server # [ 129.472082] postgres[1280]: FROM pg_event_trigger_ddl_commands() AS ev1884server # [ 129.474136] postgres[1280]: LEFT JOIN pg_catalog.pg_proc AS n1885server # [ 129.475555] postgres[1280]: ON ev.objid = n.oid1886server # [ 129.475957] postgres[1280]: );1887server # [ 129.477590] postgres[1280]:1888server # [ 129.478136] postgres[1280]: IF func_is_graphql_resolve1889server # [ 129.478649] postgres[1280]: THEN1890server # [ 129.479353] postgres[1280]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1891server # [ 129.487445] postgres[1280]: DROP FUNCTION IF EXISTS graphql_public.graphql;1892server # [ 129.488822] postgres[1280]: create or replace function graphql_public.graphql(1893server # [ 129.493117] postgres[1280]: "operationName" text default null,1894server # [ 129.494138] postgres[1280]: query text default null,1895server # [ 129.495361] postgres[1280]: variables jsonb default null,1896server # [ 129.495974] postgres[1280]: extensions jsonb default null1897server # [ 129.502009] postgres[1280]: )1898server # [ 129.503595] postgres[1280]: returns jsonb1899server # [ 129.504020] postgres[1280]: language sql1900server # [ 129.505465] postgres[1280]: as $$1901server # [ 129.506044] postgres[1280]: select graphql.resolve(1902server # [ 129.507618] postgres[1280]: query := query,1903server # [ 129.508061] postgres[1280]: variables := coalesce(variables, '{}'),1904server # [ 129.511801] postgres[1280]: "operationName" := "operationName",1905server # [ 129.512292] postgres[1280]: extensions := extensions1906server # [ 129.513960] postgres[1280]: );1907server # [ 129.514317] postgres[1280]: $$;1908server # [ 129.514614] postgres[1280]:1909server # [ 129.515319] postgres[1280]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1910server # [ 129.515687] postgres[1280]: -- function in the extension so we need to grant permissions on existing entities AND1911server # [ 129.521996] postgres[1280]: -- update default permissions to any others that are created after `graphql.resolve`1912server # [ 129.524073] postgres[1280]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1913server # [ 129.525739] postgres[1280]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1914server # [ 129.526299] postgres[1280]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1915server # [ 129.527224] postgres[1280]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1916server # [ 129.527859] postgres[1280]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1917server # [ 129.533955] postgres[1280]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1918server # [ 129.537868] postgres[1280]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1919server # [ 129.539788] postgres[1280]:1920server # [ 129.540931] postgres[1280]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles1921server # [ 129.542308] postgres[1280]: grant usage on schema graphql_public to postgres with grant option;1922server # [ 129.543176] postgres[1280]: grant usage on schema graphql to postgres with grant option;1923server # [ 129.543972] postgres[1280]: END IF;1924server # [ 129.549408] postgres[1280]:1925server # [ 129.549958] postgres[1280]: END;1926server # [ 129.550488] postgres[1280]: $func$;1927server # [ 129.551238] postgres[1280]: ::1 2026-10-27 16:10:07.046 UTC [1280] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1928server # [ 129.559416] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1269]: CREATE FUNCTION1929server # [ 129.677364] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1269]: DROP EXTENSION1930server # [ 131.523908] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1269]: DO1931server # [ 131.574530] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql1932server # [ 131.964388] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1299]: DO1933server # [ 131.979410] postgres[1300]: ::1 2026-10-27 16:10:09.471 UTC [1300] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger1934server # [ 131.990550] postgres[1300]: LANGUAGE plpgsql1935server # [ 131.991241] postgres[1300]: AS $$1936server # [ 131.995379] postgres[1300]: BEGIN1937server # [ 132.013581] postgres[1300]: IF EXISTS (1938server # [ 132.015313] postgres[1300]: SELECT1939server # [ 132.022499] postgres[1300]: FROM pg_event_trigger_ddl_commands() AS ev1940server # [ 132.035601] postgres[1300]: JOIN pg_extension AS ext1941server # [ 132.038568] postgres[1300]: ON ev.objid = ext.oid1942server # [ 132.039388] postgres[1300]: WHERE ext.extname = 'pg_cron'1943server # [ 132.045013] postgres[1300]: )1944server # [ 132.046704] postgres[1300]: THEN1945server # [ 132.048191] postgres[1300]: grant usage on schema cron to postgres with grant option;1946server # [ 132.057769] postgres[1300]:1947server # [ 132.059140] postgres[1300]: alter default privileges in schema cron grant all on tables to postgres with grant option;1948server # [ 132.065389] postgres[1300]: alter default privileges in schema cron grant all on functions to postgres with grant option;1949server # [ 132.072905] postgres[1300]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1950server # [ 132.073982] postgres[1300]:1951server # [ 132.074570] postgres[1300]: alter default privileges for user supabase_admin in schema cron grant all1952server # [ 132.075370] postgres[1300]: on sequences to postgres with grant option;1953server # [ 132.086289] postgres[1300]: alter default privileges for user supabase_admin in schema cron grant all1954server # [ 132.089044] postgres[1300]: on tables to postgres with grant option;1955server # [ 132.089536] postgres[1300]: alter default privileges for user supabase_admin in schema cron grant all1956server # [ 132.090383] postgres[1300]: on functions to postgres with grant option;1957server # [ 132.091312] postgres[1300]:1958server # [ 132.094198] postgres[1300]: grant all privileges on all tables in schema cron to postgres with grant option;1959server # [ 132.096019] postgres[1300]: revoke all on table cron.job from postgres;1960server # [ 132.102242] postgres[1300]: grant select on table cron.job to postgres with grant option;1961server # [ 132.104118] postgres[1300]: END IF;1962server # [ 132.110557] postgres[1300]: END;1963server # [ 132.111604] postgres[1300]: $$;1964server # [ 132.118652] postgres[1300]: ::1 2026-10-27 16:10:09.610 UTC [1300] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access;1965server # [ 132.125294] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1299]: CREATE FUNCTION1966server # [ 132.126936] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1299]: DROP EVENT TRIGGER1967server # [ 132.128381] postgres[1300]: ::1 2026-10-27 16:10:09.634 UTC [1300] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;1968server # [ 132.148339] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1299]: ALTER FUNCTION1969server # [ 132.152087] postgres[1300]: ::1 2026-10-27 16:10:09.650 UTC [1300] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end1970server # [ 132.153101] postgres[1300]: WHEN TAG IN ('CREATE EXTENSION')1971server # [ 132.166741] postgres[1300]: EXECUTE FUNCTION extensions.grant_pg_cron_access();1972server # [ 132.167990] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1299]: CREATE EVENT TRIGGER1973server # [ 132.204642] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql1974server # [ 132.475691] postgres[1306]: ::1 2026-10-27 16:10:09.972 UTC [1306] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s';1975server # [ 132.510765] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1305]: ALTER ROLE1976server # [ 132.517382] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql1977server # [ 132.771788] postgres[1308]: ::1 2026-10-27 16:10:10.276 UTC [1308] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin;1978server # [ 132.819850] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1307]: ALTER FUNCTION1979server # [ 132.825835] postgres[1308]: ::1 2026-10-27 16:10:10.317 UTC [1308] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;1980server # [ 132.826804] postgres[1308]: ::1 2026-10-27 16:10:10.326 UTC [1308] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;1981server # [ 132.833890] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1307]: ALTER FUNCTION1982server # [ 132.847160] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1307]: ALTER FUNCTION1983server # [ 132.883230] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql1984server # [ 133.135562] postgres[1310]: ::1 2026-10-27 16:10:10.641 UTC [1310] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres;1985server # [ 133.162664] dhcpcd[729]: eth0: leased 10.0.2.15 for 86400 seconds1986server # [ 133.175892] dhcpcd[729]: eth0: adding route to 10.0.2.0/241987server # [ 133.210349] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1309]: GRANT ROLE1988server # [ 133.217260] dhcpcd[729]: eth0: adding default route via 10.0.2.21989server # [ 133.218205] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql1990server # [ 134.751484] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1315]: DO1991server # [ 134.814622] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql1992server # [ 135.430445] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1353]: DO1993server # [ 135.448303] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1353]: DO1994server # [ 135.489153] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql1995server # [ 135.970147] postgres[1385]: ::1 2026-10-27 16:10:13.465 UTC [1385] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none;1996server # [ 136.002921] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1377]: ALTER ROLE1997server # [ 136.008862] postgres[1385]: ::1 2026-10-27 16:10:13.511 UTC [1385] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none;1998server # [ 136.019245] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1377]: ALTER ROLE1999server # [ 136.023765] postgres[1385]: ::1 2026-10-27 16:10:13.532 UTC [1385] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none;2000server # [ 136.038657] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1377]: ALTER ROLE2001server # [ 136.139755] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql2002server # [ 136.647027] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1389]: DO2003server # [ 136.682944] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql2004server # [ 137.026289] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1399]: DO2005server # [ 137.067754] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql2006server # [ 137.453679] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1403]: CREATE FUNCTION2007server # [ 137.455418] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1403]: DO2008server # [ 137.508773] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql2009server # [ 138.040703] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1411]: ALTER FUNCTION2010server # [ 138.055049] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1411]: GRANT2011server # [ 138.092487] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql2012server # [ 138.531892] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1431]: DROP EVENT TRIGGER2013server # [ 138.575687] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1431]: ALTER FUNCTION2014server # [ 138.601777] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1431]: CREATE EVENT TRIGGER2015server # [ 138.651971] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql2016server # [ 138.971584] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1433]: DO2017server # [ 139.025269] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql2018server # [ 139.338362] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1435]: CREATE FUNCTION2019server # [ 139.339989] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1435]: GRANT2020server # [ 139.365345] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql2021server # [ 139.766341] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1437]: REVOKE ROLE2022server # [ 139.827709] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1437]: DO2023server # [ 139.866651] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1437]: DO2024server # [ 139.885500] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1437]: REVOKE ROLE2025server # [ 139.901437] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1437]: REVOKE2026server # [ 139.937492] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1437]: DO2027server # [ 140.014744] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql2028server # [ 140.408114] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1443]: DO2029server # [ 140.453257] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql2030server # [ 140.898823] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1451]: DO2031server # [ 140.933307] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql2032server # [ 141.429541] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1464]: DO2033server # [ 141.493536] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql2034server # [ 141.832542] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1472]: ALTER ROLE2035server # [ 141.856547] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql2036server # [ 142.136032] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1475]: GRANT ROLE2037server # [ 142.138627] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1475]: DO2038server # [ 142.192786] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql2039server # [ 142.425993] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1477]: GRANT2040server # [ 142.458021] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql2041server # [ 142.689931] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1479]: CREATE FUNCTION2042server # [ 142.694968] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1479]: REVOKE2043server # [ 142.704324] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1479]: REVOKE2044server # [ 142.713638] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1479]: GRANT2045server # [ 142.759484] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql2046server # [ 142.984677] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1481]: DO2047server # [ 143.020535] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql2048server # [ 143.353453] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1486]: ALTER ROLE2049server # [ 143.389438] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql2050server # [ 143.799523] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1499]: DROP EXTENSION2051server # [ 143.847155] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql2052server # [ 144.150336] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1511]: CREATE FUNCTION2053server # [ 144.155722] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1511]: DROP EVENT TRIGGER2054server # [ 144.169443] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1511]: CREATE EVENT TRIGGER2055server # [ 144.207572] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql2056server # [ 144.511523] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1513]: DO2057server # [ 144.545094] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1513]: CREATE FUNCTION2058server # [ 144.591145] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql2059server # [ 144.888880] systemd-logind[592]: Watching system buttons on /dev/input/event0 (gpio-keys)2060server # [ 144.944012] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1515]: CREATE FUNCTION2061server # [ 144.963625] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1515]: CREATE FUNCTION2062server # [ 145.022367] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql2063server # [ 145.420403] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1521]: CREATE FUNCTION2064server # [ 145.430221] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1521]: CREATE FUNCTION2065server # [ 145.451743] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1521]: CREATE FUNCTION2066server # [ 145.469391] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1521]: CREATE FUNCTION2067server # [ 145.485237] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1521]: CREATE FUNCTION2068server # [ 145.501402] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1521]: CREATE FUNCTION2069server # [ 145.542352] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Running postgresql schema...2070server # [ 145.806406] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER DATABASE2071server # [ 145.821656] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER DATABASE2072server # [ 145.888751] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER ROLE2073server # [ 145.957388] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER ROLE2074server # [ 146.017344] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER ROLE2075server # [ 146.079192] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER ROLE2076server # [ 146.165868] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER ROLE2077server # [ 146.244616] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER ROLE2078server # [ 146.357117] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER ROLE2079server # [ 146.589256] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER ROLE2080server # [ 146.710728] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER ROLE2081server # [ 146.736834] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1523]: ALTER ROLE2082server # [ 146.799475] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1004]: Database initialization complete2083server # [ 146.859485] systemd[1]: Finished Supabase Database Initialization.2084server # [ 146.888781] systemd[1]: Reached target Multi-User System.2085server # [ 146.895864] systemd[1]: Startup finished in 2.645s (kernel) + 24.192s (initrd) + 2min 53ms (userspace) = 2min 26.891s.2086server: (finished: waiting for unit supabase-db-init.service, in 148.49 seconds)2087subtest: Check upgrade path with postgresql 152088server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" 2089server # NOTICE: extension "timescaledb" does not exist, skipping2090server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" , in 0.72 seconds)2091server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.9.1' CASCADE;" 2092server # [ 150.395992] mousedev: PS/2 mouse device common for all mice2093server # [ 151.144718] systemd-logind[592]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2094server # [ 154.054023] postgres[1557]: [local] 2026-10-27 16:10:31.560 UTC [1557] supabase_admin@postgres WARNING:2095server # WARNING:2096server # WELCOME TO2097server # _____ _ _ ____________2098server # |_ _(_) | | | _ \ ___ \2099server # | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ /2100server # | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \2101server # | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ /2102server # |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/2103server # Running version 2.9.12104server # For more information on TimescaleDB, please visit the following links:2105server # 2106server # 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started2107server # 2. API reference documentation: https://docs.timescale.com/api/latest2108server # 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts2109server # 2110server # Note: Please enable telemetry to help us improve our product by running: ALTER DATABASE "postgres" SET timescaledb.telemetry_level = 'basic';2111server # 2112server # [ 154.067102] postgres[1557]: WELCOME TO2113server # [ 154.069486] postgres[1557]: _____ _ _ ____________2114server # [ 154.074055] postgres[1557]: |_ _(_) | | | _ \ ___ \2115server # [ 154.075671] postgres[1557]: | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ /2116server # [ 154.082100] postgres[1557]: | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \2117server # [ 154.083688] postgres[1557]: | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ /2118server # [ 154.093273] postgres[1557]: |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/2119server # [ 154.095956] postgres[1557]: Running version 2.9.12120server # [ 154.102935] postgres[1557]: For more information on TimescaleDB, please visit the following links:2121server # [ 154.114877] postgres[1557]:2122server # [ 154.115962] postgres[1557]: 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started2123server # [ 154.117935] postgres[1557]: 2. API reference documentation: https://docs.timescale.com/api/latest2124server # [ 154.119033] postgres[1557]: 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts2125server # [ 154.119737] postgres[1557]:2126server # [ 154.120072] postgres[1557]: Note: Please enable telemetry to help us improve our product by running: ALTER DATABASE "postgres" SET timescaledb.telemetry_level = 'basic';2127server # [ 154.127923] postgres[1557]:2128server # [ 154.129214] postgres[1557]: [local] 2026-10-27 16:10:31.560 UTC [1557] supabase_admin@postgres CONTEXT: PL/pgSQL function inline_code_block line 16 at RAISE2129server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.9.1' CASCADE;" , in 6.14 seconds)2130server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" 2131server # [ 154.520345] postgres[1604]: 2026-10-27 16:10:32.025 UTC [1604] LOG: job 2 threw an error2132server # [ 154.541235] postgres[1604]: 2026-10-27 16:10:32.046 UTC [1604] ERROR: functionality not supported under the current "apache" license2133server # [ 154.542523] postgres[1604]: 2026-10-27 16:10:32.046 UTC [1604] HINT: Upgrade your license to 'timescale' to use this free community feature.2134server # [ 154.594203] postgres[975]: 2026-10-27 16:10:32.098 UTC [975] LOG: background worker "Error Log Retention Policy [2]" (PID 1604) exited with exit code 12135server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.69 seconds)2136server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "ALTER EXTENSION timescaledb UPDATE TO '2.16.1';" 2137server # [ 155.819409] postgres[1600]: 2026-10-27 16:10:33.326 UTC [1600] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command2138server # [ 155.895678] postgres[975]: 2026-10-27 16:10:33.386 UTC [975] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 1600) exited with exit code 12139server # [ 162.861612] postgres[1619]: 2026-10-27 16:10:40.363 UTC [1619] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command2140server # [ 162.901785] postgres[975]: 2026-10-27 16:10:40.400 UTC [975] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 1619) exited with exit code 12141server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "ALTER EXTENSION timescaledb UPDATE TO '2.16.1';" , in 8.47 seconds)2142server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" 2143server # [ 163.642183] postgres[1675]: 2026-10-27 16:10:41.125 UTC [1675] LOG: job 3 threw an error2144server # [ 163.654214] postgres[1675]: 2026-10-27 16:10:41.129 UTC [1675] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/.2145server # [ 163.661514] postgres[1675]: 2026-10-27 16:10:41.129 UTC [1675] HINT: To access all features and the best time-series experience, try out Timescale Cloud.2146server # [ 163.664181] postgres[975]: 2026-10-27 16:10:41.174 UTC [975] LOG: background worker "Job History Log Retention Policy [3]" (PID 1675) exited with exit code 12147server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.68 seconds)2148(finished: subtest: Check upgrade path with postgresql 15, in 16.70 seconds)2149subtest: Check the install of the last version of the extension2150server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" 2151server # [ 164.516292] postgres[1672]: 2026-10-27 16:10:42.018 UTC [1672] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command2152server # [ 164.559886] postgres[975]: 2026-10-27 16:10:42.065 UTC [975] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 1672) exited with exit code 12153server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" , in 1.90 seconds)2154server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" 2155server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" , in 6.19 seconds)2156server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" 2157server # [ 172.451045] postgres[1751]: 2026-10-27 16:10:49.957 UTC [1751] LOG: job 3 threw an error2158server # [ 172.466575] postgres[1751]: 2026-10-27 16:10:49.972 UTC [1751] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/.2159server # [ 172.473622] postgres[1751]: 2026-10-27 16:10:49.972 UTC [1751] HINT: To access all features and the best time-series experience, try out Timescale Cloud.2160server # [ 172.519611] postgres[975]: 2026-10-27 16:10:50.020 UTC [975] LOG: background worker "Job History Log Retention Policy [3]" (PID 1751) exited with exit code 12161server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.69 seconds)2162(finished: subtest: Check the install of the last version of the extension, in 8.79 seconds)2163(finished: run the VM test script, in 174.22 seconds)2164test script finished in 174.67s2165cleanup2166kill QemuMachine (pid 13)2167server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/76jq0mngg7m8zv5yjz1qgg0xspzi8x2w-python3-3.13.15/bin/python3.13)2168(finished: cleanup, in 0.07 seconds)