vm-test-run-timescaledb
checks.aarch64-linux.ext-timescaledb
· build #522
· 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.OexNJiXYp5', 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: f0cd141f-153e-426f-9095-7acffa84910e18server # 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.31 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.59 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Oct 26 15:09:28 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 s186968 r8192 d116136 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/4lgsdqa4kzhnxq63cg19y9hfdrywzpjg-nixos-system-server-test/init regInfo=/nix/store/2zjgg82m7gkmk697axzrsg22rahdi6fh-closure-info/registration console=ttyAMA0,115200n8 console=tty068server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/2zjgg82m7gkmk697axzrsg22rahdi6fh-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 74992 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 @100b10000 (indirect, esz 8, psz 64K, shr 1)102server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b20000 (flat, esz 8, psz 64K, shr 1)103server # [ 0.000000] GICv3: using LPI property table @0x0000000100b30000104server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b40000105server # [ 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.000033] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns110server # [ 0.003000] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)111server # [ 0.014604] Console: colour dummy device 80x25112server # [ 0.016020] printk: legacy console [tty0] enabled113server # [ 0.021882] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)114server # [ 0.022362] pid_max: default: 32768 minimum: 301115server # [ 0.025977] LSM: initializing lsm=capability,landlock,yama,bpf,ima116server # [ 0.027608] landlock: Up and running.117server # [ 0.027712] Yama: becoming mindful.118server # [ 0.030291] LSM support for eBPF active119server # [ 0.033448] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)120server # [ 0.034416] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)121server # [ 0.070578] rcu: Hierarchical SRCU implementation.122server # [ 0.070662] rcu: Max phase no-delay instances is 1000.123server # [ 0.071930] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level124server # [ 0.077819] fsl-mc MSI: its@8080000 domain created125server # [ 0.079881] EFI services will not be available.126server # [ 0.081510] smp: Bringing up secondary CPUs ...127server # [ 0.086811] Detected PIPT I-cache on CPU1128server # [ 0.088237] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000129server # [ 0.088861] GICv3: CPU1: using allocated LPI pending table @0x0000000100b50000130server # [ 0.090511] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]131server # [ 0.094039] smp: Brought up 1 node, 2 CPUs132server # [ 0.094189] SMP: Total of 2 processors activated.133server # [ 0.094227] CPU: All CPU(s) started at EL1134server # [ 0.094705] CPU features: detected: Branch Target Identification135server # [ 0.094796] CPU features: detected: 32-bit EL0 Support136server # [ 0.094829] CPU features: detected: 32-bit EL1 Support137server # [ 0.094856] CPU features: detected: ARMv8.4 Translation Table Level138server # [ 0.094891] CPU features: detected: Instruction cache invalidation not required for I/D coherence139server # [ 0.094928] CPU features: detected: Data cache clean to the PoU not required for I/D coherence140server # [ 0.094997] CPU features: detected: Common not Private translations141server # [ 0.095027] CPU features: detected: CRC32 instructions142server # [ 0.095049] CPU features: detected: Data cache clean to Point of Deep Persistence143server # [ 0.095079] CPU features: detected: Data cache clean to Point of Persistence144server # [ 0.095109] CPU features: detected: Data independent timing control (DIT)145server # [ 0.095137] CPU features: detected: E0PD146server # [ 0.095160] CPU features: detected: Enhanced Counter Virtualization147server # [ 0.095186] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)148server # [ 0.095215] CPU features: detected: Enhanced Privileged Access Never149server # [ 0.095241] CPU features: detected: Enhanced Virtualization Traps150server # [ 0.095264] CPU features: detected: Fine Grained Traps151server # [ 0.095286] CPU features: detected: Guarded Control Stack (GCS)152server # [ 0.095344] CPU features: detected: Generic authentication (IMP DEF algorithm)153server # [ 0.095654] CPU features: detected: RCpc load-acquire (LDAPR)154server # [ 0.095763] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)155server # [ 0.095798] CPU features: detected: LSE atomic instructions156server # [ 0.095829] CPU features: detected: Memory Copy and Memory Set instructions157server # [ 0.095863] CPU features: detected: Privileged Access Never158server # [ 0.095903] CPU features: detected: PMUv3159server # [ 0.095927] CPU features: detected: SCTLR2160server # [ 0.095953] CPU features: detected: RAS Extension Support161server # [ 0.096019] CPU features: detected: RASv1p1 Extension Support162server # [ 0.096044] CPU features: detected: Random Number Generator163server # [ 0.096094] CPU features: detected: Speculation barrier (SB)164server # [ 0.096132] CPU features: detected: Stage-2 Force Write-Back165server # [ 0.096156] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality166server # [ 0.096188] CPU features: detected: TLB range maintenance instructions167server # [ 0.096224] CPU features: detected: WFx with timeout168server # [ 0.096299] CPU features: detected: Scalable Matrix Extension169server # [ 0.096323] CPU features: detected: FA64170server # [ 0.096342] CPU features: detected: SME2171server # [ 0.096366] CPU features: detected: Speculative Store Bypassing Safe (SSBS)172server # [ 0.096389] CPU features: detected: Scalable Vector Extension173server # [ 0.102929] alternatives: applying system-wide alternatives174server # [ 0.116940] CPU features: detected: Hardware dirty bit management on CPU0-1175server # [ 0.117702] SVE: maximum available vector length 256 bytes per vector176server # [ 0.117775] SVE: default vector length 64 bytes per vector177server # [ 0.118731] SME: minimum available vector length 16 bytes per vector178server # [ 0.118770] SME: maximum available vector length 256 bytes per vector179server # [ 0.118806] SME: default vector length 32 bytes per vector180server # [ 0.132141] Memory: 3904060K/4194304K available (24384K kernel code, 7094K rwdata, 26604K rodata, 4736K init, 1103K bss, 241760K reserved, 32768K cma-reserved)181server # [ 0.152347] devtmpfs: initialized182server # [ 0.180931] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear)183server # [ 0.181257] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear).184server # [ 0.183828] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL185server # [ 0.183898] 0 pages in range for non-PLT usage186server # [ 0.183937] 508240 pages in range for PLT usage187server # [ 0.187140] pinctrl core: initialized pinctrl subsystem188server # [ 0.198518] DMI not present or invalid.189server # [ 0.220466] NET: Registered PF_NETLINK/PF_ROUTE protocol family190server # [ 0.230493] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations191server # [ 0.231315] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations192server # [ 0.232032] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations193server # [ 0.232250] audit: initializing netlink subsys (disabled)194server # [ 0.233727] audit: type=2000 audit(0.164:1): state=initialized audit_enabled=0 res=1195server # [ 0.239046] thermal_sys: Registered thermal governor 'fair_share'196server # [ 0.239082] thermal_sys: Registered thermal governor 'bang_bang'197server # [ 0.239122] thermal_sys: Registered thermal governor 'step_wise'198server # [ 0.239153] thermal_sys: Registered thermal governor 'user_space'199server # [ 0.239178] thermal_sys: Registered thermal governor 'power_allocator'200server # [ 0.239682] cpuidle: using governor ladder201server # [ 0.239902] cpuidle: using governor menu202server # [ 0.241492] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.203server # [ 0.242129] ASID allocator initialised with 65536 entries204server # [ 0.248087] Serial: AMBA PL011 UART driver205server # [ 0.300662] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1206server # [ 0.301703] printk: console [ttyAMA0] enabled207server # [ 0.344182] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages208server # [ 0.344364] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page209server # [ 0.344409] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages210server # [ 0.344441] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page211server # [ 0.344473] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages212server # [ 0.344499] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page213server # [ 0.344525] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages214server # [ 0.344555] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page215server # [ 0.364698] fbcon: Taking over console216server # [ 0.365022] ACPI: Interpreter disabled.217server # [ 0.380331] iommu: Default domain type: Translated218server # [ 0.380415] iommu: DMA domain TLB invalidation policy: strict mode219server # [ 0.386578] SCSI subsystem initialized220server # [ 0.388576] usbcore: registered new interface driver usbfs221server # [ 0.388806] usbcore: registered new interface driver hub222server # [ 0.388926] usbcore: registered new device driver usb223server # [ 0.391623] pps_core: LinuxPPS API ver. 1 registered224server # [ 0.391667] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>225server # [ 0.391741] PTP clock support registered226server # [ 0.391987] EDAC MC: Ver: 3.0.0227server # [ 0.393198] scmi_core: SCMI protocol bus registered228server # [ 0.396994] FPGA manager framework229server # [ 0.405121] vgaarb: loaded230server # [ 0.417863] clocksource: Switched to clocksource arch_sys_counter231server # [ 0.450904] VFS: Disk quotas dquot_6.6.0232server # [ 0.451129] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)233server # [ 0.452946] netfs: FS-Cache loaded234server # [ 0.454104] pnp: PnP ACPI: disabled235server # [ 0.482041] NET: Registered PF_INET protocol family236server # [ 0.482917] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)237server # [ 0.575635] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)238server # [ 0.575828] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)239server # [ 0.575950] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)240server # [ 0.576374] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)241server # [ 0.576661] TCP: Hash tables configured (established 32768 bind 32768)242server # [ 0.577816] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)243server # [ 0.579145] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)244server # [ 0.579805] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)245server # [ 0.581659] NET: Registered PF_UNIX/PF_LOCAL protocol family246server # [ 0.583013] NET: Registered PF_XDP protocol family247server # [ 0.583220] PCI: CLS 0 bytes, default 64248server # [ 0.587247] kvm [1]: HYP mode not available249server # [ 0.591926] Trying to unpack rootfs image as initramfs...250server # [ 0.806332] Initialise system trusted keyrings251server # [ 0.807586] workingset: timestamp_bits=42 max_order=20 bucket_order=0252server # [ 0.811821] squashfs: version 4.0 (2009/01/31) Phillip Lougher253server # [ 0.812319] 9p: Installing v9fs 9p2000 file system support254server # [ 0.876500] Key type asymmetric registered255server # [ 0.876641] Asymmetric key parser 'x509' registered256server # [ 0.877040] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)257server # [ 0.877860] io scheduler mq-deadline registered258server # [ 0.877935] io scheduler kyber registered259server # [ 0.939161] pl061_gpio 9030000.pl061: PL061 GPIO chip registered260server # [ 0.954388] ledtrig-cpu: registered to indicate activity on CPUs261server # [ 0.957813] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:262server # [ 0.958277] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000263server # [ 0.958614] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000264server # [ 0.958687] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000265server # [ 0.959099] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits266server # [ 0.959498] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]267server # [ 0.960559] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00268server # [ 0.960784] pci_bus 0000:00: root bus resource [bus 00-ff]269server # [ 0.960880] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]270server # [ 0.960934] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]271server # [ 0.960966] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]272server # [ 0.961893] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint273server # [ 0.966024] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint274server # [ 0.966236] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]275server # [ 0.966303] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]276server # [ 0.968669] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]277server # [ 0.968784] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]278server # [ 0.969704] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint279server # [ 0.969812] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]280server # [ 0.969852] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]281server # [ 0.969886] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282server # [ 0.974594] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint283server # [ 0.974702] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]284server # [ 0.974741] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]285server # [ 0.974780] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]286server # [ 0.975930] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint287server # [ 0.976185] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]288server # [ 0.976337] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]289server # [ 0.976462] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290server # [ 0.977044] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint291server # [ 0.977120] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]292server # [ 0.977152] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]293server # [ 0.977190] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]294server # [ 0.977615] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint295server # [ 0.977690] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]296server # [ 0.977726] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]297server # [ 0.977765] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298server # [ 0.984774] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint299server # [ 0.984900] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]300server # [ 0.984937] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]301server # [ 0.984975] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]302server # [ 0.985012] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]303server # [ 0.985688] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint304server # [ 0.985779] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]305server # [ 0.985823] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]306server # [ 0.988884] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint307server # [ 0.988999] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]308server # [ 0.989039] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]309server # [ 0.989753] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint310server # [ 0.989851] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]311server # [ 0.993273] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint312server # [ 0.993773] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]313server # [ 0.993851] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]314server # [ 0.993895] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]315server # [ 0.996907] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint316server # [ 0.997006] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]317server # [ 0.997042] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]318server # [ 0.997085] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]319server # [ 1.001750] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned320server # [ 1.001914] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned321server # [ 1.002013] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned322server # [ 1.002165] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned323server # [ 1.002240] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned324server # [ 1.002370] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned325server # [ 1.005211] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned326server # [ 1.005290] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned327server # [ 1.005437] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned328server # [ 1.005510] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned329server # [ 1.005567] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned330server # [ 1.005664] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned331server # [ 1.007717] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned332server # [ 1.007798] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned333server # [ 1.007857] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned334server # [ 1.007903] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned335server # [ 1.007947] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned336server # [ 1.007988] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned337server # [ 1.008028] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned338server # [ 1.008062] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned339server # [ 1.008100] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned340server # [ 1.008134] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned341server # [ 1.008174] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned342server # [ 1.008208] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned343server # [ 1.008242] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned344server # [ 1.008286] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned345server # [ 1.008337] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned346server # [ 1.008370] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned347server # [ 1.008403] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned348server # [ 1.008440] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned349server # [ 1.008472] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned350server # [ 1.008505] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned351server # [ 1.008540] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned352server # [ 1.008575] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned353server # [ 1.008805] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]354server # [ 1.008848] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]355server # [ 1.008879] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]356server # [ 1.010074] pci 0000:00:0a.0: enabling device (0000 -> 0002)357server # [ 1.080715] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)358server # [ 1.084665] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)359server # [ 1.086323] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)360server # [ 1.088897] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)361server # [ 1.092458] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)362server # [ 1.095861] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)363server # [ 1.099376] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)364server # [ 1.103135] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)365server # [ 1.107111] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)366server # [ 1.111797] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)367server # [ 1.115895] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)368server # [ 1.140055] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled369server # [ 1.155813] msm_serial: driver initialized370server # [ 1.156749] SuperH (H)SCI(F) driver initialized371server # [ 1.157169] STM32 USART driver initialized372server # [ 1.212860] loop: module loaded373server # [ 1.213810] virtio_blk virtio5: 2/0/0 default/read/poll queues374server # [ 1.221537] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)375server # [ 1.235044] megasas: 07.734.00.00-rc1376server # [ 1.239385] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]377server # [ 1.241284] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000378server # [ 1.241738] Intel/Sharp Extended Query Table at 0x0031379server # [ 1.242866] Using buffer write method380server # [ 1.243612] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]381server # [ 1.244706] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000382server # [ 1.244784] Intel/Sharp Extended Query Table at 0x0031383server # [ 1.245758] Using buffer write method384server # [ 1.245846] Concatenating MTD devices:385server # [ 1.245875] (0): "0.flash"386server # [ 1.245897] (1): "0.flash"387server # [ 1.245921] into device "0.flash"388server # [ 1.452682] Freeing initrd memory: 25348K389server # [ 1.540788] tun: Universal TUN/TAP device driver, 1.6390server # [ 1.554862] thunder_xcv, ver 1.0391server # [ 1.555101] thunder_bgx, ver 1.0392server # [ 1.555237] nicpf, ver 1.0393server # [ 1.558679] e1000: Intel(R) PRO/1000 Network Driver394server # [ 1.558734] e1000: Copyright (c) 1999-2006 Intel Corporation.395server # [ 1.559063] e1000e: Intel(R) PRO/1000 Network Driver396server # [ 1.559597] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.397server # [ 1.559907] igb: Intel(R) Gigabit Ethernet Network Driver398server # [ 1.559947] igb: Copyright (c) 2007-2014 Intel Corporation.399server # [ 1.560217] igbvf: Intel(R) Gigabit Virtual Function Network Driver400server # [ 1.560334] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.401server # [ 1.561727] sky2: driver version 1.30402server # [ 1.570666] ehci-pci 0000:00:0a.0: EHCI Host Controller403server # [ 1.572175] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1404server # [ 1.574658] usbcore: registered new interface driver usb-storage405server # [ 1.575466] usbcore: registered new interface driver usbserial_generic406server # [ 1.575708] usbserial: USB Serial support registered for generic407server # [ 1.575883] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000408server # [ 1.579565] hv_vmbus: registering driver hyperv_keyboard409server # [ 1.584872] rtc-pl031 9010000.pl031: registered as rtc0410server # [ 1.585333] rtc-pl031 9010000.pl031: setting system clock to 2026-10-31T19:36:33 UTC (1793475393)411server # [ 1.587040] i2c_dev: i2c /dev entries driver412server # [ 1.587137] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00413server # [ 1.592432] hub 1-0:1.0: USB hub found414server # [ 1.592876] hub 1-0:1.0: 6 ports detected415server # [ 1.600245] sdhci: Secure Digital Host Controller Interface driver416server # [ 1.600298] sdhci: Copyright(c) Pierre Ossman417server # [ 1.601548] Synopsys Designware Multimedia Card Interface Driver418server # [ 1.603003] sdhci-pltfm: SDHCI platform and OF driver helper419server # [ 1.612084] hid: raw HID events driver (C) Jiri Kosina420server # [ 1.614118] usbcore: registered new interface driver usbhid421server # [ 1.614178] usbhid: USB HID core driver422server # [ 1.624355] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available423server # [ 1.635740] drop_monitor: Initializing network drop monitor service424server # [ 1.636811] NET: Registered PF_INET6 protocol family425server # [ 1.647318] Segment Routing with IPv6426server # [ 1.647575] In-situ OAM (IOAM) with IPv6427server # [ 1.648031] NET: Registered PF_PACKET protocol family428server # [ 1.649520] 9pnet: Installing 9P2000 support429server # [ 1.655622] Key type dns_resolver registered430server # [ 1.704625] registered taskstats version 1431server # [ 1.708252] Loading compiled-in X.509 certificates432server # [ 1.767723] Demotion targets for Node 0: null433server # [ 1.768822] Key type .fscrypt registered434server # [ 1.768871] Key type fscrypt-provisioning registered435server # [ 1.773123] ima: No TPM chip found, activating TPM-bypass!436server # [ 1.773240] ima: Allocated hash algorithm: sha1437server # [ 1.776168] ima: No architecture policies found438server # [ 1.786664] input: gpio-keys as /devices/platform/gpio-keys/input/input0439server # [ 1.839527] usb 1-1: new high-speed USB device number 2 using ehci-pci440server # [ 1.857730] clk: Disabling unused clocks441server # [ 1.857934] PM: genpd: Disabling unused power domains442server # [ 2.053633] 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.116663] 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.159341] Freeing unused kernel memory: 4736K445server # [ 2.160798] Run /init as init process446server # [ 2.242814] usb 1-2: new high-speed USB device number 3 using ehci-pci447server # [ 2.281029] systemd[1]: Successfully made /usr/ read-only.448server # [ 2.428338] 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.429305] 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 # [ 2.632567] systemd[1]: systemd 260.5 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 # [ 2.632768] systemd[1]: Detected virtualization qemu.452server # [ 2.633032] systemd[1]: Detected architecture arm64.453server # [ 2.633088] systemd[1]: Running in initrd.454server # [ 2.640755] systemd[1]: Initializing machine ID from random generator.455server # [ 2.643473] systemd[1]: Hostname set to <server>.456server # [ 3.220080] systemd[1]: Queued start job for default target Initrd Default Target.457server # [ 3.270244] systemd[1]: Created slice Slice /system/modprobe.458server # [ 3.273879] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.459server # [ 3.274894] systemd[1]: Expecting device /dev/disk/by-label/nixos...460server # [ 3.275293] systemd[1]: Reached target Path Units.461server # [ 3.275444] systemd[1]: Reached target Slice Units.462server # [ 3.275568] systemd[1]: Reached target Swaps.463server # [ 3.275694] systemd[1]: Reached target Timer Units.464server # [ 3.278033] systemd[1]: Listening on D-Bus System Message Bus Socket.465server # [ 3.281598] systemd[1]: Listening on Journal Socket (/dev/log).466server # [ 3.283145] systemd[1]: Listening on Journal Sockets.467server # [ 3.283993] systemd[1]: Listening on udev Control Socket.468server # [ 3.284499] systemd[1]: Listening on udev Kernel Socket.469server # [ 3.284658] systemd[1]: Reached target Socket Units.470server # [ 3.309027] systemd[1]: Starting Create List of Static Device Nodes...471server # [ 3.335288] systemd[1]: Starting Load Kernel Module 9pnet_virtio...472server # [ 3.335994] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs473server # [ 3.368332] systemd[1]: Mounting Kernel Configuration File System...474server # [ 3.463921] systemd[1]: Starting Journal Service...475server # [ 3.501442] systemd[1]: Starting Load Kernel Modules...476server # [ 3.504144] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki477server # [ 3.534168] systemd[1]: Starting Coldplug All udev Devices...478server # [ 3.600540] systemd[1]: Finished Create List of Static Device Nodes.479server # [ 3.611099] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.480server # [ 3.628361] systemd[1]: Finished Load Kernel Module 9pnet_virtio.481server # [ 3.651566] systemd[1]: Mounted Kernel Configuration File System.482server # [ 3.679679] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...483server # [ 3.872600] systemd-journald[81]: Collecting audit messages is disabled.484server # [ 3.898163] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.485server # [ 3.923942] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev486server # [ 3.938706] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0487server # [ 3.939301] [drm] features: -virgl +edid -resource_blob -host_visible488server # [ 3.939326] [drm] features: -context_init489server # [ 3.945211] [drm] number of scanouts: 1490server # [ 3.945533] [drm] number of cap sets: 0491server # [ 3.956830] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.492server # [ 3.976879] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic493server # [ 3.977008] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0494server # [ 4.008927] systemd[1]: Starting Create Static Device Nodes in /dev...495server # [ 4.072358] Console: switching to colour frame buffer device 160x50496server # [ 4.080076] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device497server # [ 4.146333] systemd[1]: Finished Load Kernel Modules.498server # [ 4.170792] systemd[1]: Finished Create Static Device Nodes in /dev.499server # [ 4.172570] systemd[1]: Reached target Preparation for Local File Systems.500server # [ 4.172791] systemd[1]: Reached target Local File Systems.501server # [ 4.212600] systemd[1]: Starting Apply Kernel Variables...502server # [ 4.296066] systemd[1]: Starting Rule-based Manager for Device Events and Files...503server # [ 4.551490] systemd[1]: Finished Apply Kernel Variables.504server # [ 4.690031] systemd[1]: Started Journal Service.505server # [ 4.586599] systemd-modules-load[82]: Using 2 probe threads506server # [ 4.598701] systemd-modules-load[82]: Module 'virtio_balloon' is built in507server # [ 4.623620] systemd-modules-load[82]: Module 'virtio_console' is built in508server # [ 4.627191] systemd-modules-load[82]: Inserted module 'dm_mod'509server # [ 4.630302] systemd-modules-load[82]: Module 'virtio_rng' is built in510server # [ 4.632295] systemd-modules-load[82]: Inserted module 'virtio_gpu'511server # [ 4.639005] systemd[1]: Starting Create System Files and Directories...512server # [ 4.667158] systemd-udevd[89]: Using default interface naming scheme 'v260'.513server # [ 4.822215] systemd[1]: Finished Create System Files and Directories.514server # [ 4.978651] systemd[1]: Started Rule-based Manager for Device Events and Files.515server # [ 5.301655] systemd[1]: Starting Virtual Console Setup...516server # [ 5.540579] systemd-vconsole-setup[111]: Configuration of first virtual console was skipped, ignoring remaining ones.517server # [ 5.549455] systemd[1]: Finished Virtual Console Setup.518server # [ 8.977645] systemd[1]: Finished Coldplug All udev Devices.519server # [ 8.982598] systemd[1]: Reached target System Initialization.520server # [ 8.985088] systemd[1]: Reached target Basic System.521server # [ 10.658611] (udev-worker)[120]: Network interface NamePolicy= disabled on kernel command line.522server # [ 10.709022] (udev-worker)[127]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.523server # [ 10.726857] (udev-worker)[127]: Network interface NamePolicy= disabled on kernel command line.524server # [ 11.150882] systemd[1]: Found device /dev/disk/by-label/nixos.525server # [ 11.165022] systemd[1]: Reached target Initrd Root Device.526server # [ 11.169921] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...527server # [ 11.567809] systemd-fsck[158]: nixos: clean, 12/65536 files, 13019/262144 blocks528server # [ 11.621454] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.529server # [ 11.655972] systemd[1]: Mounting /sysroot...530server # [ 12.070904] EXT4-fs (vda): mounted filesystem f0cd141f-153e-426f-9095-7acffa84910e r/w with ordered data mode. Quota mode: none.531server # [ 12.005767] systemd[1]: Mounted /sysroot.532server # [ 12.028868] systemd[1]: Reached target Initrd Root File System.533server # [ 12.046389] systemd[1]: Starting Mountpoints Configured in the Real Root...534server # [ 12.184118] systemd-sysroot-fstab-check[167]: /sysroot should be mounted in the initrd, will request daemon-reload.535server # [ 12.216944] systemd[1]: Reload requested from client PID 167 ('systemd-sysroot') (unit initrd-parse-etc.service)...536server # [ 12.218637] systemd[1]: Reloading...537server # [ 13.543489] systemd[1]: Reloading finished in 1326 ms.538server # [ 13.671284] systemd-sysroot-fstab-check[167]: Requesting initrd-fs.target/start/replace...539server # [ 13.684305] systemd-sysroot-fstab-check[167]: Requesting swap.target/start/replace...540server # [ 13.719842] systemd[1]: Mounting /sysroot/nix/.rw-store...541server # [ 13.746860] systemd[1]: Mounting /sysroot/run...542server # [ 13.805621] systemd[1]: Starting Load Kernel Module 9pnet_virtio...543server # [ 13.822065] systemd[1]: initrd-parse-etc.service: Deactivated successfully.544server # [ 13.835611] systemd[1]: Finished Mountpoints Configured in the Real Root.545server # [ 13.842590] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.546server # [ 14.037904] systemd[1]: Mounted /sysroot/nix/.rw-store.547server # [ 14.049812] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.548server # [ 14.061396] systemd[1]: Finished Load Kernel Module 9pnet_virtio.549server # [ 14.110883] systemd[1]: Mounted /sysroot/run.550server # [ 14.129623] systemd[1]: Mounting /sysroot/nix/.ro-store...551server # [ 14.159470] systemd[1]: Mounting /sysroot/tmp/shared...552server # [ 14.194214] systemd[1]: Mounting /sysroot/tmp/xchg...553server # [ 14.230002] systemd[1]: Starting rw-sysroot-nix-store.service...554server # [ 14.399611] systemd[1]: Mounted /sysroot/nix/.ro-store.555server # [ 14.415437] systemd[1]: Mounted /sysroot/tmp/shared.556server # [ 14.454303] systemd[1]: Mounted /sysroot/tmp/xchg.557server # [ 14.458456] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.558server # [ 14.462333] systemd[1]: Finished rw-sysroot-nix-store.service.559server # [ 14.690484] systemd[1]: Mounting /sysroot/nix/store...560server # [ 15.015606] systemd[1]: Mounted /sysroot/nix/store.561server # [ 15.026911] systemd[1]: Reached target Initrd File Systems.562server # [ 15.054473] systemd[1]: Starting Find NixOS closure...563server # [ 15.073448] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...564server # [ 15.237407] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.565server # [ 15.307076] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.566server # [ 15.470152] systemd[1]: Finished Find NixOS closure.567server # [ 15.477820] systemd[1]: Reached target Initrd Default Target.568server # [ 15.493495] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...569server # [ 15.669110] systemd[1]: Stopped target Initrd Default Target.570server # [ 15.670957] systemd[1]: Stopped target Basic System.571server # [ 15.672137] systemd[1]: Stopped target Initrd Root Device.572server # [ 15.674149] systemd[1]: Stopped target Path Units.573server # [ 15.675987] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.574server # [ 15.682990] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.575server # [ 15.709973] systemd[1]: Stopped target Slice Units.576server # [ 15.714645] systemd[1]: Stopped target Socket Units.577server # [ 15.724152] systemd[1]: Stopped target System Initialization.578server # [ 15.740236] systemd[1]: Stopped target Swaps.579server # [ 15.753090] systemd[1]: Stopped target Timer Units.580server # [ 15.755370] systemd[1]: dbus.socket: Deactivated successfully.581server # [ 15.761332] systemd[1]: Closed D-Bus System Message Bus Socket.582server # [ 15.763739] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.583server # [ 15.766113] systemd[1]: Stopped Find NixOS closure.584server # [ 15.781476] systemd[1]: Starting Load Kernel Module 9pnet_virtio...585server # [ 15.798339] systemd[1]: Starting rw-sysroot-nix-store.service...586server # [ 15.806191] systemd[1]: systemd-sysctl.service: Deactivated successfully.587server # [ 15.813984] systemd[1]: Stopped Apply Kernel Variables.588server # [ 15.824382] systemd[1]: systemd-modules-load.service: Deactivated successfully.589server # [ 15.828352] systemd[1]: Stopped Load Kernel Modules.590server # [ 15.835111] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.591server # [ 15.844366] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.592server # [ 15.849550] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.593server # [ 15.851950] systemd[1]: Stopped Create System Files and Directories.594server # [ 15.855493] systemd[1]: Stopped target Local File Systems.595server # [ 15.862990] systemd[1]: Stopped target Preparation for Local File Systems.596server # [ 15.866303] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.597server # [ 15.870389] systemd[1]: Stopped Coldplug All udev Devices.598server # [ 15.874776] systemd[1]: systemd-udev-trigger.service: Consumed 4.515s CPU time over 12.449s wall clock time, 9.6M memory peak.599server # [ 15.878860] systemd[1]: Stopping Rule-based Manager for Device Events and Files...600server # [ 15.880534] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.601server # [ 15.895485] systemd[1]: Stopped Virtual Console Setup.602server # [ 15.932955] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.603server # [ 15.937739] systemd[1]: Finished Load Kernel Module 9pnet_virtio.604server # [ 15.965359] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.605server # [ 15.977354] systemd[1]: Finished rw-sysroot-nix-store.service.606server # [ 15.978388] systemd[1]: initrd-cleanup.service: Deactivated successfully.607server # [ 15.985824] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.608server # [ 16.112481] systemd[1]: systemd-udevd.service: Deactivated successfully.609server # [ 16.115702] systemd[1]: Stopped Rule-based Manager for Device Events and Files.610server # [ 16.117046] systemd[1]: systemd-udevd.service: Consumed 9.435s CPU time over 11.930s wall clock time, 25.5M memory peak.611server # [ 16.122540] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.612server # [ 16.124256] systemd[1]: Closed udev Control Socket.613server # [ 16.132182] systemd[1]: Starting Cleanup udev Database...614server # [ 16.137869] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.615server # [ 16.138886] systemd[1]: Stopped Create Static Device Nodes in /dev.616server # [ 16.139815] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.617server # [ 16.141056] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.618server # [ 16.142210] systemd[1]: kmod-static-nodes.service: Deactivated successfully.619server # [ 16.144680] systemd[1]: Stopped Create List of Static Device Nodes.620server # [ 16.258028] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.621server # [ 16.260555] systemd[1]: Finished Cleanup udev Database.622server # [ 16.263974] systemd[1]: Reached target Switch Root.623server # [ 16.272788] systemd[1]: Starting NixOS Activation...624server # [ 17.121962] initrd-nixos-activation-start[239]: booting system configuration /nix/store/4lgsdqa4kzhnxq63cg19y9hfdrywzpjg-nixos-system-server-test625server # [ 17.432640] initrd-nixos-activation-start[239]: running activation script...626server # [ 20.622587] initrd-nixos-activation-start[262]: setting up /etc...627server # [ 22.853849] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.628server # [ 22.855848] systemd[1]: Finished NixOS Activation.629server # [ 22.858098] systemd[1]: initrd-nixos-activation.service: Consumed 3.856s CPU time over 6.578s wall clock time, 22.7M memory peak.630server # [ 22.866326] systemd[1]: Starting Switch Root...631server # [ 22.972252] systemd[1]: Switching root.632server # [ 23.212569] systemd-journald[81]: Received SIGTERM from PID 1 (systemd).633server # [ 24.853740] systemd[1]: systemd 260.5 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 # [ 24.855779] systemd[1]: Detected virtualization qemu.635server # [ 24.857549] systemd[1]: Detected architecture arm64.636server # [ 24.861294] systemd[1]: Detected first boot.637server # [ 24.899362] systemd[1]: Initializing machine ID from random generator.638server # [ 26.436354] systemd[1]: bpf-restrict-fs: LSM BPF program attached639server # [ 28.018735] systemd[1]: Applying preset policy.640server: Guest root shell did not produce any data yet...641server: To debug, enter the VM and run 'systemctl status backdoor.service'.642server # [ 31.550457] systemd[1]: Populated /etc with preset unit settings.643server # [ 36.232868] systemd[1]: initrd-switch-root.service: Deactivated successfully.644server # [ 36.238175] systemd[1]: Stopped initrd-switch-root.service.645server # [ 36.259880] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.646server # [ 36.279315] systemd[1]: Created slice Slice /system/getty.647server # [ 36.295468] systemd[1]: Created slice User and Session Slice.648server # [ 36.301900] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.649server # [ 36.309445] systemd[1]: Started Forward Password Requests to Wall Directory Watch.650server # [ 36.314851] systemd[1]: Expecting device /dev/hvc0...651server # [ 36.317671] systemd[1]: Expecting device /dev/ttyAMA0...652server # [ 36.320846] systemd[1]: Reached target Local Encrypted Volumes.653server # [ 36.325163] systemd[1]: Stopped target initrd-fs.target.654server # [ 36.330596] systemd[1]: Stopped target initrd-root-fs.target.655server # [ 36.333882] systemd[1]: Stopped target initrd-switch-root.target.656server # [ 36.337151] systemd[1]: Reached target Virtual Machines and Containers.657server # [ 36.342818] systemd[1]: Reached target Path Units.658server # [ 36.345966] systemd[1]: Reached target Remote File Systems.659server # [ 36.351710] systemd[1]: Reached target Slice Units.660server # [ 36.355535] systemd[1]: Reached target Swaps.661server # [ 36.389136] systemd[1]: Listening on Process Core Dump Socket.662server # [ 36.412789] systemd[1]: Listening on Credential Encryption/Decryption.663server # [ 36.456995] systemd[1]: Starting Journal Log Access Socket...664server # [ 36.468257] systemd[1]: Listening on Journal Audit Socket.665server # [ 36.479900] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.666server # [ 36.487790] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki667server # [ 36.496132] systemd[1]: Listening on udev Control Socket.668server # [ 36.535495] systemd[1]: Mounting Huge Pages File System...669server # [ 36.581663] systemd[1]: Mounting POSIX Message Queue File System...670server # [ 36.625873] systemd[1]: Mounting Kernel Debug File System...671server # [ 36.727829] systemd[1]: Mounting Kernel Trace File System...672server # [ 36.892949] systemd[1]: Starting Create List of Static Device Nodes...673server # [ 36.974545] systemd[1]: Starting Load Kernel Module 9pnet_virtio...674server # [ 36.988246] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs675server # [ 37.043071] systemd[1]: Mounting Kernel Configuration File System...676server # [ 37.064262] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm677server # [ 37.080697] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore678server # [ 37.222700] systemd[1]: Starting Load Kernel Module fuse...679server # [ 37.240952] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67680server # [ 37.336447] systemd[1]: Starting Journal Service...681server # [ 37.457505] systemd[1]: Starting Load Kernel Modules...682server # [ 37.855651] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...683server # [ 38.059938] systemd[1]: Starting Remount Root and Kernel File Systems...684server # [ 38.083531] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki685server # [ 38.176842] systemd[1]: Starting Coldplug All udev Devices...686server # [ 38.507631] fuse: init (API version 7.45)687server # [ 38.544596] systemd[1]: Listening on Journal Log Access Socket.688server # [ 38.573240] systemd[1]: Mounted Huge Pages File System.689server # [ 38.607144] systemd[1]: Mounted POSIX Message Queue File System.690server # [ 38.635813] systemd[1]: Mounted Kernel Debug File System.691server # [ 38.693423] systemd[1]: Mounted Kernel Trace File System.692server # [ 38.715691] systemd[1]: Finished Create List of Static Device Nodes.693server # [ 38.731976] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.694server # [ 38.747080] systemd[1]: Finished Load Kernel Module 9pnet_virtio.695server # [ 38.756545] systemd[1]: modprobe@fuse.service: Deactivated successfully.696server # [ 38.770699] systemd[1]: Finished Load Kernel Module fuse.697server # [ 38.799786] systemd[1]: Finished Load Kernel Modules.698server # [ 38.891201] systemd[1]: Mounting FUSE Control File System...699server # [ 39.136918] systemd[1]: Starting Firewall...700server # [ 39.257298] EXT4-fs (vda): re-mounted f0cd141f-153e-426f-9095-7acffa84910e.701server # [ 39.285350] systemd[1]: Starting Apply Kernel Variables...702server # [ 39.323756] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...703server # [ 39.431964] systemd[1]: Mounted Kernel Configuration File System.704server # [ 39.505954] systemd-journald[333]: Collecting audit messages is enabled.705server # [ 39.520514] systemd[1]: Finished Remount Root and Kernel File Systems.706server # [ 39.533036] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore707server # [ 39.836053] systemd[1]: Starting Load/Save OS Random Seed...708server # [ 39.746354] systemd[1]: Queued start job for default target Multi-User System.709server # [ 39.867742] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki710server # [ 39.778467] systemd[1]: systemd-journald.service: Deactivated successfully.711server # [ 39.809699] systemd[1]: systemd-journald.service: Consumed 1.065s CPU time over 32.700s wall clock time, 9.8M memory peak.712server # [ 39.860088] systemd-modules-load[334]: Using 2 probe threads713server # [ 39.891772] systemd-modules-load[334]: Module 'atkbd' is built in714server # [ 39.926965] systemd-modules-load[334]: Module 'loop' is built in715server # [ 40.060601] systemd[1]: Started Journal Service.716server # [ 40.042918] systemd-oomd[335]: No swap; memory pressure usage will be degraded717server # [ 40.449293] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.718server # [ 40.616357] systemd[1]: Mounted FUSE Control File System.719server # [ 41.074345] systemd[1]: Finished Load/Save OS Random Seed.720server # [ 41.201985] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.721server # [ 41.293107] systemd[1]: Finished Apply Kernel Variables.722server # [ 41.395082] systemd[1]: Reached target First Boot Complete.723server # [ 41.443736] systemd[1]: Starting Flush Journal to Persistent Storage...724server # [ 41.529386] systemd[1]: Starting Create Static Device Nodes in /dev...725server # [ 42.160784] systemd-journald[333]: Received client request to flush runtime journal.726server # [ 42.445726] systemd[1]: Finished Flush Journal to Persistent Storage.727server # [ 42.528515] systemd[1]: Finished Create Static Device Nodes in /dev.728server # [ 42.575586] systemd[1]: Reached target Preparation for Local File Systems.729server # [ 42.618404] systemd[1]: Mounting /run/wrappers...730server # [ 42.690156] systemd[1]: Starting Rule-based Manager for Device Events and Files...731server # [ 43.181094] systemd[1]: Mounted /run/wrappers.732server # [ 43.225085] systemd[1]: Reached target Local File Systems.733server # [ 43.292985] systemd[1]: Listening on Boot Loader Control Service Socket.734server # [ 43.353261] systemd[1]: Starting register-nix-paths.service...735server # [ 43.547993] systemd[1]: Starting Create SUID/SGID Wrappers...736server # [ 43.565826] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.737server # [ 43.731578] systemd[1]: Starting Save Transient machine-id to Disk...738server # [ 43.912713] systemd[1]: Starting Create System Files and Directories...739server # [ 45.095420] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.740server # [ 45.134111] systemd[1]: Finished Save Transient machine-id to Disk.741server # [ 46.544381] systemd[1]: Finished Create System Files and Directories.742server # [ 46.745686] systemd[1]: Starting Rebuild Journal Catalog...743server # [ 46.955787] systemd[1]: Starting Record System Boot/Shutdown in UTMP...744server # [ 48.289558] systemd[1]: Finished Record System Boot/Shutdown in UTMP.745server # [ 49.481042] systemd[1]: Finished Rebuild Journal Catalog.746server # [ 49.581319] systemd[1]: Starting Update is Completed...747server # [ 50.335843] systemd[1]: Finished Update is Completed.748server # [ 53.239112] systemd-udevd[381]: Using default interface naming scheme 'v260'.749server # [ 55.103642] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.750server # [ 55.143001] systemd[1]: Finished Create SUID/SGID Wrappers.751server # [ 55.151611] systemd[1]: suid-sgid-wrappers.service: Consumed 2.923s CPU time over 11.552s wall clock time, 5.3M memory peak.752server # [ 55.501445] systemd[1]: Started Rule-based Manager for Device Events and Files.753server # [ 57.814599] systemd[1]: Finished register-nix-paths.service.754server # [ 59.027817] systemd[1]: Finished Firewall.755server: Guest root shell did not produce any data yet...756server: To debug, enter the VM and run 'systemctl status backdoor.service'.757server # [ 61.531379] systemd[1]: Finished Coldplug All udev Devices.758server # [ 61.542213] systemd[1]: Reached target System Initialization.759server # [ 61.550272] systemd[1]: Started Discard unused filesystem blocks once a week.760server # [ 61.554731] systemd[1]: Started Daily Cleanup of Temporary Directories.761server # [ 61.559012] systemd[1]: Reached target Timer Units.762server # [ 61.569297] systemd[1]: Listening on D-Bus System Message Bus Socket.763server # [ 61.573402] systemd[1]: Listening on Nix Daemon Socket.764server # [ 61.578962] systemd[1]: Listening on Hostname Service Socket.765server # [ 61.585829] systemd[1]: Reached target Socket Units.766server # [ 61.587588] systemd[1]: Reached target Basic System.767server # [ 61.618074] systemd[1]: Starting Import lastlog data into lastlog2 database...768server # [ 61.686193] systemd[1]: Starting Name Service Cache Daemon (nsncd)...769server # [ 61.734061] systemd[1]: Starting Post-Boot Actions...770server # [ 61.889251] systemd[1]: Started Reset console on configuration changes.771server # [ 62.032931] systemd[1]: Starting resolvconf update...772server # [ 62.659636] systemd[1]: Starting D-Bus System Message Bus...773server # [ 62.761490] systemd[1]: Finished Post-Boot Actions.774server # [ 62.968218] nsncd[592]: Oct 31 19:37:34.944 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"775server # [ 63.007461] systemd[1]: Started Name Service Cache Daemon (nsncd).776server # [ 63.034059] systemd[1]: Reached target Host and Network Name Lookups.777server # [ 63.041854] systemd[1]: Reached target User and Group Name Lookups.778server # [ 63.279988] systemd[1]: Starting User Login Management...779server # [ 63.380820] systemd[1]: Finished Import lastlog data into lastlog2 database.780server # [ 64.463922] dbus-broker-launch[599]: Looking up NSS user entry for 'systemd-timesync'...781server # [ 64.701974] dbus-broker-launch[599]: NSS returned no entry for 'systemd-timesync'782server # [ 64.712090] dbus-broker-launch[599]: Invalid user-name in /nix/store/vwdpn7pp7wk0r49xcqdysw2qqzsvv94q-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"783server # [ 65.116689] systemd[1]: Started D-Bus System Message Bus.784server # [ 65.527450] systemd-logind[613]: New seat seat0.785server # [ 65.586070] systemd[1]: Started User Login Management.786server # [ 65.685285] systemd[1]: Starting linger-users.service...787server # [ 65.743022] dbus-broker-launch[599]: Ready788server # [ 66.238604] systemd[1]: Stopped target Host and Network Name Lookups.789server # [ 66.250480] systemd[1]: Stopping Host and Network Name Lookups...790server # [ 66.263474] systemd[1]: Stopped target User and Group Name Lookups.791server # [ 66.267369] systemd[1]: Stopping User and Group Name Lookups...792server # [ 66.282777] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...793server # [ 66.356124] systemd[1]: nscd.service: Deactivated successfully.794server # [ 66.371798] systemd[1]: Stopped Name Service Cache Daemon (nsncd).795server # [ 66.542374] systemd[1]: linger-users.service: Deactivated successfully.796server # [ 66.597608] systemd[1]: Finished linger-users.service.797server # [ 66.818013] systemd[1]: Starting Name Service Cache Daemon (nsncd)...798server # [ 67.539849] systemd[1]: Started Name Service Cache Daemon (nsncd).799server # [ 67.576859] nsncd[674]: Oct 31 19:37:39.563 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"800server # [ 67.579049] systemd[1]: Reached target Host and Network Name Lookups.801server # [ 67.582813] systemd[1]: Reached target User and Group Name Lookups.802server # [ 67.921415] systemd[1]: Finished resolvconf update.803server # [ 67.954227] systemd[1]: Reached target Preparation for Network.804server # [ 68.029725] systemd[1]: Starting DHCP Client...805server # [ 68.103180] systemd[1]: Starting Extra networking commands....806server # [ 70.854416] dhcpcd[714]: dhcpcd-10.3.1 starting807server # [ 71.083358] dhcpcd[773]: dev: loaded udev808server # [ 71.220961] dhcpcd[773]: no valid interfaces found809server # [ 71.227044] dhcpcd[773]: no valid interfaces found810server # [ 71.244747] dhcpcd[773]: libudev: received NULL device811server # [ 71.256373] dhcpcd[773]: libudev: received NULL device812server # [ 71.486865] systemd[1]: Finished Extra networking commands..813server # [ 71.502269] systemd[1]: Reached target Network.814server # [ 71.541077] systemd[1]: Starting PostgreSQL Database Server...815server # [ 71.602443] systemd[1]: Starting Permit User Sessions...816server # [ 72.133577] systemd[1]: Finished Permit User Sessions.817server # [ 72.235432] systemd[1]: Started Getty on tty1.818server # [ 72.257823] systemd[1]: Reached target Login Prompts.819server # [ 73.026703] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[790]: Initializing database at /var/lib/postgresql/data820server # [ 74.648124] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: The files belonging to this database system will be owned by user "postgres".821server # [ 74.670772] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: This user must also own the server process.822server # [ 74.725499] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: The database cluster will be initialized with locale "en_US.UTF-8".823server # [ 74.727628] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: The default database encoding has accordingly been set to "UTF8".824server # [ 74.734274] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: The default text search configuration will be set to "english".825server # [ 74.735168] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: Data page checksums are enabled.826server # [ 74.735979] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: fixing permissions on existing directory /var/lib/postgresql/data ... ok827server # [ 74.741924] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: creating subdirectories ... ok828server # [ 74.749879] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: selecting dynamic shared memory implementation ... posix829server # [ 76.045911] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: selecting default max_connections ... 100830server # [ 76.759544] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: selecting default shared_buffers ... 128MB831server # [ 87.066022] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: selecting default time zone ... UTC832server # [ 87.094598] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: creating configuration files ... ok833server: Guest root shell did not produce any data yet...834server: To debug, enter the VM and run 'systemctl status backdoor.service'.835server # [ 91.291247] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: running bootstrap script ... ok836server # [ 101.272215] dhcpcd[773]: timed out837server # [ 101.294882] dhcpcd[773]: timed out838server # [ 101.306890] systemd[1]: Started DHCP Client.839server # [ 101.682256] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: performing post-bootstrap initialization ... ok840server # [ 104.666330] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: syncing data to disk ... ok841server # [ 104.669399] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: initdb: warning: enabling "trust" authentication for local connections842server # [ 104.671429] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: 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.843server # [ 104.678649] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: Success. You can now start the database server using:844server # [ 104.680554] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[805]: /nix/store/as2nds8lpb4qfzhl3yshr0z6dkjwy99z-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start845server # [ 106.047596] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[790]: Validating PostgreSQL configuration...846server # [ 106.455803] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[1036]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault847server # [ 107.496281] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3848server # [ 107.681416] postgres[1038]: 2026-10-31 19:38:19.702 UTC [1038] LOG: pgaudit extension initialized849server # [ 108.483576] postgres[1038]: 2026-10-31 19:38:20.511 UTC [1038] LOG: pgsodium primary server secret key loaded850server # [ 108.943104] postgres[1038]: 2026-10-31 19:38:20.959 UTC [1038] LOG: vault primary server secret key loaded851server # [ 109.200688] postgres[1038]: 2026-10-31 19:38:21.228 UTC [1038] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.3.0, 64-bit852server # [ 109.220638] postgres[1038]: 2026-10-31 19:38:21.248 UTC [1038] LOG: listening on IPv4 address "0.0.0.0", port 5432853server # [ 109.225439] postgres[1038]: 2026-10-31 19:38:21.251 UTC [1038] LOG: listening on IPv6 address "::", port 5432854server # [ 109.247430] postgres[1038]: 2026-10-31 19:38:21.275 UTC [1038] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"855server # [ 109.351544] postgres[1063]: 2026-10-31 19:38:21.367 UTC [1063] LOG: database system was shut down at 2026-10-31 19:38:13 UTC856server # [ 109.582136] postgres[1038]: 2026-10-31 19:38:21.607 UTC [1038] LOG: database system is ready to accept connections857server # [ 109.600538] postgres[1067]: 2026-10-31 19:38:21.621 UTC [1067] FATAL: role "postgres" does not exist858server # [ 109.643229] postgres[1066]: 2026-10-31 19:38:21.648 UTC [1066] LOG: TimescaleDB background worker launcher connected to shared catalogs859server # [ 109.700024] systemd[1]: Started PostgreSQL Database Server.860server # [ 109.743231] postgres[1038]: 2026-10-31 19:38:21.769 UTC [1038] LOG: background worker "pg_net 0.20.4 worker" (PID 1067) exited with exit code 1861server # [ 109.781326] systemd[1]: Starting Supabase Database Initialization...862server # [ 109.872202] postgres[1068]: 2026-10-31 19:38:21.871 UTC [1068] LOG: pg_cron scheduler started863server # [ 110.334931] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Waiting for PostgreSQL to be ready...864server # [ 110.910794] postgres[1086]: 2026-10-31 19:38:22.927 UTC [1086] FATAL: role "postgres" does not exist865server # [ 110.975708] postgres[1038]: 2026-10-31 19:38:22.999 UTC [1038] LOG: background worker "pg_net 0.20.4 worker" (PID 1086) exited with exit code 1866server # [ 111.137819] postgres[1089]: ::1 2026-10-31 19:38:23.162 UTC [1089] root@root FATAL: role "root" does not exist867server # [ 111.225676] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: PostgreSQL is ready868server # [ 111.237537] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Creating postgres role...869server # [ 111.676211] postgres[1097]: ::1 2026-10-31 19:38:23.700 UTC [1097] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN;870server # [ 111.699553] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1094]: CREATE ROLE871server # [ 112.046740] postgres[1099]: ::1 2026-10-31 19:38:24.055 UTC [1099] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres;872server # [ 112.090173] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1098]: ALTER DATABASE873server # [ 112.139261] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql874server # [ 112.431444] postgres[1102]: ::1 2026-10-31 19:38:24.451 UTC [1102] postgres@postgres LOG: statement: create publication supabase_realtime;875server # [ 112.462984] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: CREATE PUBLICATION876server # [ 112.466355] postgres[1102]: ::1 2026-10-31 19:38:24.480 UTC [1102] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls;877server # [ 112.473655] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: ALTER ROLE878server # [ 112.476757] postgres[1102]: ::1 2026-10-31 19:38:24.495 UTC [1102] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication;879server # [ 112.479190] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: CREATE ROLE880server # [ 112.481701] postgres[1102]: ::1 2026-10-31 19:38:24.508 UTC [1102] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls;881server # [ 112.492334] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: CREATE ROLE882server # [ 112.498771] postgres[1102]: ::1 2026-10-31 19:38:24.526 UTC [1102] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin;883server # [ 112.513369] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: GRANT ROLE884server # [ 112.517181] postgres[1102]: ::1 2026-10-31 19:38:24.545 UTC [1102] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin;885server # [ 112.526109] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: GRANT886server # [ 112.531480] postgres[1102]: ::1 2026-10-31 19:38:24.554 UTC [1102] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls;887server # [ 112.536144] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: CREATE ROLE888server # [ 112.538423] postgres[1102]: ::1 2026-10-31 19:38:24.565 UTC [1102] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user;889server # [ 112.546102] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: GRANT ROLE890server # [ 112.548808] postgres[1102]: ::1 2026-10-31 19:38:24.573 UTC [1102] postgres@postgres LOG: statement: create schema if not exists extensions;891server # [ 112.569166] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: CREATE SCHEMA892server # [ 112.571614] postgres[1102]: ::1 2026-10-31 19:38:24.594 UTC [1102] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions;893server # [ 115.093164] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: CREATE EXTENSION894server # [ 115.110765] postgres[1102]: ::1 2026-10-31 19:38:27.117 UTC [1102] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions;895server # [ 116.062645] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: CREATE EXTENSION896server # [ 116.071119] postgres[1102]: ::1 2026-10-31 19:38:28.092 UTC [1102] postgres@postgres LOG: statement: create role anon nologin noinherit;897server # [ 116.077688] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: CREATE ROLE898server # [ 116.085675] postgres[1102]: ::1 2026-10-31 19:38:28.107 UTC [1102] postgres@postgres LOG: statement: create role authenticated nologin noinherit;899server # [ 116.107125] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: CREATE ROLE900server # [ 116.113107] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: CREATE ROLE901server # [ 116.130722] postgres[1102]: ::1 2026-10-31 19:38:28.120 UTC [1102] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls;902server # [ 116.134443] postgres[1102]: ::1 2026-10-31 19:38:28.139 UTC [1102] postgres@postgres LOG: statement: create user authenticator noinherit;903server # [ 116.141470] postgres[1102]: ::1 2026-10-31 19:38:28.155 UTC [1102] postgres@postgres LOG: statement: grant anon to authenticator;904server # [ 116.145665] postgres[1102]: ::1 2026-10-31 19:38:28.167 UTC [1102] postgres@postgres LOG: statement: grant authenticated to authenticator;905server # [ 116.149831] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: CREATE ROLE906server # [ 116.154199] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: GRANT ROLE907server # [ 116.160966] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: GRANT ROLE908server # [ 116.165317] postgres[1102]: ::1 2026-10-31 19:38:28.185 UTC [1102] postgres@postgres LOG: statement: grant service_role to authenticator;909server # [ 116.175242] postgres[1102]: ::1 2026-10-31 19:38:28.196 UTC [1102] postgres@postgres LOG: statement: grant supabase_admin to authenticator;910server # [ 116.179034] postgres[1102]: ::1 2026-10-31 19:38:28.203 UTC [1102] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role;911server # [ 116.182747] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: GRANT ROLE912server # [ 116.186856] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: GRANT ROLE913server # [ 116.193484] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: GRANT914server # [ 116.194852] postgres[1102]: ::1 2026-10-31 19:38:28.217 UTC [1102] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;915server # [ 116.206229] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: ALTER DEFAULT PRIVILEGES916server # [ 116.214943] postgres[1102]: ::1 2026-10-31 19:38:28.235 UTC [1102] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;917server # [ 116.217413] postgres[1102]: ::1 2026-10-31 19:38:28.244 UTC [1102] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;918server # [ 116.221241] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: ALTER DEFAULT PRIVILEGES919server # [ 116.224214] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: ALTER DEFAULT PRIVILEGES920server # [ 116.232162] postgres[1102]: ::1 2026-10-31 19:38:28.257 UTC [1102] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role;921server # [ 116.237875] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: GRANT922server # [ 116.240393] postgres[1102]: ::1 2026-10-31 19:38:28.268 UTC [1102] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions;923server # [ 116.259156] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: ALTER ROLE924server # [ 116.266678] postgres[1102]: ::1 2026-10-31 19:38:28.286 UTC [1102] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all925server # [ 116.270950] postgres[1102]: on sequences to postgres, anon, authenticated, service_role;926server # [ 116.276136] postgres[1102]: ::1 2026-10-31 19:38:28.297 UTC [1102] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all927server # [ 116.282729] postgres[1102]: on tables to postgres, anon, authenticated, service_role;928server # [ 116.285714] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: ALTER DEFAULT PRIVILEGES929server # [ 116.286934] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: ALTER DEFAULT PRIVILEGES930server # [ 116.289887] postgres[1102]: ::1 2026-10-31 19:38:28.309 UTC [1102] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all931server # [ 116.294040] postgres[1102]: on functions to postgres, anon, authenticated, service_role;932server # [ 116.296965] postgres[1102]: ::1 2026-10-31 19:38:28.322 UTC [1102] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s';933server # [ 116.298655] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: ALTER DEFAULT PRIVILEGES934server # [ 116.303538] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: ALTER ROLE935server # [ 116.307267] postgres[1102]: ::1 2026-10-31 19:38:28.335 UTC [1102] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s';936server # [ 116.319977] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1101]: ALTER ROLE937server # [ 116.355569] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql938server # [ 116.645668] postgres[1124]: ::1 2026-10-31 19:38:28.658 UTC [1124] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;939server # [ 116.649855] postgres[1124]: ::1 2026-10-31 19:38:28.669 UTC [1124] postgres@postgres LOG: statement: CREATE TABLE auth.users (940server # [ 116.659140] postgres[1124]: instance_id uuid NULL,941server # [ 116.666347] postgres[1124]: id uuid NOT NULL UNIQUE,942server # [ 116.667522] postgres[1124]: aud varchar(255) NULL,943server # [ 116.671813] postgres[1124]: "role" varchar(255) NULL,944server # [ 116.675298] postgres[1124]: email varchar(255) NULL UNIQUE,945server # [ 116.678626] postgres[1124]: encrypted_password varchar(255) NULL,946server # [ 116.682223] postgres[1124]: confirmed_at timestamptz NULL,947server # [ 116.683084] postgres[1124]: invited_at timestamptz NULL,948server # [ 116.685243] postgres[1124]: confirmation_token varchar(255) NULL,949server # [ 116.686192] postgres[1124]: confirmation_sent_at timestamptz NULL,950server # [ 116.688989] postgres[1124]: recovery_token varchar(255) NULL,951server # [ 116.690168] postgres[1124]: recovery_sent_at timestamptz NULL,952server # [ 116.691071] postgres[1124]: email_change_token varchar(255) NULL,953server # [ 116.693210] postgres[1124]: email_change varchar(255) NULL,954server # [ 116.695368] postgres[1124]: email_change_sent_at timestamptz NULL,955server # [ 116.701163] postgres[1124]: last_sign_in_at timestamptz NULL,956server # [ 116.704314] postgres[1124]: raw_app_meta_data jsonb NULL,957server # [ 116.710354] postgres[1124]: raw_user_meta_data jsonb NULL,958server # [ 116.713780] postgres[1124]: is_super_admin bool NULL,959server # [ 116.717650] postgres[1124]: created_at timestamptz NULL,960server # [ 116.718987] postgres[1124]: updated_at timestamptz NULL,961server # [ 116.720295] postgres[1124]: CONSTRAINT users_pkey PRIMARY KEY (id)962server # [ 116.721746] postgres[1124]: );963server # [ 116.728020] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE SCHEMA964server # [ 116.789587] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE TABLE965server # [ 116.796709] postgres[1124]: ::1 2026-10-31 19:38:28.823 UTC [1124] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);966server # [ 116.830191] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE INDEX967server # [ 116.837847] postgres[1124]: ::1 2026-10-31 19:38:28.859 UTC [1124] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);968server # [ 116.865823] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE INDEX969server # [ 116.870125] postgres[1124]: ::1 2026-10-31 19:38:28.890 UTC [1124] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';970server # [ 116.877935] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: COMMENT971server # [ 116.887550] postgres[1124]: ::1 2026-10-31 19:38:28.909 UTC [1124] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens (972server # [ 116.893965] postgres[1124]: instance_id uuid NULL,973server # [ 116.898275] postgres[1124]: id bigserial NOT NULL,974server # [ 116.902249] postgres[1124]: "token" varchar(255) NULL,975server # [ 116.903235] postgres[1124]: user_id varchar(255) NULL,976server # [ 116.906979] postgres[1124]: revoked bool NULL,977server # [ 116.908162] postgres[1124]: created_at timestamptz NULL,978server # [ 116.913003] postgres[1124]: updated_at timestamptz NULL,979server # [ 116.915272] postgres[1124]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)980server # [ 116.918377] postgres[1124]: );981server # [ 116.983242] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE TABLE982server # [ 116.993116] postgres[1124]: ::1 2026-10-31 19:38:29.012 UTC [1124] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);983server # [ 117.021057] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE INDEX984server # [ 117.022366] postgres[1124]: ::1 2026-10-31 19:38:29.047 UTC [1124] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id);985server # [ 117.067490] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE INDEX986server # [ 117.078994] postgres[1124]: ::1 2026-10-31 19:38:29.092 UTC [1124] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);987server # [ 117.130645] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE INDEX988server # [ 117.142952] postgres[1124]: ::1 2026-10-31 19:38:29.162 UTC [1124] postgres@postgres LOG: statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.';989server # [ 117.159330] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: COMMENT990server # [ 117.162890] postgres[1124]: ::1 2026-10-31 19:38:29.191 UTC [1124] postgres@postgres LOG: statement: CREATE TABLE auth.instances (991server # [ 117.166448] postgres[1124]: id uuid NOT NULL,992server # [ 117.167825] postgres[1124]: uuid uuid NULL,993server # [ 117.178794] postgres[1124]: raw_base_config text NULL,994server # [ 117.182257] postgres[1124]: created_at timestamptz NULL,995server # [ 117.183306] postgres[1124]: updated_at timestamptz NULL,996server # [ 117.184994] postgres[1124]: CONSTRAINT instances_pkey PRIMARY KEY (id)997server # [ 117.186968] postgres[1124]: );998server # [ 117.266357] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE TABLE999server # [ 117.268906] postgres[1124]: ::1 2026-10-31 19:38:29.295 UTC [1124] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';1000server # [ 117.283124] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: COMMENT1001server # [ 117.291228] postgres[1124]: ::1 2026-10-31 19:38:29.308 UTC [1124] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries (1002server # [ 117.301728] postgres[1124]: instance_id uuid NULL,1003server # [ 117.303418] postgres[1124]: id uuid NOT NULL,1004server # [ 117.305575] postgres[1124]: payload json NULL,1005server # [ 117.313947] postgres[1124]: created_at timestamptz NULL,1006server # [ 117.319047] postgres[1124]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)1007server # [ 117.337548] postgres[1124]: );1008server # [ 117.377657] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE TABLE1009server # [ 117.381689] postgres[1124]: ::1 2026-10-31 19:38:29.406 UTC [1124] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);1010server # [ 117.438336] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE INDEX1011server # [ 117.451051] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: COMMENT1012server # [ 117.457840] postgres[1124]: ::1 2026-10-31 19:38:29.466 UTC [1124] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';1013server # [ 117.463258] postgres[1124]: ::1 2026-10-31 19:38:29.475 UTC [1124] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations (1014server # [ 117.477907] postgres[1124]: "version" varchar(255) NOT NULL,1015server # [ 117.481253] postgres[1124]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")1016server # [ 117.491625] postgres[1124]: );1017server # [ 117.495260] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE TABLE1018server # [ 117.503855] postgres[1124]: ::1 2026-10-31 19:38:29.529 UTC [1124] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';1019server # [ 117.522350] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: COMMENT1020server # [ 117.565087] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: INSERT 0 71021server # [ 117.589314] postgres[1124]: ::1 2026-10-31 19:38:29.615 UTC [1124] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$1022server # [ 117.590546] postgres[1124]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;1023server # [ 117.591535] postgres[1124]: $$ language sql stable;1024server # [ 117.603569] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE FUNCTION1025server # [ 117.605643] postgres[1124]: ::1 2026-10-31 19:38:29.633 UTC [1124] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$1026server # [ 117.606871] postgres[1124]: select nullif(current_setting('request.jwt.claim.role', true), '')::text;1027server # [ 117.609148] postgres[1124]: $$ language sql stable;1028server # [ 117.617112] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE FUNCTION1029server # [ 117.625463] postgres[1124]: ::1 2026-10-31 19:38:29.649 UTC [1124] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$1030server # [ 117.628343] postgres[1124]: select nullif(current_setting('request.jwt.claim.email', true), '')::text;1031server # [ 117.644196] postgres[1124]: $$ language sql stable;1032server # [ 117.657432] postgres[1124]: ::1 2026-10-31 19:38:29.667 UTC [1124] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;1033server # [ 117.661063] postgres[1124]: ::1 2026-10-31 19:38:29.676 UTC [1124] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1034server # [ 117.663651] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE FUNCTION1035server # [ 117.664611] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: GRANT1036server # [ 117.669121] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: CREATE ROLE1037server # [ 117.674571] postgres[1124]: ::1 2026-10-31 19:38:29.692 UTC [1124] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1038server # [ 117.681643] postgres[1124]: ::1 2026-10-31 19:38:29.709 UTC [1124] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1039server # [ 117.683330] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: GRANT1040server # [ 117.706033] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: GRANT1041server # [ 117.709579] postgres[1124]: ::1 2026-10-31 19:38:29.734 UTC [1124] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1042server # [ 117.720756] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: GRANT1043server # [ 117.729536] postgres[1124]: ::1 2026-10-31 19:38:29.755 UTC [1124] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth";1044server # [ 117.753456] postgres[1124]: ::1 2026-10-31 19:38:29.777 UTC [1124] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin;1045server # [ 117.790133] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: ALTER ROLE1046server # [ 117.800572] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: ALTER TABLE1047server # [ 117.809882] postgres[1124]: ::1 2026-10-31 19:38:29.832 UTC [1124] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;1048server # [ 117.831608] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: ALTER TABLE1049server # [ 117.837544] postgres[1124]: ::1 2026-10-31 19:38:29.862 UTC [1124] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;1050server # [ 117.850763] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: ALTER TABLE1051server # [ 117.857862] postgres[1124]: ::1 2026-10-31 19:38:29.885 UTC [1124] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;1052server # [ 117.877163] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: ALTER TABLE1053server # [ 117.878848] postgres[1124]: ::1 2026-10-31 19:38:29.906 UTC [1124] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;1054server # [ 117.895404] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1123]: ALTER TABLE1055server # [ 117.944155] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql1056server # [ 118.389727] postgres[1143]: ::1 2026-10-31 19:38:30.391 UTC [1143] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;1057server # [ 118.397254] postgres[1143]: ::1 2026-10-31 19:38:30.422 UTC [1143] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1058server # [ 118.411948] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1139]: CREATE SCHEMA1059server # [ 118.413273] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1139]: CREATE ROLE1060server # [ 118.417613] postgres[1143]: ::1 2026-10-31 19:38:30.441 UTC [1143] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage";1061server # [ 118.424661] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1139]: ALTER ROLE1062server # [ 118.427108] postgres[1143]: ::1 2026-10-31 19:38:30.455 UTC [1143] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;1063server # [ 118.446634] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1139]: GRANT1064server # [ 118.506426] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1139]: DO1065server # [ 118.561375] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql1066server # [ 118.867172] postgres[1148]: ::1 2026-10-31 19:38:30.882 UTC [1148] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;1067server # [ 118.874951] postgres[1148]: ::1 2026-10-31 19:38:30.894 UTC [1148] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;1068server # [ 118.885941] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: ALTER ROLE1069server # [ 118.890400] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: ALTER ROLE1070server # [ 118.901235] postgres[1148]: ::1 2026-10-31 19:38:30.904 UTC [1148] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()1071server # [ 118.904785] postgres[1148]: RETURNS event_trigger1072server # [ 118.905789] postgres[1148]: LANGUAGE plpgsql1073server # [ 118.907245] postgres[1148]: AS $$1074server # [ 118.909327] postgres[1148]: DECLARE1075server # [ 118.911137] postgres[1148]: schema_is_cron bool;1076server # [ 118.913513] postgres[1148]: BEGIN1077server # [ 118.914590] postgres[1148]: schema_is_cron = (1078server # [ 118.917316] postgres[1148]: SELECT n.nspname = 'cron'1079server # [ 118.920710] postgres[1148]: FROM pg_event_trigger_ddl_commands() AS ev1080server # [ 118.921995] postgres[1148]: LEFT JOIN pg_catalog.pg_namespace AS n1081server # [ 118.922939] postgres[1148]: ON ev.objid = n.oid1082server # [ 118.924091] postgres[1148]: );1083server # [ 118.926150] postgres[1148]:1084server # [ 118.927147] postgres[1148]: IF schema_is_cron1085server # [ 118.928925] postgres[1148]: THEN1086server # [ 118.930526] postgres[1148]: grant usage on schema cron to postgres with grant option;1087server # [ 118.932139] postgres[1148]:1088server # [ 118.934627] postgres[1148]: alter default privileges in schema cron grant all on tables to postgres with grant option;1089server # [ 118.936068] postgres[1148]: alter default privileges in schema cron grant all on functions to postgres with grant option;1090server # [ 118.939562] postgres[1148]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1091server # [ 118.942171] postgres[1148]:1092server # [ 118.943593] postgres[1148]: alter default privileges for user supabase_admin in schema cron grant all1093server # [ 118.945908] postgres[1148]: on sequences to postgres with grant option;1094server # [ 118.946967] postgres[1148]: alter default privileges for user supabase_admin in schema cron grant all1095server # [ 118.948966] postgres[1148]: on tables to postgres with grant option;1096server # [ 118.950983] postgres[1148]: alter default privileges for user supabase_admin in schema cron grant all1097server # [ 118.953202] postgres[1148]: on functions to postgres with grant option;1098server # [ 118.955012] postgres[1148]:1099server # [ 118.957196] postgres[1148]: grant all privileges on all tables in schema cron to postgres with grant option;1100server # [ 118.958108] postgres[1148]:1101server # [ 118.958812] postgres[1148]: END IF;1102server # [ 118.965551] postgres[1148]:1103server # [ 118.969216] postgres[1148]: END;1104server # [ 118.973369] postgres[1148]: $$;1105server # [ 118.979840] postgres[1148]: ::1 2026-10-31 19:38:30.923 UTC [1148] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')1106server # [ 118.989326] postgres[1148]: EXECUTE PROCEDURE extensions.grant_pg_cron_access();1107server # [ 118.990514] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: CREATE FUNCTION1108server # [ 118.991308] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: CREATE EVENT TRIGGER1109server # [ 119.008107] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: COMMENT1110server # [ 119.013164] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: CREATE FUNCTION1111server # [ 119.017135] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: COMMENT1112server # [ 119.021040] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: DO1113server # [ 119.023932] postgres[1148]: ::1 2026-10-31 19:38:30.936 UTC [1148] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';1114server # [ 119.033130] postgres[1148]: ::1 2026-10-31 19:38:30.954 UTC [1148] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()1115server # [ 119.038724] postgres[1148]: RETURNS event_trigger1116server # [ 119.045861] postgres[1148]: LANGUAGE plpgsql1117server # [ 119.047181] postgres[1148]: AS $$1118server # [ 119.055404] postgres[1148]: BEGIN1119server # [ 119.060058] postgres[1148]: IF EXISTS (1120server # [ 119.061946] postgres[1148]: SELECT 11121server # [ 119.066532] postgres[1148]: FROM pg_event_trigger_ddl_commands() AS ev1122server # [ 119.077386] postgres[1148]: JOIN pg_extension AS ext1123server # [ 119.082631] postgres[1148]: ON ev.objid = ext.oid1124server # [ 119.087749] postgres[1148]: WHERE ext.extname = 'pg_net'1125server # [ 119.091952] postgres[1148]: )1126server # [ 119.097478] postgres[1148]: THEN1127server # [ 119.099137] postgres[1148]: IF NOT EXISTS (1128server # [ 119.103012] postgres[1148]: SELECT 11129server: Guest root shell did not produce any data yet...1130server: To debug, enter the VM and run 'systemctl status backdoor.service'.1131server # [ 119.111587] postgres[1148]: FROM pg_roles1132server # [ 119.122895] postgres[1148]: WHERE rolname = 'supabase_functions_admin'1133server # [ 119.127433] postgres[1148]: )1134server # [ 119.131042] postgres[1148]: THEN1135server # [ 119.133055] postgres[1148]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1136server # [ 119.133921] postgres[1148]: END IF;1137server # [ 119.134550] postgres[1148]:1138server # [ 119.135123] postgres[1148]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;1139server # [ 119.135974] postgres[1148]:1140server # [ 119.145709] postgres[1148]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1141server # [ 119.162444] postgres[1148]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1142server # [ 119.165411] postgres[1148]:1143server # [ 119.169867] postgres[1148]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1144server # [ 119.186583] postgres[1148]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1145server # [ 119.193411] postgres[1148]:1146server # [ 119.194941] postgres[1148]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1147server # [ 119.202545] postgres[1148]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1148server # [ 119.209913] postgres[1148]:1149server # [ 119.213713] postgres[1148]: 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;1150server # [ 119.225602] postgres[1148]: 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;1151server # [ 119.241902] postgres[1148]: END IF;1152server # [ 119.245551] postgres[1148]: END;1153server # [ 119.253430] postgres[1148]: $$;1154server # [ 119.257628] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: CREATE ROLE1155server # [ 119.269233] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: GRANT1156server # [ 119.270354] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: GRANT1157server # [ 119.275443] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: GRANT1158server # [ 119.280759] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: GRANT1159server # [ 119.291818] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: GRANT1160server # [ 119.299466] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: GRANT1161server # [ 119.301316] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: GRANT1162server # [ 119.306502] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: GRANT1163server # [ 119.318859] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: GRANT1164server # [ 119.325425] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1147]: DO1165server # [ 119.333236] postgres[1148]: ::1 2026-10-31 19:38:30.974 UTC [1148] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';1166server # [ 119.343960] postgres[1148]: ::1 2026-10-31 19:38:31.019 UTC [1148] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;1167server # [ 119.352996] postgres[1148]: ::1 2026-10-31 19:38:31.028 UTC [1148] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user;1168server # [ 119.355443] postgres[1148]: ::1 2026-10-31 19:38:31.043 UTC [1148] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user;1169server # [ 119.357815] postgres[1148]: ::1 2026-10-31 19:38:31.058 UTC [1148] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;1170server # [ 119.358683] postgres[1148]: ::1 2026-10-31 19:38:31.071 UTC [1148] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;1171server # [ 119.359798] postgres[1148]: ::1 2026-10-31 19:38:31.082 UTC [1148] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;1172server # [ 119.363440] postgres[1148]: ::1 2026-10-31 19:38:31.085 UTC [1148] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;1173server # [ 119.365545] postgres[1148]: ::1 2026-10-31 19:38:31.093 UTC [1148] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;1174server # [ 119.367026] postgres[1148]: ::1 2026-10-31 19:38:31.097 UTC [1148] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;1175server # [ 119.369279] postgres[1148]: ::1 2026-10-31 19:38:31.114 UTC [1148] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;1176server # [ 119.377860] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running pgbouncer auth schema...1177server # [ 119.521367] postgres[1150]: ::1 2026-10-31 19:38:31.543 UTC [1150] postgres@postgres LOG: statement: CREATE USER pgbouncer;1178server # [ 119.539311] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1149]: CREATE ROLE1179server # [ 119.542522] postgres[1150]: ::1 2026-10-31 19:38:31.565 UTC [1150] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;1180server # [ 119.550566] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1149]: REVOKE1181server # [ 119.557434] postgres[1150]: ::1 2026-10-31 19:38:31.580 UTC [1150] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;1182server # [ 119.593258] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1149]: CREATE SCHEMA1183server # [ 119.597578] postgres[1150]: ::1 2026-10-31 19:38:31.621 UTC [1150] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)1184server # [ 119.599665] postgres[1150]: RETURNS TABLE(username TEXT, password TEXT) AS1185server # [ 119.605236] postgres[1150]: $$1186server # [ 119.607073] postgres[1150]: BEGIN1187server # [ 119.609189] postgres[1150]: RAISE WARNING 'PgBouncer auth request: %', p_usename;1188server # [ 119.614968] postgres[1150]:1189server # [ 119.616163] postgres[1150]: RETURN QUERY1190server # [ 119.618432] postgres[1150]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow1191server # [ 119.619358] postgres[1150]: WHERE usename = p_usename;1192server # [ 119.621686] postgres[1150]: END;1193server # [ 119.622979] postgres[1150]: $$ LANGUAGE plpgsql1194server # [ 119.626815] postgres[1150]: SET search_path = ''1195server # [ 119.631242] postgres[1150]: SECURITY DEFINER;1196server # [ 119.633602] postgres[1150]: ::1 2026-10-31 19:38:31.646 UTC [1150] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;1197server # [ 119.639969] postgres[1150]: ::1 2026-10-31 19:38:31.659 UTC [1150] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;1198server # [ 119.649840] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1149]: CREATE FUNCTION1199server # [ 119.653079] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1149]: REVOKE1200server # [ 119.660811] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1149]: GRANT1201server # [ 119.692669] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running stat extension...1202server # [ 119.999630] postgres[1152]: ::1 2026-10-31 19:38:32.025 UTC [1152] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions;1203server # [ 120.017865] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1151]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping1204server # [ 120.026666] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1151]: CREATE SCHEMA1205server # [ 120.028292] postgres[1152]: ::1 2026-10-31 19:38:32.055 UTC [1152] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;1206server # [ 121.544920] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1151]: CREATE EXTENSION1207server # [ 121.601511] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql1208server # [ 121.883870] postgres[1174]: ::1 2026-10-31 19:38:33.902 UTC [1174] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres;1209server # [ 121.904371] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1173]: GRANT1210server # [ 121.913982] postgres[1174]: ::1 2026-10-31 19:38:33.923 UTC [1174] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres;1211server # [ 121.921392] postgres[1174]: ::1 2026-10-31 19:38:33.945 UTC [1174] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres;1212server # [ 121.926514] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1173]: GRANT1213server # [ 121.933406] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1173]: GRANT1214server # [ 121.935183] postgres[1174]: ::1 2026-10-31 19:38:33.961 UTC [1174] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;1215server # [ 121.963530] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1173]: GRANT1216server # [ 121.966882] postgres[1174]: ::1 2026-10-31 19:38:33.992 UTC [1174] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;1217server # [ 121.986862] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1173]: GRANT1218server # [ 121.990201] postgres[1174]: ::1 2026-10-31 19:38:34.011 UTC [1174] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;1219server # [ 121.997620] postgres[1174]: ::1 2026-10-31 19:38:34.022 UTC [1174] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;1220server # [ 121.999055] postgres[1174]: ::1 2026-10-31 19:38:34.025 UTC [1174] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;1221server # [ 122.006731] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1173]: GRANT1222server # [ 122.009588] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1173]: GRANT1223server # [ 122.010940] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1173]: GRANT1224server # [ 122.012192] postgres[1174]: ::1 2026-10-31 19:38:34.039 UTC [1174] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;1225server # [ 122.052577] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1173]: GRANT1226server # [ 122.076779] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1173]: DO1227server # [ 122.083194] postgres[1174]: ::1 2026-10-31 19:38:34.104 UTC [1174] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;1228server # [ 122.091024] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1173]: ALTER ROLE1229server # [ 122.115425] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql1230server # [ 122.395279] postgres[1176]: ::1 2026-10-31 19:38:34.418 UTC [1176] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1231server # [ 122.407081] postgres[1176]: ::1 2026-10-31 19:38:34.434 UTC [1176] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1232server # [ 122.418696] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: GRANT1233server # [ 122.435560] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: GRANT1234server # [ 122.443240] postgres[1176]: ::1 2026-10-31 19:38:34.458 UTC [1176] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1235server # [ 122.449304] postgres[1176]: ::1 2026-10-31 19:38:34.467 UTC [1176] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;1236server # [ 122.451211] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: GRANT1237server # [ 122.454519] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: ALTER TABLE1238server # [ 122.456947] postgres[1176]: ::1 2026-10-31 19:38:34.484 UTC [1176] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;1239server # [ 122.468800] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: ALTER TABLE1240server # [ 122.478226] postgres[1176]: ::1 2026-10-31 19:38:34.497 UTC [1176] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;1241server # [ 122.497052] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: ALTER TABLE1242server # [ 122.499314] postgres[1176]: ::1 2026-10-31 19:38:34.527 UTC [1176] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;1243server # [ 122.512029] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: ALTER TABLE1244server # [ 122.514987] postgres[1176]: ::1 2026-10-31 19:38:34.537 UTC [1176] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;1245server # [ 122.525388] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: ALTER TABLE1246server # [ 122.531513] postgres[1176]: ::1 2026-10-31 19:38:34.550 UTC [1176] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres;1247server # [ 122.534585] postgres[1176]: ::1 2026-10-31 19:38:34.558 UTC [1176] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;1248server # [ 122.538873] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: GRANT1249server # [ 122.545818] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: GRANT1250server # [ 122.550340] postgres[1176]: ::1 2026-10-31 19:38:34.574 UTC [1176] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;1251server # [ 122.557514] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: GRANT1252server # [ 122.559488] postgres[1176]: ::1 2026-10-31 19:38:34.587 UTC [1176] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;1253server # [ 122.570214] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: GRANT1254server # [ 122.573577] postgres[1176]: ::1 2026-10-31 19:38:34.600 UTC [1176] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user;1255server # [ 122.587041] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: ALTER DEFAULT PRIVILEGES1256server # [ 122.590763] postgres[1176]: ::1 2026-10-31 19:38:34.618 UTC [1176] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1257server # [ 122.599956] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: ALTER DEFAULT PRIVILEGES1258server # [ 122.607913] postgres[1176]: ::1 2026-10-31 19:38:34.631 UTC [1176] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user;1259server # [ 122.614738] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1175]: ALTER DEFAULT PRIVILEGES1260server # [ 122.687663] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql1261server # [ 122.937019] postgres[1178]: ::1 2026-10-31 19:38:34.954 UTC [1178] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime;1262server # [ 122.957252] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1177]: CREATE SCHEMA1263server # [ 122.989627] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql1264server # [ 123.355486] postgres[1180]: ::1 2026-10-31 19:38:35.352 UTC [1180] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres;1265server # [ 123.390364] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1179]: GRANT1266server # [ 123.392883] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1179]: GRANT1267server # [ 123.396080] postgres[1180]: ::1 2026-10-31 19:38:35.411 UTC [1180] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;1268server # [ 123.402369] postgres[1180]: ::1 2026-10-31 19:38:35.418 UTC [1180] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;1269server # [ 123.405442] postgres[1180]: ::1 2026-10-31 19:38:35.422 UTC [1180] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;1270server # [ 123.408777] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1179]: GRANT1271server # [ 123.417325] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1179]: GRANT1272server # [ 123.455157] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql1273server # [ 123.956288] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1187]: DO1274server # [ 123.965676] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1187]: DO1275server # [ 123.982257] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1187]: DO1276server # [ 124.044530] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql1277server # [ 124.499003] postgres[1206]: ::1 2026-10-31 19:38:36.522 UTC [1206] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user;1278server # [ 124.549440] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1202]: ALTER DEFAULT PRIVILEGES1279server # [ 124.552855] postgres[1206]: ::1 2026-10-31 19:38:36.554 UTC [1206] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1280server # [ 124.555456] postgres[1206]: ::1 2026-10-31 19:38:36.574 UTC [1206] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user;1281server # [ 124.564785] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1202]: ALTER DEFAULT PRIVILEGES1282server # [ 124.567799] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1202]: ALTER DEFAULT PRIVILEGES1283server # [ 124.591427] systemd[1]: Starting Virtual Console Setup...1284server # [ 124.605664] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql1285server # [ 125.016389] postgres[1210]: ::1 2026-10-31 19:38:37.036 UTC [1210] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';1286server # [ 125.080250] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1208]: ALTER ROLE1287server # [ 125.133058] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql1288server # [ 125.692759] postgres[1213]: ::1 2026-10-31 19:38:37.715 UTC [1213] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1289server # [ 125.739928] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1290server # [ 125.750528] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: DROP EVENT TRIGGER1291server # [ 125.760935] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1292server # [ 125.770417] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: DROP FUNCTION1293server # [ 125.773423] postgres[1213]: ::1 2026-10-31 19:38:37.742 UTC [1213] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1294server # [ 125.782102] postgres[1213]: ::1 2026-10-31 19:38:37.783 UTC [1213] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1295server # [ 125.789577] postgres[1213]: DECLARE1296server # [ 125.795452] postgres[1213]: cmd record;1297server # [ 125.802828] postgres[1213]: BEGIN1298server # [ 125.811130] postgres[1213]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1299server # [ 125.813169] postgres[1213]: LOOP1300server # [ 125.819137] postgres[1213]: IF cmd.command_tag IN (1301server # [ 125.826186] postgres[1213]: 'CREATE SCHEMA', 'ALTER SCHEMA'1302server # [ 125.830356] postgres[1213]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1303server # [ 125.835603] postgres[1213]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1304server # [ 125.843267] postgres[1213]: , 'CREATE VIEW', 'ALTER VIEW'1305server # [ 125.847326] postgres[1213]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1306server # [ 125.861237] postgres[1213]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1307server # [ 125.873953] postgres[1213]: , 'CREATE TRIGGER'1308server # [ 125.882423] postgres[1213]: , 'CREATE TYPE'1309server # [ 125.890616] postgres[1213]: , 'CREATE RULE'1310server # [ 125.902212] postgres[1213]: , 'COMMENT'1311server # [ 125.906549] postgres[1213]: )1312server # [ 125.911668] postgres[1213]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1313server # [ 125.920183] postgres[1213]: AND cmd.schema_name is distinct from 'pg_temp'1314server # [ 125.934991] postgres[1213]: THEN1315server # [ 125.968037] postgres[1213]: NOTIFY pgrst, 'reload schema';1316server # [ 125.978459] postgres[1213]: END IF;1317server # [ 125.985747] postgres[1213]: END LOOP;1318server # [ 125.998378] postgres[1213]: END; $$ LANGUAGE plpgsql;1319server # [ 126.006391] postgres[1213]: ::1 2026-10-31 19:38:37.859 UTC [1213] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1320server # [ 126.015098] postgres[1213]: DECLARE1321server # [ 126.026617] postgres[1213]: obj record;1322server # [ 126.039562] postgres[1213]: BEGIN1323server # [ 126.050448] postgres[1213]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1324server # [ 126.056550] postgres[1213]: LOOP1325server # [ 126.067348] postgres[1213]: IF obj.object_type IN (1326server # [ 126.072699] postgres[1213]: 'schema'1327server # [ 126.077859] postgres[1213]: , 'table'1328server # [ 126.094211] postgres[1213]: , 'foreign table'1329server # [ 126.097936] postgres[1213]: , 'view'1330server # [ 126.101603] postgres[1213]: , 'materialized view'1331server # [ 126.107052] postgres[1213]: , 'function'1332server # [ 126.118184] postgres[1213]: , 'trigger'1333server # [ 126.123833] postgres[1213]: , 'type'1334server # [ 126.139600] postgres[1213]: , 'rule'1335server # [ 126.147185] postgres[1213]: )1336server # [ 126.159927] postgres[1213]: AND obj.is_temporary IS false -- no pg_temp objects1337server # [ 126.171866] postgres[1213]: THEN1338server # [ 126.186370] postgres[1213]: NOTIFY pgrst, 'reload schema';1339server # [ 126.199441] postgres[1213]: END IF;1340server # [ 126.208370] postgres[1213]: END LOOP;1341server # [ 126.222064] postgres[1213]: END; $$ LANGUAGE plpgsql;1342server # [ 126.227521] postgres[1213]: ::1 2026-10-31 19:38:37.890 UTC [1213] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1343server # [ 126.245900] postgres[1213]: ::1 2026-10-31 19:38:37.898 UTC [1213] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1344server # [ 126.254762] postgres[1213]: ON ddl_command_end1345server # [ 126.262028] postgres[1213]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1346server # [ 126.274923] postgres[1213]: ::1 2026-10-31 19:38:37.914 UTC [1213] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1347server # [ 126.282311] postgres[1213]: ::1 2026-10-31 19:38:37.934 UTC [1213] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1348server # [ 126.298169] postgres[1213]: ON sql_drop1349server # [ 126.307907] postgres[1213]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1350server # [ 126.317508] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: CREATE FUNCTION1351server # [ 126.323218] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: CREATE FUNCTION1352server # [ 126.340893] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping1353server # [ 126.345460] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: DROP EVENT TRIGGER1354server # [ 126.347588] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: CREATE EVENT TRIGGER1355server # [ 126.357970] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping1356server # [ 126.361618] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: DROP EVENT TRIGGER1357server # [ 126.363789] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1211]: CREATE EVENT TRIGGER1358server # [ 126.379200] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql1359server # [ 127.337463] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1214]: DO1360server # [ 127.403976] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql1361server # [ 127.968298] postgres[1217]: ::1 2026-10-31 19:38:39.992 UTC [1217] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public;1362server # [ 128.069889] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: CREATE SCHEMA1363server # [ 128.075256] postgres[1217]: ::1 2026-10-31 19:38:40.078 UTC [1217] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb);1364server # [ 128.085702] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping1365server # [ 128.097462] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: DROP FUNCTION1366server # [ 128.102056] postgres[1217]: ::1 2026-10-31 19:38:40.106 UTC [1217] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1367server # [ 128.110931] postgres[1217]: "operationName" text default null,1368server # [ 128.117827] postgres[1217]: query text default null,1369server # [ 128.125352] postgres[1217]: variables jsonb default null,1370server # [ 128.129614] postgres[1217]: extensions jsonb default null1371server # [ 128.138084] postgres[1217]: )1372server # [ 128.146561] postgres[1217]: returns jsonb1373server # [ 128.153600] postgres[1217]: language plpgsql1374server # [ 128.156771] postgres[1217]: as $$1375server # [ 128.162496] postgres[1217]: DECLARE1376server # [ 128.169931] postgres[1217]: server_version float;1377server # [ 128.173479] postgres[1217]: BEGIN1378server # [ 128.178950] postgres[1217]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1379server # [ 128.186485] postgres[1217]:1380server # [ 128.195381] postgres[1217]: IF server_version >= 14 THEN1381server # [ 128.197968] postgres[1217]: RETURN jsonb_build_object(1382server # [ 128.201593] postgres[1217]: 'data', null::jsonb,1383server # [ 128.205623] postgres[1217]: 'errors', array['pg_graphql extension is not enabled.']1384server # [ 128.211324] postgres[1217]: );1385server # [ 128.219955] postgres[1217]: ELSE1386server # [ 128.222978] postgres[1217]: RETURN jsonb_build_object(1387server # [ 128.227474] postgres[1217]: 'data', null::jsonb,1388server # [ 128.237768] postgres[1217]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1389server # [ 128.246532] postgres[1217]: );1390server # [ 128.254147] postgres[1217]: END IF;1391server # [ 128.258348] postgres[1217]: END;1392server # [ 128.275297] postgres[1217]: $$;1393server # [ 128.278467] postgres[1217]: ::1 2026-10-31 19:38:40.149 UTC [1217] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;1394server # [ 128.282125] postgres[1217]: ::1 2026-10-31 19:38:40.177 UTC [1217] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;1395server # [ 128.285613] postgres[1217]: ::1 2026-10-31 19:38:40.218 UTC [1217] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;1396server # [ 128.292244] postgres[1217]: ::1 2026-10-31 19:38:40.241 UTC [1217] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;1397server # [ 128.297881] postgres[1217]: ::1 2026-10-31 19:38:40.260 UTC [1217] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1398server # [ 128.302116] postgres[1217]: on sequences to postgres, anon, authenticated, service_role;1399server # [ 128.302982] postgres[1217]: ::1 2026-10-31 19:38:40.278 UTC [1217] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1400server # [ 128.303838] postgres[1217]: on tables to postgres, anon, authenticated, service_role;1401server # [ 128.307950] postgres[1217]: ::1 2026-10-31 19:38:40.296 UTC [1217] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1402server # [ 128.311713] postgres[1217]: on functions to postgres, anon, authenticated, service_role;1403server # [ 128.317885] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: CREATE FUNCTION1404server # [ 128.324902] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: GRANT1405server # [ 128.334210] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: ALTER DEFAULT PRIVILEGES1406server # [ 128.342607] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: ALTER DEFAULT PRIVILEGES1407server # [ 128.353341] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: ALTER DEFAULT PRIVILEGES1408server # [ 128.358867] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: ALTER DEFAULT PRIVILEGES1409server # [ 128.363166] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: ALTER DEFAULT PRIVILEGES1410server # [ 128.370578] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: ALTER DEFAULT PRIVILEGES1411server # [ 128.382972] postgres[1217]: ::1 2026-10-31 19:38:40.320 UTC [1217] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()1412server # [ 128.395992] postgres[1217]: RETURNS event_trigger1413server # [ 128.401513] postgres[1217]: LANGUAGE plpgsql1414server # [ 128.405610] postgres[1217]: AS $func$1415server # [ 128.414960] postgres[1217]: DECLARE1416server # [ 128.417832] postgres[1217]: func_is_graphql_resolve bool;1417server # [ 128.434211] postgres[1217]: BEGIN1418server # [ 128.446054] postgres[1217]: func_is_graphql_resolve = (1419server # [ 128.459869] postgres[1217]: SELECT n.proname = 'resolve'1420server # [ 128.467792] postgres[1217]: FROM pg_event_trigger_ddl_commands() AS ev1421server # [ 128.472320] postgres[1217]: LEFT JOIN pg_catalog.pg_proc AS n1422server # [ 128.479943] postgres[1217]: ON ev.objid = n.oid1423server # [ 128.486735] postgres[1217]: );1424server # [ 128.493273] postgres[1217]:1425server # [ 128.497976] postgres[1217]: IF func_is_graphql_resolve1426server # [ 128.507283] postgres[1217]: THEN1427server # [ 128.514133] postgres[1217]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1428server # [ 128.523366] postgres[1217]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1429server # [ 128.533205] postgres[1217]:1430server # [ 128.539418] postgres[1217]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1431server # [ 128.550123] postgres[1217]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1432server # [ 128.560675] postgres[1217]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1433server # [ 128.572894] postgres[1217]:1434server # [ 128.585035] postgres[1217]: DROP FUNCTION IF EXISTS graphql_public.graphql;1435server # [ 128.595246] postgres[1217]: create or replace function graphql_public.graphql(1436server # [ 128.610687] postgres[1217]: "operationName" text default null,1437server # [ 128.623549] postgres[1217]: query text default null,1438server # [ 128.637567] postgres[1217]: variables jsonb default null,1439server # [ 128.645408] postgres[1217]: extensions jsonb default null1440server # [ 128.651844] postgres[1217]: )1441server # [ 128.662274] postgres[1217]: returns jsonb1442server # [ 128.681683] postgres[1217]: language sql1443server # [ 128.693430] postgres[1217]: as $$1444server # [ 128.702727] postgres[1217]: SELECT graphql.resolve(query, coalesce(variables, '{}'));1445server # [ 128.710735] postgres[1217]: $$;1446server # [ 128.722000] postgres[1217]:1447server # [ 128.726715] postgres[1217]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1448server # [ 128.739536] postgres[1217]: END IF;1449server # [ 128.754032] postgres[1217]:1450server # [ 128.765377] postgres[1217]: END;1451server # [ 128.775731] postgres[1217]: $func$;1452server # [ 128.786643] postgres[1217]: ::1 2026-10-31 19:38:40.366 UTC [1217] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;1453server # [ 128.804814] postgres[1217]: ::1 2026-10-31 19:38:40.382 UTC [1217] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')1454server # [ 128.825338] postgres[1217]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access();1455server # [ 128.838726] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: CREATE FUNCTION1456server # [ 128.847803] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping1457server # [ 128.853095] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: DROP EVENT TRIGGER1458server # [ 128.855569] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: CREATE EVENT TRIGGER1459server # [ 128.857827] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: COMMENT1460server # [ 128.860261] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: CREATE FUNCTION1461server # [ 128.862074] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping1462server # [ 128.866819] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: DROP EVENT TRIGGER1463server # [ 128.869243] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: CREATE EVENT TRIGGER1464server # [ 128.871734] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1216]: COMMENT1465server # [ 128.875064] postgres[1217]: ::1 2026-10-31 19:38:40.406 UTC [1217] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';1466server # [ 128.879276] postgres[1217]: ::1 2026-10-31 19:38:40.437 UTC [1217] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1467server # [ 128.882235] postgres[1217]: RETURNS event_trigger1468server # [ 128.885404] postgres[1217]: LANGUAGE plpgsql1469server # [ 128.886870] postgres[1217]: AS $func$1470server # [ 128.890167] postgres[1217]: DECLARE1471server # [ 128.894319] postgres[1217]: graphql_is_dropped bool;1472server # [ 128.896116] postgres[1217]: BEGIN1473server # [ 128.898352] postgres[1217]: graphql_is_dropped = (1474server # [ 128.900207] postgres[1217]: SELECT ev.schema_name = 'graphql_public'1475server # [ 128.903952] postgres[1217]: FROM pg_event_trigger_dropped_objects() AS ev1476server # [ 128.907125] postgres[1217]: WHERE ev.schema_name = 'graphql_public'1477server # [ 128.910778] postgres[1217]: );1478server # [ 128.913375] postgres[1217]:1479server # [ 128.916968] postgres[1217]: IF graphql_is_dropped1480server # [ 128.918571] postgres[1217]: THEN1481server # [ 128.919480] postgres[1217]: create or replace function graphql_public.graphql(1482server # [ 128.923098] postgres[1217]: "operationName" text default null,1483server # [ 128.926813] postgres[1217]: query text default null,1484server # [ 128.929994] postgres[1217]: variables jsonb default null,1485server # [ 128.932780] postgres[1217]: extensions jsonb default null1486server # [ 128.935044] postgres[1217]: )1487server # [ 128.938439] postgres[1217]: returns jsonb1488server # [ 128.942979] postgres[1217]: language plpgsql1489server # [ 128.947223] postgres[1217]: as $$1490server # [ 128.950429] postgres[1217]: DECLARE1491server # [ 128.952117] postgres[1217]: server_version float;1492server # [ 128.955178] postgres[1217]: BEGIN1493server # [ 128.957475] postgres[1217]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1494server # [ 128.959656] postgres[1217]:1495server # [ 128.962497] postgres[1217]: IF server_version >= 14 THEN1496server # [ 128.968882] postgres[1217]: RETURN jsonb_build_object(1497server # [ 128.971199] postgres[1217]: 'data', null::jsonb,1498server # [ 128.975073] postgres[1217]: 'errors', array['pg_graphql extension is not enabled.']1499server # [ 128.980575] postgres[1217]: );1500server # [ 128.986890] postgres[1217]: ELSE1501server # [ 128.991097] postgres[1217]: RETURN jsonb_build_object(1502server # [ 128.994797] postgres[1217]: 'data', null::jsonb,1503server # [ 129.006781] postgres[1217]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1504server # [ 129.016241] postgres[1217]: );1505server # [ 129.023082] postgres[1217]: END IF;1506server # [ 129.030739] postgres[1217]: END;1507server # [ 129.038118] postgres[1217]: $$;1508server # [ 129.045828] postgres[1217]: END IF;1509server # [ 129.052239] postgres[1217]:1510server # [ 129.061650] postgres[1217]: END;1511server # [ 129.071402] postgres[1217]: $func$;1512server # [ 129.078887] postgres[1217]: ::1 2026-10-31 19:38:40.571 UTC [1217] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;1513server # [ 129.080197] postgres[1217]: ::1 2026-10-31 19:38:40.581 UTC [1217] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')1514server # [ 129.127378] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql1515server # [ 129.146323] postgres[1217]: EXECUTE PROCEDURE extensions.set_graphql_placeholder();1516server # [ 129.162037] postgres[1217]: ::1 2026-10-31 19:38:40.593 UTC [1217] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';1517server # [ 129.323422] postgres[1219]: ::1 2026-10-31 19:38:41.327 UTC [1219] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1518server # [ 129.334794] postgres[1219]: ::1 2026-10-31 19:38:41.354 UTC [1219] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1519server # [ 129.357270] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1218]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1520server # [ 129.370213] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1218]: DROP EVENT TRIGGER1521server # [ 129.378688] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1218]: 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, skipping1522server # [ 129.386212] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1218]: DROP FUNCTION1523server # [ 129.393699] postgres[1219]: ::1 2026-10-31 19:38:41.394 UTC [1219] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1524server # [ 129.407462] postgres[1219]: DECLARE1525server # [ 129.411213] postgres[1219]: cmd record;1526server # [ 129.413516] postgres[1219]: BEGIN1527server # [ 129.414535] postgres[1219]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1528server # [ 129.417855] postgres[1219]: LOOP1529server # [ 129.419611] postgres[1219]: IF cmd.command_tag IN (1530server # [ 129.422442] postgres[1219]: 'CREATE SCHEMA', 'ALTER SCHEMA'1531server # [ 129.425663] postgres[1219]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1532server # [ 129.427305] postgres[1219]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1533server # [ 129.430287] postgres[1219]: , 'CREATE VIEW', 'ALTER VIEW'1534server # [ 129.432354] postgres[1219]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1535server # [ 129.433978] postgres[1219]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1536server # [ 129.435244] postgres[1219]: , 'CREATE TRIGGER'1537server # [ 129.437549] postgres[1219]: , 'CREATE TYPE', 'ALTER TYPE'1538server # [ 129.438479] postgres[1219]: , 'CREATE RULE'1539server # [ 129.439396] postgres[1219]: , 'COMMENT'1540server # [ 129.442442] postgres[1219]: )1541server # [ 129.451525] postgres[1219]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1542server # [ 129.460952] postgres[1219]: AND cmd.schema_name is distinct from 'pg_temp'1543server # [ 129.470260] postgres[1219]: THEN1544server # [ 129.477065] postgres[1219]: NOTIFY pgrst, 'reload schema';1545server # [ 129.485768] postgres[1219]: END IF;1546server # [ 129.490551] postgres[1219]: END LOOP;1547server # [ 129.499952] postgres[1219]: END; $$ LANGUAGE plpgsql;1548server # [ 129.511764] postgres[1219]: ::1 2026-10-31 19:38:41.522 UTC [1219] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1549server # [ 129.521528] postgres[1219]: DECLARE1550server # [ 129.524738] postgres[1219]: obj record;1551server # [ 129.529398] postgres[1219]: BEGIN1552server # [ 129.535028] postgres[1219]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1553server # [ 129.545761] postgres[1219]: LOOP1554server # [ 129.547269] postgres[1219]: IF obj.object_type IN (1555server # [ 129.555202] postgres[1219]: 'schema'1556server # [ 129.560025] postgres[1219]: , 'table'1557server # [ 129.565204] postgres[1219]: , 'foreign table'1558server # [ 129.573705] postgres[1219]: , 'view'1559server # [ 129.579230] postgres[1219]: , 'materialized view'1560server # [ 129.583651] postgres[1219]: , 'function'1561server # [ 129.591113] postgres[1219]: , 'trigger'1562server # [ 129.593301] postgres[1219]: , 'type'1563server # [ 129.596054] postgres[1219]: , 'rule'1564server # [ 129.597712] postgres[1219]: )1565server # [ 129.606467] postgres[1219]: AND obj.is_temporary IS false -- no pg_temp objects1566server # [ 129.610716] postgres[1219]: THEN1567server # [ 129.613980] postgres[1219]: NOTIFY pgrst, 'reload schema';1568server # [ 129.617890] postgres[1219]: END IF;1569server # [ 129.623971] postgres[1219]: END LOOP;1570server # [ 129.629723] postgres[1219]: END; $$ LANGUAGE plpgsql;1571server # [ 129.634025] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1218]: CREATE FUNCTION1572server # [ 129.639484] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1218]: CREATE FUNCTION1573server # [ 129.651266] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1218]: DROP EVENT TRIGGER1574server # [ 129.662603] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1218]: CREATE EVENT TRIGGER1575server # [ 129.667846] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1218]: DROP EVENT TRIGGER1576server # [ 129.671664] postgres[1219]: ::1 2026-10-31 19:38:41.606 UTC [1219] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1577server # [ 129.675075] postgres[1219]: ::1 2026-10-31 19:38:41.619 UTC [1219] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1578server # [ 129.678464] postgres[1219]: ON ddl_command_end1579server # [ 129.681041] postgres[1219]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1580server # [ 129.683059] postgres[1219]: ::1 2026-10-31 19:38:41.638 UTC [1219] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1581server # [ 129.685717] postgres[1219]: ::1 2026-10-31 19:38:41.659 UTC [1219] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1582server # [ 129.690273] postgres[1219]: ON sql_drop1583server # [ 129.694684] postgres[1219]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1584server # [ 129.708842] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1218]: CREATE EVENT TRIGGER1585server # [ 129.724210] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql1586server # [ 130.149167] postgres[1221]: ::1 2026-10-31 19:38:42.167 UTC [1221] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;1587server # [ 130.183286] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1220]: ALTER ROLE1588server # [ 130.243100] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql1589server # [ 130.805093] postgres[1223]: ::1 2026-10-31 19:38:42.813 UTC [1223] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1590server # [ 130.807457] postgres[1223]: returns event_trigger1591server # [ 130.811357] postgres[1223]: language plpgsql1592server # [ 130.814796] postgres[1223]: AS $func$1593server # [ 130.818353] postgres[1223]: DECLARE1594server # [ 130.822769] postgres[1223]: func_is_graphql_resolve bool;1595server # [ 130.825314] postgres[1223]: BEGIN1596server # [ 130.827852] postgres[1223]: func_is_graphql_resolve = (1597server # [ 130.829468] postgres[1223]: SELECT n.proname = 'resolve'1598server # [ 130.830299] postgres[1223]: FROM pg_event_trigger_ddl_commands() AS ev1599server # [ 130.831094] postgres[1223]: LEFT JOIN pg_catalog.pg_proc AS n1600server # [ 130.831971] postgres[1223]: ON ev.objid = n.oid1601server # [ 130.835012] postgres[1223]: );1602server # [ 130.837183] postgres[1223]:1603server # [ 130.839860] postgres[1223]: IF func_is_graphql_resolve1604server # [ 130.843268] postgres[1223]: THEN1605server # [ 130.845614] postgres[1223]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1606server # [ 130.848922] postgres[1223]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1607server # [ 130.851115] postgres[1223]:1608server # [ 130.852364] postgres[1223]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1609server # [ 130.855237] postgres[1223]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1610server # [ 130.860061] postgres[1223]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1611server # [ 130.863016] postgres[1223]:1612server # [ 130.865141] postgres[1223]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1613server # [ 130.869557] postgres[1223]: DROP FUNCTION IF EXISTS graphql_public.graphql;1614server # [ 130.873304] postgres[1223]: create or replace function graphql_public.graphql(1615server # [ 130.875323] postgres[1223]: "operationName" text default null,1616server # [ 130.882188] postgres[1223]: query text default null,1617server # [ 130.888940] postgres[1223]: variables jsonb default null,1618server # [ 130.898753] postgres[1223]: extensions jsonb default null1619server # [ 130.910627] postgres[1223]: )1620server # [ 130.918627] postgres[1223]: returns jsonb1621server # [ 130.925378] postgres[1223]: language sql1622server # [ 130.927589] postgres[1223]: as $$1623server # [ 130.931541] postgres[1223]: -- This changed1624server # [ 130.949987] postgres[1223]: select graphql.resolve(1625server # [ 130.952504] postgres[1223]: query := query,1626server # [ 130.958019] postgres[1223]: variables := coalesce(variables, '{}'),1627server # [ 130.961528] postgres[1223]: "operationName" := "operationName",1628server # [ 130.969743] postgres[1223]: extensions := extensions1629server # [ 130.976017] postgres[1223]: );1630server # [ 130.985081] postgres[1223]: $$;1631server # [ 130.990652] postgres[1223]:1632server # [ 130.997699] postgres[1223]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1633server # [ 131.005021] postgres[1223]: END IF;1634server # [ 131.017348] postgres[1223]:1635server # [ 131.026679] postgres[1223]: END;1636server # [ 131.030204] postgres[1223]: $func$;1637server # [ 131.045455] systemd-vconsole-setup[1207]: Configuration of first virtual console was skipped, ignoring remaining ones.1638server # [ 131.062877] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1222]: CREATE FUNCTION1639server # [ 131.073504] postgres[1223]: ::1 2026-10-31 19:38:43.044 UTC [1223] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1640server # [ 131.081477] postgres[1223]: RETURNS event_trigger1641server # [ 131.083827] postgres[1223]: LANGUAGE plpgsql1642server # [ 131.089068] postgres[1223]: AS $func$1643server # [ 131.093756] postgres[1223]: DECLARE1644server # [ 131.098925] postgres[1223]: graphql_is_dropped bool;1645server # [ 131.109031] postgres[1223]: BEGIN1646server # [ 131.112134] postgres[1223]: graphql_is_dropped = (1647server # [ 131.120261] postgres[1223]: SELECT ev.schema_name = 'graphql_public'1648server # [ 131.123533] postgres[1223]: FROM pg_event_trigger_dropped_objects() AS ev1649server # [ 131.133233] postgres[1223]: WHERE ev.schema_name = 'graphql_public'1650server # [ 131.140097] postgres[1223]: );1651server # [ 131.142073] postgres[1223]:1652server # [ 131.147848] postgres[1223]: IF graphql_is_dropped1653server # [ 131.162389] postgres[1223]: THEN1654server # [ 131.170202] postgres[1223]: create or replace function graphql_public.graphql(1655server # [ 131.174573] postgres[1223]: "operationName" text default null,1656server # [ 131.179347] postgres[1223]: query text default null,1657server # [ 131.181648] postgres[1223]: variables jsonb default null,1658server # [ 131.183453] postgres[1223]: extensions jsonb default null1659server # [ 131.185403] postgres[1223]: )1660server # [ 131.190581] postgres[1223]: returns jsonb1661server # [ 131.194700] postgres[1223]: language plpgsql1662server # [ 131.199329] postgres[1223]: as $$1663server # [ 131.204007] postgres[1223]: DECLARE1664server # [ 131.206933] postgres[1223]: server_version float;1665server # [ 131.209639] postgres[1223]: BEGIN1666server # [ 131.212647] postgres[1223]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1667server # [ 131.213601] postgres[1223]:1668server # [ 131.215548] postgres[1223]: IF server_version >= 14 THEN1669server # [ 131.217624] postgres[1223]: RETURN jsonb_build_object(1670server # [ 131.222959] postgres[1223]: 'errors', jsonb_build_array(1671server # [ 131.234805] postgres[1223]: jsonb_build_object(1672server # [ 131.236130] postgres[1223]: 'message', 'pg_graphql extension is not enabled.'1673server # [ 131.241934] postgres[1223]: )1674server # [ 131.253805] postgres[1223]: )1675server # [ 131.256090] postgres[1223]: );1676server # [ 131.258140] postgres[1223]: ELSE1677server # [ 131.259659] postgres[1223]: RETURN jsonb_build_object(1678server # [ 131.262370] postgres[1223]: 'errors', jsonb_build_array(1679server # [ 131.269272] postgres[1223]: jsonb_build_object(1680server # [ 131.271458] postgres[1223]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1681server # [ 131.279832] postgres[1223]: )1682server # [ 131.286652] postgres[1223]: )1683server # [ 131.289570] postgres[1223]: );1684server # [ 131.290954] postgres[1223]: END IF;1685server # [ 131.295130] postgres[1223]: END;1686server # [ 131.299041] postgres[1223]: $$;1687server # [ 131.301911] postgres[1223]: END IF;1688server # [ 131.309997] postgres[1223]:1689server # [ 131.314710] postgres[1223]: END;1690server # [ 131.318475] postgres[1223]: $func$;1691server # [ 131.322776] postgres[1223]: ::1 2026-10-31 19:38:43.099 UTC [1223] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1692server # [ 131.330950] postgres[1223]: "operationName" text default null,1693server # [ 131.337474] postgres[1223]: query text default null,1694server # [ 131.339282] postgres[1223]: variables jsonb default null,1695server # [ 131.357697] systemd[1]: Finished Virtual Console Setup.1696server # [ 131.369133] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1222]: CREATE FUNCTION1697server # [ 131.371989] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1222]: CREATE FUNCTION1698server # [ 131.378497] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1222]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping1699server # [ 131.382634] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1222]: DROP EXTENSION1700server # [ 131.390380] postgres[1223]: extensions jsonb default null1701server # [ 131.392053] postgres[1223]: )1702server # [ 131.395990] postgres[1223]: returns jsonb1703server # [ 131.400292] postgres[1223]: language plpgsql1704server # [ 131.405933] postgres[1223]: as $$1705server # [ 131.417764] postgres[1223]: DECLARE1706server # [ 131.419812] postgres[1223]: server_version float;1707server # [ 131.421692] postgres[1223]: BEGIN1708server # [ 131.422534] postgres[1223]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1709server # [ 131.428042] postgres[1223]:1710server # [ 131.430475] postgres[1223]: IF server_version >= 14 THEN1711server # [ 131.433672] postgres[1223]: RETURN jsonb_build_object(1712server # [ 131.438362] postgres[1223]: 'errors', jsonb_build_array(1713server # [ 131.441347] postgres[1223]: jsonb_build_object(1714server # [ 131.446099] postgres[1223]: 'message', 'pg_graphql extension is not enabled.'1715server # [ 131.450684] postgres[1223]: )1716server # [ 131.461598] postgres[1223]: )1717server # [ 131.465652] postgres[1223]: );1718server # [ 131.470231] postgres[1223]: ELSE1719server # [ 131.473259] postgres[1223]: RETURN jsonb_build_object(1720server # [ 131.475370] postgres[1223]: 'errors', jsonb_build_array(1721server # [ 131.481280] postgres[1223]: jsonb_build_object(1722server # [ 131.483326] postgres[1223]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1723server # [ 131.486750] postgres[1223]: )1724server # [ 131.489818] postgres[1223]: )1725server # [ 131.492526] postgres[1223]: );1726server # [ 131.495296] postgres[1223]: END IF;1727server # [ 131.504149] postgres[1223]: END;1728server # [ 131.510878] postgres[1223]: $$;1729server # [ 131.514837] postgres[1223]: ::1 2026-10-31 19:38:43.158 UTC [1223] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1730server # [ 133.221166] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1222]: DO1731server # [ 133.270822] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql1732server # [ 133.508158] postgres[1246]: ::1 2026-10-31 19:38:45.532 UTC [1246] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres;1733server # [ 133.529525] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1245]: GRANT ROLE1734server # [ 133.563374] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql1735server # [ 133.881771] postgres[1248]: ::1 2026-10-31 19:38:45.896 UTC [1248] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1736server # [ 133.889430] postgres[1248]: returns event_trigger1737server # [ 133.891112] postgres[1248]: language plpgsql1738server # [ 133.897939] postgres[1248]: AS $func$1739server # [ 133.906162] postgres[1248]: DECLARE1740server # [ 133.911638] postgres[1248]: func_is_graphql_resolve bool;1741server # [ 133.921611] postgres[1248]: BEGIN1742server # [ 133.926481] postgres[1248]: func_is_graphql_resolve = (1743server # [ 133.930202] postgres[1248]: SELECT n.proname = 'resolve'1744server # [ 133.932172] postgres[1248]: FROM pg_event_trigger_ddl_commands() AS ev1745server # [ 133.934387] postgres[1248]: LEFT JOIN pg_catalog.pg_proc AS n1746server # [ 133.936494] postgres[1248]: ON ev.objid = n.oid1747server # [ 133.938418] postgres[1248]: );1748server # [ 133.940956] postgres[1248]:1749server # [ 133.942131] postgres[1248]: IF func_is_graphql_resolve1750server # [ 133.942962] postgres[1248]: THEN1751server # [ 133.943992] postgres[1248]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1752server # [ 133.945463] postgres[1248]: DROP FUNCTION IF EXISTS graphql_public.graphql;1753server # [ 133.948106] postgres[1248]: create or replace function graphql_public.graphql(1754server # [ 133.949876] postgres[1248]: "operationName" text default null,1755server # [ 133.950584] postgres[1248]: query text default null,1756server # [ 133.951209] postgres[1248]: variables jsonb default null,1757server # [ 133.951973] postgres[1248]: extensions jsonb default null1758server # [ 133.956385] postgres[1248]: )1759server # [ 133.958489] postgres[1248]: returns jsonb1760server # [ 133.960174] postgres[1248]: language sql1761server # [ 133.961891] postgres[1248]: as $$1762server # [ 133.962561] postgres[1248]: select graphql.resolve(1763server # [ 133.964268] postgres[1248]: query := query,1764server # [ 133.966205] postgres[1248]: variables := coalesce(variables, '{}'),1765server # [ 133.967035] postgres[1248]: "operationName" := "operationName",1766server # [ 133.967807] postgres[1248]: extensions := extensions1767server # [ 133.969448] postgres[1248]: );1768server # [ 133.970455] postgres[1248]: $$;1769server # [ 133.971801] postgres[1248]:1770server # [ 133.974140] postgres[1248]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1771server # [ 133.978030] postgres[1248]: -- function in the extension so we need to grant permissions on existing entities AND1772server # [ 133.981968] postgres[1248]: -- update default permissions to any others that are created after `graphql.resolve`1773server # [ 133.986491] postgres[1248]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1774server # [ 133.989487] postgres[1248]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1775server # [ 133.991561] postgres[1248]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1776server # [ 133.994063] postgres[1248]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1777server # [ 133.997517] postgres[1248]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1778server # [ 134.001359] postgres[1248]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1779server # [ 134.003403] postgres[1248]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1780server # [ 134.006043] postgres[1248]: END IF;1781server # [ 134.007451] postgres[1248]:1782server # [ 134.014317] postgres[1248]: END;1783server # [ 134.016031] postgres[1248]: $func$;1784server # [ 134.022487] postgres[1248]: ::1 2026-10-31 19:38:45.969 UTC [1248] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1785server # [ 134.031417] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1247]: CREATE FUNCTION1786server # [ 134.073736] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1247]: DROP EXTENSION1787server # [ 135.847844] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1788server # [ 135.943474] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1247]: DO1789server # [ 136.008595] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql1790server # [ 136.828051] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1269]: DO1791server # [ 137.545400] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1269]: DO1792server # [ 137.631800] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql1793server # [ 138.065209] postgres[1286]: ::1 2026-10-31 19:38:50.088 UTC [1286] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s';1794server # [ 138.086097] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1280]: ALTER ROLE1795server # [ 138.141418] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql1796server # [ 138.599586] postgres[1294]: ::1 2026-10-31 19:38:50.614 UTC [1294] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator;1797server # [ 138.622665] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1290]: REVOKE ROLE1798server # [ 138.678607] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql1799server # [ 141.057031] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1295]: DO1800server # [ 141.115611] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql1801server # [ 141.466204] postgres[1318]: ::1 2026-10-31 19:38:53.481 UTC [1318] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres;1802server # [ 141.492128] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1316]: GRANT ROLE1803server # [ 141.531830] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql1804server # [ 141.860197] postgres[1320]: ::1 2026-10-31 19:38:53.882 UTC [1320] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option;1805server # [ 141.895083] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1319]: GRANT1806server # [ 141.902885] postgres[1320]: ::1 2026-10-31 19:38:53.918 UTC [1320] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option;1807server # [ 141.918151] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1319]: GRANT1808server # [ 141.921482] postgres[1320]: ::1 2026-10-31 19:38:53.947 UTC [1320] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option;1809server # [ 141.926556] postgres[1320]: ::1 2026-10-31 19:38:53.951 UTC [1320] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;1810server # [ 141.930188] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1319]: GRANT1811server # [ 141.938429] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1319]: ALTER DEFAULT PRIVILEGES1812server # [ 141.941067] postgres[1320]: ::1 2026-10-31 19:38:53.967 UTC [1320] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;1813server # [ 141.951343] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1319]: ALTER DEFAULT PRIVILEGES1814server # [ 141.958446] postgres[1320]: ::1 2026-10-31 19:38:53.982 UTC [1320] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;1815server # [ 141.965661] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1319]: ALTER DEFAULT PRIVILEGES1816server # [ 142.000512] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql1817server # [ 142.289505] postgres[1322]: ::1 2026-10-31 19:38:54.307 UTC [1322] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres;1818server # [ 142.300909] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1321]: GRANT ROLE1819server # [ 142.364044] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql1820server # [ 142.604033] postgres[1324]: ::1 2026-10-31 19:38:54.626 UTC [1324] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin;1821server # [ 142.627368] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1323]: GRANT ROLE1822server # [ 142.660912] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql1823server # [ 142.969959] postgres[1326]: ::1 2026-10-31 19:38:54.982 UTC [1326] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit;1824server # [ 142.975303] postgres[1326]: ::1 2026-10-31 19:38:54.998 UTC [1326] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit;1825server # [ 142.997584] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1325]: ALTER ROLE1826server # [ 143.005706] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1325]: ALTER ROLE1827server # [ 143.013250] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1325]: ALTER ROLE1828server # [ 143.021164] postgres[1326]: ::1 2026-10-31 19:38:55.006 UTC [1326] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit;1829server # [ 143.033119] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1325]: DO1830server # [ 143.058243] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql1831server # [ 143.466095] postgres[1332]: ::1 2026-10-31 19:38:55.474 UTC [1332] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin;1832server # [ 143.517109] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1327]: GRANT ROLE1833server # [ 143.528892] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1327]: REVOKE ROLE1834server # [ 143.537217] postgres[1332]: ::1 2026-10-31 19:38:55.534 UTC [1332] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin;1835server # [ 143.597603] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql1836server # [ 144.030488] postgres[1343]: ::1 2026-10-31 19:38:56.030 UTC [1343] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1837server # [ 144.048855] postgres[1343]: returns event_trigger1838server # [ 144.059407] postgres[1343]: language plpgsql1839server # [ 144.061813] postgres[1343]: AS $func$1840server # [ 144.069714] postgres[1343]: DECLARE1841server # [ 144.076911] postgres[1343]: func_is_graphql_resolve bool;1842server # [ 144.089561] postgres[1343]: BEGIN1843server # [ 144.096353] postgres[1343]: func_is_graphql_resolve = (1844server # [ 144.103374] postgres[1343]: SELECT n.proname = 'resolve'1845server # [ 144.109551] postgres[1343]: FROM pg_event_trigger_ddl_commands() AS ev1846server # [ 144.118239] postgres[1343]: LEFT JOIN pg_catalog.pg_proc AS n1847server # [ 144.137340] postgres[1343]: ON ev.objid = n.oid1848server # [ 144.150181] postgres[1343]: );1849server # [ 144.159619] postgres[1343]:1850server # [ 144.166050] postgres[1343]: IF func_is_graphql_resolve1851server # [ 144.173921] postgres[1343]: THEN1852server # [ 144.176215] postgres[1343]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1853server # [ 144.181714] postgres[1343]: DROP FUNCTION IF EXISTS graphql_public.graphql;1854server # [ 144.183118] postgres[1343]: create or replace function graphql_public.graphql(1855server # [ 144.187390] postgres[1343]: "operationName" text default null,1856server # [ 144.189639] postgres[1343]: query text default null,1857server # [ 144.193277] postgres[1343]: variables jsonb default null,1858server # [ 144.197867] postgres[1343]: extensions jsonb default null1859server # [ 144.201594] postgres[1343]: )1860server # [ 144.203115] postgres[1343]: returns jsonb1861server # [ 144.209370] postgres[1343]: language sql1862server # [ 144.210544] postgres[1343]: as $$1863server # [ 144.211273] postgres[1343]: select graphql.resolve(1864server # [ 144.213001] postgres[1343]: query := query,1865server # [ 144.217485] postgres[1343]: variables := coalesce(variables, '{}'),1866server # [ 144.221136] postgres[1343]: "operationName" := "operationName",1867server # [ 144.226878] postgres[1343]: extensions := extensions1868server # [ 144.235208] postgres[1343]: );1869server # [ 144.242702] postgres[1343]: $$;1870server # [ 144.245310] postgres[1343]:1871server # [ 144.251083] postgres[1343]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1872server # [ 144.253459] postgres[1343]: -- function in the extension so we need to grant permissions on existing entities AND1873server # [ 144.258499] postgres[1343]: -- update default permissions to any others that are created after `graphql.resolve`1874server # [ 144.260733] postgres[1343]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1875server # [ 144.265227] postgres[1343]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1876server # [ 144.267402] postgres[1343]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1877server # [ 144.273310] postgres[1343]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1878server # [ 144.274097] postgres[1343]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1879server # [ 144.275078] postgres[1343]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1880server # [ 144.278018] postgres[1343]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1881server # [ 144.285937] postgres[1343]:1882server # [ 144.287156] postgres[1343]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles1883server # [ 144.288155] postgres[1343]: grant usage on schema graphql_public to postgres with grant option;1884server # [ 144.295092] postgres[1343]: grant usage on schema graphql to postgres with grant option;1885server # [ 144.301567] postgres[1343]: END IF;1886server # [ 144.305233] postgres[1343]:1887server # [ 144.310482] postgres[1343]: END;1888server # [ 144.315448] postgres[1343]: $func$;1889server # [ 144.317385] postgres[1343]: ::1 2026-10-31 19:38:56.231 UTC [1343] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1890server # [ 144.332301] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1339]: CREATE FUNCTION1891server # [ 144.341757] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1339]: DROP EXTENSION1892server # [ 145.826958] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1339]: DO1893server # [ 145.859275] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql1894server # [ 146.132125] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1351]: DO1895server # [ 146.150879] postgres[1352]: ::1 2026-10-31 19:38:58.163 UTC [1352] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger1896server # [ 146.158883] postgres[1352]: LANGUAGE plpgsql1897server # [ 146.165793] postgres[1352]: AS $$1898server # [ 146.174112] postgres[1352]: BEGIN1899server # [ 146.181968] postgres[1352]: IF EXISTS (1900server # [ 146.189351] postgres[1352]: SELECT1901server # [ 146.193420] postgres[1352]: FROM pg_event_trigger_ddl_commands() AS ev1902server # [ 146.197370] postgres[1352]: JOIN pg_extension AS ext1903server # [ 146.198357] postgres[1352]: ON ev.objid = ext.oid1904server # [ 146.201825] postgres[1352]: WHERE ext.extname = 'pg_cron'1905server # [ 146.204473] postgres[1352]: )1906server # [ 146.209200] postgres[1352]: THEN1907server # [ 146.210235] postgres[1352]: grant usage on schema cron to postgres with grant option;1908server # [ 146.211975] postgres[1352]:1909server # [ 146.218261] postgres[1352]: alter default privileges in schema cron grant all on tables to postgres with grant option;1910server # [ 146.221561] postgres[1352]: alter default privileges in schema cron grant all on functions to postgres with grant option;1911server # [ 146.222735] postgres[1352]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1912server # [ 146.225262] postgres[1352]:1913server # [ 146.230294] postgres[1352]: alter default privileges for user supabase_admin in schema cron grant all1914server # [ 146.238385] postgres[1352]: on sequences to postgres with grant option;1915server # [ 146.239459] postgres[1352]: alter default privileges for user supabase_admin in schema cron grant all1916server # [ 146.246199] postgres[1352]: on tables to postgres with grant option;1917server # [ 146.250557] postgres[1352]: alter default privileges for user supabase_admin in schema cron grant all1918server # [ 146.257225] postgres[1352]: on functions to postgres with grant option;1919server # [ 146.258805] postgres[1352]:1920server # [ 146.259906] postgres[1352]: grant all privileges on all tables in schema cron to postgres with grant option;1921server # [ 146.261351] postgres[1352]: revoke all on table cron.job from postgres;1922server # [ 146.265484] postgres[1352]: grant select on table cron.job to postgres with grant option;1923server # [ 146.268954] postgres[1352]: END IF;1924server # [ 146.273353] postgres[1352]: END;1925server # [ 146.281124] postgres[1352]: $$;1926server # [ 146.282726] postgres[1352]: ::1 2026-10-31 19:38:58.286 UTC [1352] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access;1927server # [ 146.284064] postgres[1352]: ::1 2026-10-31 19:38:58.309 UTC [1352] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;1928server # [ 146.289572] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1351]: CREATE FUNCTION1929server # [ 146.293291] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1351]: DROP EVENT TRIGGER1930server # [ 146.299164] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1351]: ALTER FUNCTION1931server # [ 146.301616] postgres[1352]: ::1 2026-10-31 19:38:58.323 UTC [1352] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end1932server # [ 146.306469] postgres[1352]: WHEN TAG IN ('CREATE EXTENSION')1933server # [ 146.313429] postgres[1352]: EXECUTE FUNCTION extensions.grant_pg_cron_access();1934server # [ 146.319126] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1351]: CREATE EVENT TRIGGER1935server # [ 146.369483] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql1936server # [ 146.816202] postgres[1364]: ::1 2026-10-31 19:38:58.831 UTC [1364] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s';1937server # [ 146.829408] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1359]: ALTER ROLE1938server # [ 146.897804] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql1939server # [ 147.462045] postgres[1373]: ::1 2026-10-31 19:38:59.413 UTC [1373] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin;1940server # [ 147.507418] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1368]: ALTER FUNCTION1941server # [ 147.516841] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1368]: ALTER FUNCTION1942server # [ 147.518164] postgres[1373]: ::1 2026-10-31 19:38:59.537 UTC [1373] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;1943server # [ 147.524056] postgres[1373]: ::1 2026-10-31 19:38:59.543 UTC [1373] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;1944server # [ 147.527791] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1368]: ALTER FUNCTION1945server # [ 147.582883] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql1946server # [ 147.905960] postgres[1378]: ::1 2026-10-31 19:38:59.919 UTC [1378] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres;1947server # [ 147.938437] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1377]: GRANT ROLE1948server # [ 147.978983] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql1949server # [ 148.910628] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1379]: DO1950server # [ 148.941574] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql1951server: Guest root shell did not produce any data yet...1952server: To debug, enter the VM and run 'systemctl status backdoor.service'.1953server # [ 149.297837] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1381]: DO1954server # [ 149.306354] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1381]: DO1955server # [ 149.355532] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql1956server # [ 149.790025] postgres[1389]: ::1 2026-10-31 19:39:01.797 UTC [1389] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none;1957server # [ 149.832192] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1383]: ALTER ROLE1958server # [ 149.836480] postgres[1389]: ::1 2026-10-31 19:39:01.840 UTC [1389] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none;1959server # [ 149.841604] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1383]: ALTER ROLE1960server # [ 149.846070] postgres[1389]: ::1 2026-10-31 19:39:01.871 UTC [1389] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none;1961server # [ 149.872872] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1383]: ALTER ROLE1962server # [ 149.936707] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql1963server # [ 150.445067] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1395]: DO1964server # [ 150.470316] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql1965server # [ 150.973229] 8021q: 802.1Q VLAN Support v1.81966server # [ 151.050989] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1407]: DO1967server # [ 151.093457] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql1968server # [ 151.233465] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1969server # [ 151.760482] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1411]: CREATE FUNCTION1970server # [ 151.781671] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1411]: DO1971server # [ 151.921048] cfg80211: Loading compiled-in X.509 certificates for regulatory database1972server # [ 151.863925] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql1973server # [ 152.332990] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1974server # [ 152.341926] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1975server # [ 152.374995] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21976server # [ 152.375804] cfg80211: failed to load regulatory.db1977server # [ 152.331650] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1414]: ALTER FUNCTION1978server # [ 152.340029] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1414]: GRANT1979server # [ 152.399028] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql1980server # [ 152.682411] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1419]: DROP EVENT TRIGGER1981server # [ 152.709710] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1419]: ALTER FUNCTION1982server # [ 152.726367] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1419]: CREATE EVENT TRIGGER1983server # [ 152.775374] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql1984server # [ 153.111063] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1421]: DO1985server # [ 153.206358] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql1986server # [ 153.688319] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1424]: CREATE FUNCTION1987server # [ 153.701779] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1424]: GRANT1988server # [ 153.746679] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql1989server # [ 154.152857] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1441]: REVOKE ROLE1990server # [ 154.240920] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1441]: DO1991server # [ 154.273638] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1441]: DO1992server # [ 154.289715] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1441]: REVOKE ROLE1993server # [ 154.314659] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1441]: REVOKE1994server # [ 154.355472] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1441]: DO1995server # [ 154.425670] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql1996server # [ 154.655593] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1997server # [ 154.749175] systemd[1]: Started backdoor.service.1998server # [ 154.798243] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1447]: DO1999server # [ 154.836972] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql2000server # [ 155.244259] (udev-worker)[1429]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.2001server # [ 155.262550] (udev-worker)[1429]: Network interface NamePolicy= disabled on kernel command line.2002server # [ 155.300017] (udev-worker)[1426]: Network interface NamePolicy= disabled on kernel command line.2003server # [ 155.469628] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1450]: DO2004server # [ 155.524780] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql2005server # connecting to host...2006server # [ 156.079855] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1456]: DO2007server # [ 156.135312] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql2008server: Guest shell says: b'Spawning backdoor root shell...\n'2009server: connected to guest root shell2010server: (connecting took 157.15 seconds)2011server: (finished: waiting for the VM to finish booting, in 157.15 seconds)2012server # [ 156.612441] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1462]: ALTER ROLE2013server # [ 156.643054] systemd[1]: Condition check resulted in Virtio network device being skipped.2014server # [ 156.723637] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql2015server # [ 156.770665] systemd[1]: Starting Address configuration of eth1...2016server # [ 157.267231] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1468]: GRANT ROLE2017server # [ 157.302833] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1468]: DO2018server # [ 157.364970] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql2019server # [ 158.131501] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1474]: GRANT2020server # [ 158.210389] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql2021server # [ 158.399597] 8021q: adding VLAN 0 to HW filter on device eth02022server # [ 158.341413] dhcpcd[773]: eth0: waiting for carrier2023server # [ 158.343598] dhcpcd[773]: eth0: carrier acquired2024server # [ 158.462057] 8021q: adding VLAN 0 to HW filter on device eth12025server # [ 158.588036] dhcpcd[773]: DUID 00:01:00:01:32:79:00:5e:52:54:00:12:34:562026server # [ 158.590884] dhcpcd[773]: eth0: IAID 00:12:34:562027server # [ 158.601852] dhcpcd[773]: eth0: adding address fe80::5054:ff:fe12:34562028server # [ 158.767579] network-addresses-eth1-start[1469]: adding address 192.168.1.1/24... done2029server # [ 158.872211] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1482]: CREATE FUNCTION2030server # [ 158.885935] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1482]: REVOKE2031server # [ 158.899925] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1482]: REVOKE2032server # [ 158.919100] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1482]: GRANT2033server # [ 158.990033] network-addresses-eth1-start[1469]: adding address 2001:db8:1::1/64... done2034server # [ 158.996929] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql2035server # [ 159.202876] dhcpcd[773]: eth0: soliciting a DHCP lease2036server # [ 159.246145] dhcpcd[773]: eth0: offered 10.0.2.15 from 10.0.2.22037server # [ 159.290260] dhcpcd[773]: eth0: probing address 10.0.2.15/242038server # [ 159.485202] systemd[1]: Finished Address configuration of eth1.2039server # [ 159.685161] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1490]: DO2040server # [ 159.746235] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql2041server # [ 160.175094] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1498]: ALTER ROLE2042server # [ 160.216711] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql2043server # [ 160.558879] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1500]: DROP EXTENSION2044server # [ 160.599080] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql2045server # [ 160.834584] dhcpcd[773]: eth0: soliciting an IPv6 router2046server # [ 160.845182] dhcpcd[773]: eth0: Router Advertisement from fe80::22047server # [ 160.846121] dhcpcd[773]: eth0: adding address fec0::5054:ff:fe12:3456/642048server # [ 160.865703] dhcpcd[773]: eth0: adding route to fec0::/642049server # [ 160.874945] dhcpcd[773]: eth0: adding default route via fe80::22050server # [ 161.007795] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1502]: CREATE FUNCTION2051server # [ 161.023015] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1502]: DROP EVENT TRIGGER2052server # [ 161.023971] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1502]: CREATE EVENT TRIGGER2053server # [ 161.086813] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql2054server # [ 161.607016] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1505]: DO2055server # [ 161.645811] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1505]: CREATE FUNCTION2056server # [ 161.714500] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql2057server # [ 162.325996] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1526]: CREATE FUNCTION2058server # [ 162.338338] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1526]: CREATE FUNCTION2059server # [ 162.410003] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql2060server # [ 163.191067] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1532]: CREATE FUNCTION2061server # [ 163.201171] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1532]: CREATE FUNCTION2062server # [ 163.227184] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1532]: CREATE FUNCTION2063server # [ 163.256905] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1532]: CREATE FUNCTION2064server # [ 163.277939] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1532]: CREATE FUNCTION2065server # [ 163.303208] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1532]: CREATE FUNCTION2066server # [ 163.351368] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Running postgresql schema...2067server # [ 163.776647] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER DATABASE2068server # [ 163.785598] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER DATABASE2069server # [ 163.885716] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER ROLE2070server # [ 163.994271] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER ROLE2071server # [ 164.077814] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER ROLE2072server # [ 164.126307] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER ROLE2073server # [ 164.177234] dhcpcd[773]: eth0: leased 10.0.2.15 for 86400 seconds2074server # [ 164.183887] dhcpcd[773]: eth0: adding route to 10.0.2.0/242075server # [ 164.198254] dhcpcd[773]: eth0: adding default route via 10.0.2.22076server # [ 164.224520] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER ROLE2077server # [ 164.318692] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER ROLE2078server # [ 164.394166] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER ROLE2079server # [ 164.467194] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER ROLE2080server # [ 164.554408] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER ROLE2081server # [ 164.573565] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1541]: ALTER ROLE2082server # [ 164.657882] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: Database initialization complete2083server # [ 164.702719] systemd[1]: Finished Supabase Database Initialization.2084server # [ 164.733270] systemd[1]: Reached target Multi-User System.2085server # [ 164.747334] systemd[1]: Startup finished in 2.074s (kernel) + 21.592s (initrd) + 2min 21.074s (userspace) = 2min 44.741s.2086server: (finished: waiting for unit supabase-db-init.service, in 167.13 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.92 seconds)2091server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.9.1' CASCADE;" 2092server # WARNING:2093server # WELCOME TO2094server # _____ _ _ ____________2095server # |_ _(_) | | | _ \ ___ \2096server # | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ /2097server # | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \2098server # | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ /2099server # |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/2100server # Running version 2.9.12101server # For more information on TimescaleDB, please visit the following links:2102server # 2103server # 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started2104server # 2. API reference documentation: https://docs.timescale.com/api/latest2105server # 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts2106server # 2107server # Note: Please enable telemetry to help us improve our product by running: ALTER DATABASE "postgres" SET timescaledb.telemetry_level = 'basic';2108server # 2109server # [ 174.053303] postgres[1630]: [local] 2026-10-31 19:39:26.065 UTC [1630] supabase_admin@postgres WARNING:2110server # [ 174.069503] postgres[1630]: WELCOME TO2111server # [ 174.071022] postgres[1630]: _____ _ _ ____________2112server # [ 174.071660] postgres[1630]: |_ _(_) | | | _ \ ___ \2113server # [ 174.081240] postgres[1630]: | | _ _ __ ___ ___ ___ ___ __ _| | ___| | | | |_/ /2114server # [ 174.083254] postgres[1630]: | | | | _ ` _ \ / _ \/ __|/ __/ _` | |/ _ \ | | | ___ \2115server # [ 174.089449] postgres[1630]: | | | | | | | | | __/\__ \ (_| (_| | | __/ |/ /| |_/ /2116server # [ 174.090274] postgres[1630]: |_| |_|_| |_| |_|\___||___/\___\__,_|_|\___|___/ \____/2117server # [ 174.091314] postgres[1630]: Running version 2.9.12118server # [ 174.097313] postgres[1630]: For more information on TimescaleDB, please visit the following links:2119server # [ 174.098223] postgres[1630]:2120server # [ 174.099274] postgres[1630]: 1. Getting started: https://docs.timescale.com/timescaledb/latest/getting-started2121server # [ 174.099961] postgres[1630]: 2. API reference documentation: https://docs.timescale.com/api/latest2122server # [ 174.105637] postgres[1630]: 3. How TimescaleDB is designed: https://docs.timescale.com/timescaledb/latest/overview/core-concepts2123server # [ 174.106588] postgres[1630]:2124server # [ 174.107559] postgres[1630]: Note: Please enable telemetry to help us improve our product by running: ALTER DATABASE "postgres" SET timescaledb.telemetry_level = 'basic';2125server # [ 174.108219] postgres[1630]:2126server # [ 174.114304] postgres[1630]: [local] 2026-10-31 19:39:26.065 UTC [1630] supabase_admin@postgres CONTEXT: PL/pgSQL function inline_code_block line 16 at RAISE2127server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.9.1' CASCADE;" , in 7.20 seconds)2128server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" 2129server # [ 174.720533] postgres[1687]: 2026-10-31 19:39:26.727 UTC [1687] LOG: job 2 threw an error2130server # [ 174.726597] postgres[1687]: 2026-10-31 19:39:26.751 UTC [1687] ERROR: functionality not supported under the current "apache" license2131server # [ 174.736940] postgres[1687]: 2026-10-31 19:39:26.751 UTC [1687] HINT: Upgrade your license to 'timescale' to use this free community feature.2132server # [ 174.796317] postgres[1038]: 2026-10-31 19:39:26.815 UTC [1038] LOG: background worker "Error Log Retention Policy [2]" (PID 1687) exited with exit code 12133server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.99 seconds)2134server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "ALTER EXTENSION timescaledb UPDATE TO '2.16.1';" 2135server # [ 176.272741] systemd-logind[613]: Watching system buttons on /dev/input/event0 (gpio-keys)2136server # [ 176.355198] postgres[1674]: 2026-10-31 19:39:28.358 UTC [1674] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command2137server # [ 176.382178] postgres[1038]: 2026-10-31 19:39:28.395 UTC [1038] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 1674) exited with exit code 12138server # [ 179.370941] mousedev: PS/2 mouse device common for all mice2139server # [ 181.680002] systemd-logind[613]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2140server # [ 183.679393] postgres[1702]: 2026-10-31 19:39:35.691 UTC [1702] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command2141server # [ 183.721215] postgres[1038]: 2026-10-31 19:39:35.739 UTC [1038] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 1702) exited with exit code 12142server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "ALTER EXTENSION timescaledb UPDATE TO '2.16.1';" , in 8.87 seconds)2143server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" 2144server # [ 184.385099] postgres[1766]: 2026-10-31 19:39:36.394 UTC [1766] LOG: job 3 threw an error2145server # [ 184.390617] postgres[1766]: 2026-10-31 19:39:36.410 UTC [1766] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/.2146server # [ 184.402949] postgres[1766]: 2026-10-31 19:39:36.410 UTC [1766] HINT: To access all features and the best time-series experience, try out Timescale Cloud.2147server # [ 184.430798] postgres[1038]: 2026-10-31 19:39:36.459 UTC [1038] LOG: background worker "Job History Log Retention Policy [3]" (PID 1766) exited with exit code 12148server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 0.84 seconds)2149(finished: subtest: Check upgrade path with postgresql 15, in 18.82 seconds)2150subtest: Check the install of the last version of the extension2151server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" 2152server # [ 185.435333] postgres[1763]: 2026-10-31 19:39:37.447 UTC [1763] FATAL: terminating background worker "TimescaleDB Background Worker Scheduler" due to administrator command2153server # [ 185.473985] postgres[1038]: 2026-10-31 19:39:37.474 UTC [1038] LOG: background worker "TimescaleDB Background Worker Scheduler" (PID 1763) exited with exit code 12154server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS timescaledb;" , in 1.41 seconds)2155server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" 2156server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION timescaledb WITH VERSION '2.16.1' CASCADE;" , in 6.48 seconds)2157server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" 2158server # [ 193.355656] postgres[1835]: 2026-10-31 19:39:45.338 UTC [1835] LOG: job 3 threw an error2159server # [ 193.366288] postgres[1835]: 2026-10-31 19:39:45.349 UTC [1835] ERROR: functionality not supported under the current "apache" license. Learn more at https://timescale.com/.2160server # [ 193.368043] postgres[1835]: 2026-10-31 19:39:45.349 UTC [1835] HINT: To access all features and the best time-series experience, try out Timescale Cloud.2161server # [ 193.417957] postgres[1038]: 2026-10-31 19:39:45.413 UTC [1038] LOG: background worker "Job History Log Retention Policy [3]" (PID 1835) exited with exit code 12162server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'timescaledb';" , in 1.01 seconds)2163(finished: subtest: Check the install of the last version of the extension, in 8.90 seconds)2164(finished: run the VM test script, in 195.16 seconds)2165test script finished in 195.80s2166cleanup2167kill QemuMachine (pid 13)2168server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/vilynzly1pyhawy04ljmrp7n9ffr24qy-python3-3.13.17/bin/python3.13)2169(finished: cleanup, in 0.07 seconds)