nixbot

builds

failed vm-test-run-pgjwt checks.aarch64-linux.ext-pgjwt · build #474 · raw

1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600 seconds5run the VM test script6additionally exposed symbols:7 server,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11server: starting vm12server: QEMU running (pid 13)13server # Disk image does not exist, creating the virtualisation disk image...14server # Formatting '/build/vm-state-server/tmp.ZcB7uoZkzH', fmt=raw size=107374182415server # mke2fs 1.47.4 (6-Mar-2025)16server # Discarding device blocks: 0/262144 done17server # Creating filesystem with 262144 4k blocks and 65536 inodes18server # Filesystem UUID: e05f0d32-00b0-40fc-aba8-c9330282002e19server # Superblock backups stored on blocks:20server # 32768, 98304, 163840, 22937621server # 22server # Allocating group tables: 0/8 done23server # Writing inode tables: 0/8 done24server # Creating journal (8192 blocks): done25server # Writing superblocks and filesystem accounting information: 0/8 done26server # 27server # Virtualisation disk image created.28server # qemu-system-aarch64: Could not access KVM kernel module: No such file or directory29server # qemu-system-aarch64: failed to initialize kvm: No such file or directory30server # qemu-system-aarch64: falling back to tcg31(finished: start all VMs, in 0.16 seconds)32server: waiting for unit supabase-db-init.service33server: waiting for the VM to finish booting34server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]35server # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 202636server # [ 0.000000] KASLR enabled37server # [ 0.000000] random: crng init done38server # [ 0.000000] Machine model: linux,dummy-virt39server # [ 0.000000] efi: UEFI not found.40server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT41server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]42server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f6031c0-0x13f60693f]43server # [ 0.000000] Zone ranges:44server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff]45server # [ 0.000000] DMA32 empty46server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff]47server # [ 0.000000] Device empty48server # [ 0.000000] Movable zone start for each node49server # [ 0.000000] Early memory node ranges50server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff]51server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]52server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe00000053server # [ 0.000000] psci: probing for conduit method from DT.54server # [ 0.000000] psci: PSCIv1.1 detected in firmware.55server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs56server # [ 0.000000] psci: Trusted OS migration not required57server # [ 0.000000] psci: SMC Calling Convention v1.058server # [ 0.000000] percpu: Embedded 76 pages/cpu s186520 r8192 d116584 u31129659server # [ 0.000000] Detected PIPT I-cache on CPU060server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)61server # [ 0.000000] CPU features: detected: GICv3 CPU interface62server # [ 0.000000] CPU features: detected: HCRX_EL2 register63server # [ 0.000000] CPU features: detected: Stage-1 Permission Indirection Extension (S1PIE)64server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2)65server # [ 0.000000] CPU features: detected: Spectre-v466server # [ 0.000000] alternatives: applying boot alternatives67server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/hfxhpbki07sz40832cnfs3kh5v4i27dg-nixos-system-server-test/init regInfo=/nix/store/m9009b8wjx9clkqqmfzjpkhjpaqylybk-closure-info/registration console=ttyAMA0,115200n8 console=tty068server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/m9009b8wjx9clkqqmfzjpkhjpaqylybk-closure-info/registration", will be passed to user space.69server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes70server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)71server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)72server # [ 0.000000] software IO TLB: area num 2.73server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)74server # [ 0.000000] Fallback order for Node 0: 075server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 104857676server # [ 0.000000] Policy zone: Normal77server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off78server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=179server # [ 0.000000] allocated 8388608 bytes of page_ext80server # [ 0.000000] ftrace: allocating 74832 entries in 294 pages81server # [ 0.000000] ftrace: allocated 294 pages with 4 groups82server # [ 0.000000] rcu: Hierarchical RCU implementation.83server # [ 0.000000] rcu: RCU event tracing is enabled.84server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2.85server # [ 0.000000] Trampoline variant of Tasks RCU enabled.86server # [ 0.000000] Rude variant of Tasks RCU enabled.87server # [ 0.000000] Tracing variant of Tasks RCU enabled.88server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.89server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=290server # [ 0.000000] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.91server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.92server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.93server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 094server # [ 0.000000] GICv3: 256 SPIs implemented95server # [ 0.000000] GICv3: 0 Extended SPIs implemented96server # [ 0.000000] Root IRQ handler: gic_handle_irq97server # [ 0.000000] GICv3: GICv3 features: 16 PPIs98server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=099server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000100server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]101server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b00000 (indirect, esz 8, psz 64K, shr 1)102server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b10000 (flat, esz 8, psz 64K, shr 1)103server # [ 0.000000] GICv3: using LPI property table @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.000046] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns110server # [ 0.004746] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)111server # [ 0.016962] Console: colour dummy device 80x25112server # [ 0.018611] printk: legacy console [tty0] enabled113server # [ 0.024353] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)114server # [ 0.024778] pid_max: default: 32768 minimum: 301115server # [ 0.027753] LSM: initializing lsm=capability,landlock,yama,bpf,ima116server # [ 0.029255] landlock: Up and running.117server # [ 0.029318] Yama: becoming mindful.118server # [ 0.032343] LSM support for eBPF active119server # [ 0.035279] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)120server # [ 0.035702] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)121server # [ 0.078831] rcu: Hierarchical SRCU implementation.122server # [ 0.078948] rcu: Max phase no-delay instances is 1000.123server # [ 0.080302] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level124server # [ 0.087375] fsl-mc MSI: its@8080000 domain created125server # [ 0.089454] EFI services will not be available.126server # [ 0.091408] smp: Bringing up secondary CPUs ...127server # [ 0.097073] Detected PIPT I-cache on CPU1128server # [ 0.098793] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000129server # [ 0.099493] GICv3: CPU1: using allocated LPI pending table @0x0000000100b50000130server # [ 0.101008] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]131server # [ 0.105247] smp: Brought up 1 node, 2 CPUs132server # [ 0.105446] SMP: Total of 2 processors activated.133server # [ 0.105492] CPU: All CPU(s) started at EL1134server # [ 0.105672] CPU features: detected: Branch Target Identification135server # [ 0.105720] CPU features: detected: 32-bit EL0 Support136server # [ 0.105756] CPU features: detected: 32-bit EL1 Support137server # [ 0.105786] CPU features: detected: ARMv8.4 Translation Table Level138server # [ 0.105821] CPU features: detected: Instruction cache invalidation not required for I/D coherence139server # [ 0.105858] CPU features: detected: Data cache clean to the PoU not required for I/D coherence140server # [ 0.105926] CPU features: detected: Common not Private translations141server # [ 0.105959] CPU features: detected: CRC32 instructions142server # [ 0.105987] CPU features: detected: Data cache clean to Point of Deep Persistence143server # [ 0.106225] CPU features: detected: Data cache clean to Point of Persistence144server # [ 0.106272] CPU features: detected: Data independent timing control (DIT)145server # [ 0.106306] CPU features: detected: E0PD146server # [ 0.106332] CPU features: detected: Enhanced Counter Virtualization147server # [ 0.106361] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)148server # [ 0.106393] CPU features: detected: Enhanced Privileged Access Never149server # [ 0.106424] CPU features: detected: Enhanced Virtualization Traps150server # [ 0.106452] CPU features: detected: Fine Grained Traps151server # [ 0.106480] CPU features: detected: Guarded Control Stack (GCS)152server # [ 0.106550] CPU features: detected: Generic authentication (IMP DEF algorithm)153server # [ 0.106645] CPU features: detected: RCpc load-acquire (LDAPR)154server # [ 0.106695] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)155server # [ 0.106726] CPU features: detected: LSE atomic instructions156server # [ 0.106754] CPU features: detected: Memory Copy and Memory Set instructions157server # [ 0.106786] CPU features: detected: Privileged Access Never158server # [ 0.106837] CPU features: detected: PMUv3159server # [ 0.106863] CPU features: detected: SCTLR2160server # [ 0.106889] CPU features: detected: RAS Extension Support161server # [ 0.106954] CPU features: detected: RASv1p1 Extension Support162server # [ 0.106984] CPU features: detected: Random Number Generator163server # [ 0.107009] CPU features: detected: Speculation barrier (SB)164server # [ 0.107038] CPU features: detected: Stage-2 Force Write-Back165server # [ 0.107067] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality166server # [ 0.107099] CPU features: detected: TLB range maintenance instructions167server # [ 0.107129] CPU features: detected: WFx with timeout168server # [ 0.107215] CPU features: detected: Scalable Matrix Extension169server # [ 0.107242] CPU features: detected: FA64170server # [ 0.107267] CPU features: detected: SME2171server # [ 0.107287] CPU features: detected: Speculative Store Bypassing Safe (SSBS)172server # [ 0.107313] CPU features: detected: Scalable Vector Extension173server # [ 0.113808] alternatives: applying system-wide alternatives174server # [ 0.128838] CPU features: detected: Hardware dirty bit management on CPU0-1175server # [ 0.129574] SVE: maximum available vector length 256 bytes per vector176server # [ 0.129663] SVE: default vector length 64 bytes per vector177server # [ 0.130802] SME: minimum available vector length 16 bytes per vector178server # [ 0.130863] SME: maximum available vector length 256 bytes per vector179server # [ 0.130900] SME: default vector length 32 bytes per vector180server # [ 0.148501] Memory: 3904080K/4194304K available (24320K kernel code, 7090K rwdata, 26572K rodata, 4736K init, 1103K bss, 241772K reserved, 32768K cma-reserved)181server # [ 0.171643] devtmpfs: initialized182server # [ 0.204004] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear)183server # [ 0.204318] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear).184server # [ 0.207183] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL185server # [ 0.207367] 0 pages in range for non-PLT usage186server # [ 0.207430] 508272 pages in range for PLT usage187server # [ 0.210406] pinctrl core: initialized pinctrl subsystem188server # [ 0.221895] DMI not present or invalid.189server # [ 0.240558] NET: Registered PF_NETLINK/PF_ROUTE protocol family190server # [ 0.252001] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations191server # [ 0.253657] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations192server # [ 0.255100] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations193server # [ 0.255411] audit: initializing netlink subsys (disabled)194server # [ 0.258006] audit: type=2000 audit(0.208:1): state=initialized audit_enabled=0 res=1195server # [ 0.263908] thermal_sys: Registered thermal governor 'fair_share'196server # [ 0.263970] thermal_sys: Registered thermal governor 'bang_bang'197server # [ 0.264038] thermal_sys: Registered thermal governor 'step_wise'198server # [ 0.264068] thermal_sys: Registered thermal governor 'user_space'199server # [ 0.264094] thermal_sys: Registered thermal governor 'power_allocator'200server # [ 0.264682] cpuidle: using governor ladder201server # [ 0.264996] cpuidle: using governor menu202server # [ 0.267223] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.203server # [ 0.268228] ASID allocator initialised with 65536 entries204server # [ 0.275879] Serial: AMBA PL011 UART driver205server # [ 0.332347] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1206server # [ 0.335022] printk: console [ttyAMA0] enabled207server # [ 0.388316] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages208server # [ 0.388419] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page209server # [ 0.388470] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages210server # [ 0.388500] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page211server # [ 0.388529] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages212server # [ 0.388556] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page213server # [ 0.388585] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages214server # [ 0.388611] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page215server # [ 0.414309] fbcon: Taking over console216server # [ 0.415588] ACPI: Interpreter disabled.217server # [ 0.427262] iommu: Default domain type: Translated218server # [ 0.427360] iommu: DMA domain TLB invalidation policy: strict mode219server # [ 0.435642] SCSI subsystem initialized220server # [ 0.440636] usbcore: registered new interface driver usbfs221server # [ 0.440933] usbcore: registered new interface driver hub222server # [ 0.441114] usbcore: registered new device driver usb223server # [ 0.444346] pps_core: LinuxPPS API ver. 1 registered224server # [ 0.444402] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>225server # [ 0.444494] PTP clock support registered226server # [ 0.444844] EDAC MC: Ver: 3.0.0227server # [ 0.446460] scmi_core: SCMI protocol bus registered228server # [ 0.457358] FPGA manager framework229server # [ 0.467136] vgaarb: loaded230server # [ 0.470701] clocksource: Switched to clocksource arch_sys_counter231server # [ 0.476082] VFS: Disk quotas dquot_6.6.0232server # [ 0.476250] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)233server # [ 0.481492] netfs: FS-Cache loaded234server # [ 0.483887] pnp: PnP ACPI: disabled235server # [ 0.509590] NET: Registered PF_INET protocol family236server # [ 0.511282] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)237server # [ 0.616903] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)238server # [ 0.617099] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)239server # [ 0.617227] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)240server # [ 0.617606] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)241server # [ 0.617907] TCP: Hash tables configured (established 32768 bind 32768)242server # [ 0.620348] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)243server # [ 0.620758] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)244server # [ 0.621189] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)245server # [ 0.622732] NET: Registered PF_UNIX/PF_LOCAL protocol family246server # [ 0.623117] NET: Registered PF_XDP protocol family247server # [ 0.623289] PCI: CLS 0 bytes, default 64248server # [ 0.627365] kvm [1]: HYP mode not available249server # [ 0.628297] Trying to unpack rootfs image as initramfs...250server # [ 0.768278] Initialise system trusted keyrings251server # [ 0.772717] workingset: timestamp_bits=42 max_order=20 bucket_order=0252server # [ 0.779215] squashfs: version 4.0 (2009/01/31) Phillip Lougher253server # [ 0.779868] 9p: Installing v9fs 9p2000 file system support254server # [ 0.842647] Key type asymmetric registered255server # [ 0.843408] Asymmetric key parser 'x509' registered256server # [ 0.843823] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)257server # [ 0.851883] io scheduler mq-deadline registered258server # [ 0.852028] io scheduler kyber registered259server # [ 0.885934] pl061_gpio 9030000.pl061: PL061 GPIO chip registered260server # [ 0.896010] ledtrig-cpu: registered to indicate activity on CPUs261server # [ 0.900786] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:262server # [ 0.901296] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000263server # [ 0.901703] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000264server # [ 0.901803] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000265server # [ 0.902476] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits266server # [ 0.903424] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]267server # [ 0.904964] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00268server # [ 0.905253] pci_bus 0000:00: root bus resource [bus 00-ff]269server # [ 0.905379] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]270server # [ 0.905441] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]271server # [ 0.905480] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]272server # [ 0.907111] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint273server # [ 0.913397] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint274server # [ 0.913662] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]275server # [ 0.913744] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]276server # [ 0.913797] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]277server # [ 0.913875] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]278server # [ 0.914521] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint279server # [ 0.915056] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]280server # [ 0.915112] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]281server # [ 0.915160] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282server # [ 0.916239] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint283server # [ 0.916776] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]284server # [ 0.916841] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]285server # [ 0.916890] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]286server # [ 0.917843] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint287server # [ 0.918415] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]288server # [ 0.918477] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]289server # [ 0.919965] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290server # [ 0.922160] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint291server # [ 0.922424] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]292server # [ 0.923907] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]293server # [ 0.924137] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]294server # [ 0.925427] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint295server # [ 0.925545] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]296server # [ 0.925587] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]297server # [ 0.925626] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298server # [ 0.926245] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint299server # [ 0.926340] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]300server # [ 0.926382] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]301server # [ 0.926418] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]302server # [ 0.926462] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]303server # [ 0.926938] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint304server # [ 0.927022] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]305server # [ 0.927061] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]306server # [ 0.928579] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint307server # [ 0.928718] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]308server # [ 0.929109] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]309server # [ 0.929855] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint310server # [ 0.929948] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]311server # [ 0.932723] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint312server # [ 0.933264] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]313server # [ 0.933366] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]314server # [ 0.933443] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]315server # [ 0.938798] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint316server # [ 0.939433] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]317server # [ 0.939498] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]318server # [ 0.939542] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]319server # [ 0.945811] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned320server # [ 0.946467] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned321server # [ 0.946581] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned322server # [ 0.947134] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned323server # [ 0.947231] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned324server # [ 0.947285] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned325server # [ 0.947352] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned326server # [ 0.947523] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned327server # [ 0.947764] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned328server # [ 0.947988] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned329server # [ 0.948249] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned330server # [ 0.948326] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned331server # [ 0.948822] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned332server # [ 0.949086] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned333server # [ 0.949144] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned334server # [ 0.949190] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned335server # [ 0.949228] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned336server # [ 0.949265] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned337server # [ 0.949308] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned338server # [ 0.949348] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned339server # [ 0.949385] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned340server # [ 0.949431] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned341server # [ 0.949478] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned342server # [ 0.949564] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned343server # [ 0.949625] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned344server # [ 0.949684] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned345server # [ 0.949752] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned346server # [ 0.949798] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned347server # [ 0.949844] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned348server # [ 0.949889] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned349server # [ 0.949934] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned350server # [ 0.950197] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned351server # [ 0.952010] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned352server # [ 0.952081] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned353server # [ 0.953065] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]354server # [ 0.953154] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]355server # [ 0.953204] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]356server # [ 0.963243] pci 0000:00:0a.0: enabling device (0000 -> 0002)357server # [ 1.035221] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)358server # [ 1.040317] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)359server # [ 1.041919] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)360server # [ 1.044613] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)361server # [ 1.048349] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)362server # [ 1.049704] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)363server # [ 1.052855] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)364server # [ 1.055653] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)365server # [ 1.056971] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)366server # [ 1.062125] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)367server # [ 1.065092] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)368server # [ 1.084186] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled369server # [ 1.095769] msm_serial: driver initialized370server # [ 1.096677] SuperH (H)SCI(F) driver initialized371server # [ 1.097112] STM32 USART driver initialized372server # [ 1.160294] loop: module loaded373server # [ 1.160894] virtio_blk virtio5: 2/0/0 default/read/poll queues374server # [ 1.165161] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)375server # [ 1.179453] megasas: 07.734.00.00-rc1376server # [ 1.184864] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]377server # [ 1.187898] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000378server # [ 1.188419] Intel/Sharp Extended Query Table at 0x0031379server # [ 1.189448] Using buffer write method380server # [ 1.189942] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]381server # [ 1.190978] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000382server # [ 1.191080] Intel/Sharp Extended Query Table at 0x0031383server # [ 1.194007] Using buffer write method384server # [ 1.194286] Concatenating MTD devices:385server # [ 1.194327] (0): "0.flash"386server # [ 1.194360] (1): "0.flash"387server # [ 1.194385] into device "0.flash"388server # [ 1.763595] Freeing initrd memory: 25488K389server # [ 1.873397] tun: Universal TUN/TAP device driver, 1.6390server # [ 1.888916] thunder_xcv, ver 1.0391server # [ 1.889125] thunder_bgx, ver 1.0392server # [ 1.889291] nicpf, ver 1.0393server # [ 1.893004] e1000: Intel(R) PRO/1000 Network Driver394server # [ 1.893076] e1000: Copyright (c) 1999-2006 Intel Corporation.395server # [ 1.893240] e1000e: Intel(R) PRO/1000 Network Driver396server # [ 1.893271] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.397server # [ 1.893427] igb: Intel(R) Gigabit Ethernet Network Driver398server # [ 1.893465] igb: Copyright (c) 2007-2014 Intel Corporation.399server # [ 1.893622] igbvf: Intel(R) Gigabit Virtual Function Network Driver400server # [ 1.893662] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.401server # [ 1.894516] sky2: driver version 1.30402server # [ 1.907214] ehci-pci 0000:00:0a.0: EHCI Host Controller403server # [ 1.907646] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1404server # [ 1.909251] usbcore: registered new interface driver usb-storage405server # [ 1.909606] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000406server # [ 1.909664] usbcore: registered new interface driver usbserial_generic407server # [ 1.909890] usbserial: USB Serial support registered for generic408server # [ 1.917271] hv_vmbus: registering driver hyperv_keyboard409server # [ 1.919842] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00410server # [ 1.925950] rtc-pl031 9010000.pl031: registered as rtc0411server # [ 1.926513] rtc-pl031 9010000.pl031: setting system clock to 2026-10-27T16:33:19 UTC (1793118799)412server # [ 1.928762] hub 1-0:1.0: USB hub found413server # [ 1.928930] i2c_dev: i2c /dev entries driver414server # [ 1.929295] hub 1-0:1.0: 6 ports detected415server # [ 1.947659] sdhci: Secure Digital Host Controller Interface driver416server # [ 1.947748] sdhci: Copyright(c) Pierre Ossman417server # [ 1.949385] Synopsys Designware Multimedia Card Interface Driver418server # [ 1.951840] sdhci-pltfm: SDHCI platform and OF driver helper419server # [ 1.961722] hid: raw HID events driver (C) Jiri Kosina420server # [ 1.964608] usbcore: registered new interface driver usbhid421server # [ 1.964683] usbhid: USB HID core driver422server # [ 1.975625] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available423server # [ 1.985243] drop_monitor: Initializing network drop monitor service424server # [ 1.986438] NET: Registered PF_INET6 protocol family425server # [ 1.997558] Segment Routing with IPv6426server # [ 1.997828] In-situ OAM (IOAM) with IPv6427server # [ 1.998367] NET: Registered PF_PACKET protocol family428server # [ 2.000072] 9pnet: Installing 9P2000 support429server # [ 2.004735] Key type dns_resolver registered430server # [ 2.048550] registered taskstats version 1431server # [ 2.051552] Loading compiled-in X.509 certificates432server # [ 2.119836] Demotion targets for Node 0: null433server # [ 2.120909] Key type .fscrypt registered434server # [ 2.120970] Key type fscrypt-provisioning registered435server # [ 2.124558] ima: No TPM chip found, activating TPM-bypass!436server # [ 2.124686] ima: Allocated hash algorithm: sha1437server # [ 2.126479] ima: No architecture policies found438server # [ 2.136715] input: gpio-keys as /devices/platform/gpio-keys/input/input0439server # [ 2.187374] usb 1-1: new high-speed USB device number 2 using ehci-pci440server # [ 2.187400] clk: Disabling unused clocks441server # [ 2.187578] PM: genpd: Disabling unused power domains442server # [ 2.368015] 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.436010] 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.557468] usb 1-2: new high-speed USB device number 3 using ehci-pci445server # [ 2.560713] Freeing unused kernel memory: 4736K446server # [ 2.561986] Run /init as init process447server # [ 2.708564] systemd[1]: Successfully made /usr/ read-only.448server # [ 2.721570] 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.725019] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0450server # [ 3.060343] systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)451server # [ 3.060592] systemd[1]: Detected virtualization qemu.452server # [ 3.060905] systemd[1]: Detected architecture arm64.453server # [ 3.060981] systemd[1]: Running in initrd.454server # [ 3.072937] systemd[1]: Initializing machine ID from random generator.455server # [ 3.076714] systemd[1]: Hostname set to <server>.456server # [ 3.745977] systemd[1]: Queued start job for default target Initrd Default Target.457server # [ 3.800098] systemd[1]: Created slice Slice /system/modprobe.458server # [ 3.804743] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.459server # [ 3.805556] systemd[1]: Expecting device /dev/disk/by-label/nixos...460server # [ 3.805972] systemd[1]: Reached target Path Units.461server # [ 3.806423] systemd[1]: Reached target Slice Units.462server # [ 3.806746] systemd[1]: Reached target Swaps.463server # [ 3.807955] systemd[1]: Reached target Timer Units.464server # [ 3.811581] systemd[1]: Listening on D-Bus System Message Bus Socket.465server # [ 3.813636] systemd[1]: Listening on Journal Socket (/dev/log).466server # [ 3.816120] systemd[1]: Listening on Journal Sockets.467server # [ 3.817530] systemd[1]: Listening on udev Control Socket.468server # [ 3.818225] systemd[1]: Listening on udev Kernel Socket.469server # [ 3.818419] systemd[1]: Reached target Socket Units.470server # [ 3.842221] systemd[1]: Starting Create List of Static Device Nodes...471server # [ 3.863774] systemd[1]: Starting Load Kernel Module 9pnet_virtio...472server # [ 3.865247] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs473server # [ 3.925143] systemd[1]: Mounting Kernel Configuration File System...474server # [ 4.011268] systemd[1]: Starting Journal Service...475server # [ 4.050222] systemd[1]: Starting Load Kernel Modules...476server # [ 4.055465] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki477server # [ 4.092490] systemd[1]: Starting Coldplug All udev Devices...478server # [ 4.165886] systemd[1]: Finished Create List of Static Device Nodes.479server # [ 4.225452] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.480server # [ 4.233732] systemd[1]: Finished Load Kernel Module 9pnet_virtio.481server # [ 4.265118] systemd[1]: Mounted Kernel Configuration File System.482server # [ 4.292603] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...483server # [ 4.528470] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.484server # [ 4.541618] systemd-journald[81]: Collecting audit messages is disabled.485server # [ 4.574455] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.486server # [ 4.579858] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0487server # [ 4.580441] [drm] features: -virgl +edid -resource_blob -host_visible488server # [ 4.580468] [drm] features: -context_init489server # [ 4.582456] [drm] number of scanouts: 1490server # [ 4.582530] [drm] number of cap sets: 0491server # [ 4.588310] systemd[1]: Starting Create Static Device Nodes in /dev...492server # [ 4.596570] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev493server # [ 4.610262] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic494server # [ 4.610395] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0495server # [ 4.729043] Console: switching to colour frame buffer device 160x50496server # [ 4.735864] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device497server # [ 4.782478] systemd[1]: Finished Load Kernel Modules.498server # [ 4.797373] systemd[1]: Finished Create Static Device Nodes in /dev.499server # [ 4.801815] systemd[1]: Reached target Preparation for Local File Systems.500server # [ 4.807444] systemd[1]: Reached target Local File Systems.501server # [ 4.837526] systemd[1]: Starting Apply Kernel Variables...502server # [ 4.891957] systemd[1]: Starting Rule-based Manager for Device Events and Files...503server # [ 5.188202] systemd[1]: Finished Apply Kernel Variables.504server # [ 5.401040] systemd[1]: Started Journal Service.505server # [ 5.319435] systemd-modules-load[82]: Using 2 probe threads506server # [ 5.338748] systemd-modules-load[82]: Module 'virtio_balloon' is built in507server # [ 5.361566] systemd-modules-load[82]: Module 'virtio_console' is built in508server # [ 5.366193] systemd-modules-load[82]: Inserted module 'dm_mod'509server # [ 5.378208] systemd-modules-load[82]: Module 'virtio_rng' is built in510server # [ 5.388104] systemd-modules-load[82]: Inserted module 'virtio_gpu'511server # [ 5.419044] systemd-udevd[89]: Using default interface naming scheme 'v260'.512server # [ 5.434935] systemd[1]: Starting Create System Files and Directories...513server # [ 5.666785] systemd[1]: Finished Create System Files and Directories.514server # [ 5.800606] systemd[1]: Started Rule-based Manager for Device Events and Files.515server # [ 6.167061] systemd[1]: Starting Virtual Console Setup...516server # [ 6.437674] systemd-vconsole-setup[111]: Configuration of first virtual console was skipped, ignoring remaining ones.517server # [ 6.461351] systemd[1]: Finished Virtual Console Setup.518server # [ 10.381137] systemd[1]: Finished Coldplug All udev Devices.519server # [ 10.396895] systemd[1]: Reached target System Initialization.520server # [ 10.398022] systemd[1]: Reached target Basic System.521server # [ 12.577273] (udev-worker)[125]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.522server # [ 12.579488] (udev-worker)[125]: Network interface NamePolicy= disabled on kernel command line.523server # [ 12.587873] (udev-worker)[117]: Network interface NamePolicy= disabled on kernel command line.524server # [ 12.803694] systemd[1]: Found device /dev/disk/by-label/nixos.525server # [ 12.825685] systemd[1]: Reached target Initrd Root Device.526server # [ 12.839824] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...527server # [ 13.264964] systemd-fsck[139]: nixos: clean, 12/65536 files, 13019/262144 blocks528server # [ 13.296898] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.529server # [ 13.350359] systemd[1]: Mounting /sysroot...530server # [ 14.053742] EXT4-fs (vda): mounted filesystem e05f0d32-00b0-40fc-aba8-c9330282002e r/w with ordered data mode. Quota mode: none.531server # [ 14.016100] systemd[1]: Mounted /sysroot.532server # [ 14.041261] systemd[1]: Reached target Initrd Root File System.533server # [ 14.098404] systemd[1]: Mounting /sysroot/nix/.ro-store...534server # [ 14.134198] systemd[1]: Mounting /sysroot/nix/.rw-store...535server # [ 14.187007] systemd[1]: Mounting /sysroot/run...536server # [ 14.241255] systemd[1]: Mounting /sysroot/tmp/shared...537server # [ 14.291224] systemd[1]: Mounting /sysroot/tmp/xchg...538server # [ 14.341999] systemd[1]: Starting Mountpoints Configured in the Real Root...539server # [ 14.482477] systemd-sysroot-fstab-check[152]: /sysroot should be mounted in the initrd, will request daemon-reload.540server # [ 14.516015] systemd[1]: Mounted /sysroot/nix/.ro-store.541server # [ 14.525227] systemd[1]: Mounted /sysroot/nix/.rw-store.542server # [ 14.539041] systemd[1]: Mounted /sysroot/run.543server # [ 14.547879] systemd[1]: Mounted /sysroot/tmp/shared.544server # [ 14.550424] systemd[1]: Mounted /sysroot/tmp/xchg.545server # [ 14.605896] systemd[1]: Reload requested from client PID 152 ('systemd-sysroot') (unit initrd-parse-etc.service)...546server # [ 14.609822] systemd[1]: Reloading...547server # [ 15.743776] systemd[1]: Reloading finished in 1127 ms.548server # [ 15.821298] systemd-sysroot-fstab-check[152]: Requesting initrd-fs.target/start/replace...549server # [ 15.835468] systemd-sysroot-fstab-check[152]: Requesting swap.target/start/replace...550server # [ 15.865875] systemd[1]: initrd-parse-etc.service: Deactivated successfully.551server # [ 15.871869] systemd[1]: Finished Mountpoints Configured in the Real Root.552server # [ 15.875807] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.553server # [ 15.901482] systemd[1]: Starting rw-sysroot-nix-store.service...554server # [ 16.027943] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.555server # [ 16.033549] systemd[1]: Finished rw-sysroot-nix-store.service.556server # [ 16.067822] systemd[1]: Mounting /sysroot/nix/store...557server # [ 16.413301] systemd[1]: Mounted /sysroot/nix/store.558server # [ 16.434296] systemd[1]: Reached target Initrd File Systems.559server # [ 16.469199] systemd[1]: Starting Find NixOS closure...560server # [ 16.522163] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...561server # [ 16.863260] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.562server # [ 16.886574] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.563server # [ 17.104900] systemd[1]: Finished Find NixOS closure.564server # [ 17.113813] systemd[1]: Reached target Initrd Default Target.565server # [ 17.135116] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...566server # [ 17.355150] systemd[1]: initrd-cleanup.service: Deactivated successfully.567server # [ 17.359170] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.568server # [ 17.386212] systemd[1]: Stopped target Initrd Default Target.569server # [ 17.395467] systemd[1]: Stopped target Basic System.570server # [ 17.399264] systemd[1]: Stopped target Initrd Root Device.571server # [ 17.404953] systemd[1]: Stopped target Path Units.572server # [ 17.410680] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.573server # [ 17.413304] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.574server # [ 17.415010] systemd[1]: Stopped target Slice Units.575server # [ 17.417298] systemd[1]: Stopped target Socket Units.576server # [ 17.419559] systemd[1]: Stopped target System Initialization.577server # [ 17.421897] systemd[1]: Stopped target Swaps.578server # [ 17.422977] systemd[1]: Stopped target Timer Units.579server # [ 17.426234] systemd[1]: dbus.socket: Deactivated successfully.580server # [ 17.433224] systemd[1]: Closed D-Bus System Message Bus Socket.581server # [ 17.435127] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.582server # [ 17.437506] systemd[1]: Stopped Find NixOS closure.583server # [ 17.439887] systemd[1]: Starting Load Kernel Module 9pnet_virtio...584server # [ 17.462916] systemd[1]: Starting rw-sysroot-nix-store.service...585server # [ 17.469881] systemd[1]: systemd-sysctl.service: Deactivated successfully.586server # [ 17.471291] systemd[1]: Stopped Apply Kernel Variables.587server # [ 17.473138] systemd[1]: systemd-modules-load.service: Deactivated successfully.588server # [ 17.474277] systemd[1]: Stopped Load Kernel Modules.589server # [ 17.475529] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.590server # [ 17.481919] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.591server # [ 17.484005] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.592server # [ 17.488400] systemd[1]: Stopped Create System Files and Directories.593server # [ 17.493673] systemd[1]: Stopped target Local File Systems.594server # [ 17.495152] systemd[1]: Stopped target Preparation for Local File Systems.595server # [ 17.497996] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.596server # [ 17.505871] systemd[1]: Stopped Coldplug All udev Devices.597server # [ 17.509010] systemd[1]: systemd-udev-trigger.service: Consumed 5.154s CPU time over 13.477s wall clock time, 9.5M memory peak.598server # [ 17.514844] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.599server # [ 17.517727] systemd[1]: Stopped Virtual Console Setup.600server # [ 17.575161] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.601server # [ 17.596718] systemd[1]: Finished Load Kernel Module 9pnet_virtio.602server # [ 17.647352] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.603server # [ 17.651147] systemd[1]: Finished rw-sysroot-nix-store.service.604server # [ 17.909985] systemd[1]: systemd-udevd.service: Deactivated successfully.605server # [ 17.913626] systemd[1]: Stopped Rule-based Manager for Device Events and Files.606server # [ 17.917496] systemd[1]: systemd-udevd.service: Consumed 8.832s CPU time over 13.102s wall clock time, 25.4M memory peak.607server # [ 17.919361] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.608server # [ 17.921223] systemd[1]: Closed udev Control Socket.609server # [ 17.935119] systemd[1]: Starting Cleanup udev Database...610server # [ 17.941519] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.611server # [ 17.942515] systemd[1]: Stopped Create Static Device Nodes in /dev.612server # [ 17.943065] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.613server # [ 17.943548] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.614server # [ 17.944161] systemd[1]: kmod-static-nodes.service: Deactivated successfully.615server # [ 17.950008] systemd[1]: Stopped Create List of Static Device Nodes.616server # [ 18.078164] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.617server # [ 18.081899] systemd[1]: Finished Cleanup udev Database.618server # [ 18.087636] systemd[1]: Reached target Switch Root.619server # [ 18.100818] systemd[1]: Starting NixOS Activation...620server # [ 19.741878] initrd-nixos-activation-start[217]: booting system configuration /nix/store/hfxhpbki07sz40832cnfs3kh5v4i27dg-nixos-system-server-test621server # [ 20.262298] initrd-nixos-activation-start[217]: running activation script...622server # [ 24.096574] initrd-nixos-activation-start[240]: setting up /etc...623server # [ 26.467258] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.624server # [ 26.469720] systemd[1]: Finished NixOS Activation.625server # [ 26.471724] systemd[1]: initrd-nixos-activation.service: Consumed 4.378s CPU time over 8.363s wall clock time, 22.6M memory peak.626server # [ 26.487107] systemd[1]: Starting Switch Root...627server # [ 26.614706] systemd[1]: Switching root.628server # [ 26.855518] systemd-journald[81]: Received SIGTERM from PID 1 (systemd).629server: Guest root shell did not produce any data yet...630server: To debug, enter the VM and run 'systemctl status backdoor.service'.631server # [ 29.207873] systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)632server # [ 29.209281] systemd[1]: Detected virtualization qemu.633server # [ 29.209716] systemd[1]: Detected architecture arm64.634server # [ 29.210601] systemd[1]: Detected first boot.635server # [ 29.244876] systemd[1]: Initializing machine ID from random generator.636server # [ 30.552074] systemd[1]: bpf-restrict-fs: LSM BPF program attached637server # [ 31.985592] systemd[1]: Applying preset policy.638server # [ 36.158017] systemd[1]: Populated /etc with preset unit settings.639server # [ 40.853262] systemd[1]: initrd-switch-root.service: Deactivated successfully.640server # [ 40.856162] systemd[1]: Stopped initrd-switch-root.service.641server # [ 40.879633] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.642server # [ 40.897290] systemd[1]: Created slice Slice /system/getty.643server # [ 40.910398] systemd[1]: Created slice User and Session Slice.644server # [ 40.916271] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.645server # [ 40.921860] systemd[1]: Started Forward Password Requests to Wall Directory Watch.646server # [ 40.928210] systemd[1]: Expecting device /dev/hvc0...647server # [ 40.930793] systemd[1]: Expecting device /dev/ttyAMA0...648server # [ 40.934422] systemd[1]: Reached target Local Encrypted Volumes.649server # [ 40.939316] systemd[1]: Stopped target initrd-fs.target.650server # [ 40.942533] systemd[1]: Stopped target initrd-root-fs.target.651server # [ 40.946436] systemd[1]: Stopped target initrd-switch-root.target.652server # [ 40.951759] systemd[1]: Reached target Virtual Machines and Containers.653server # [ 40.955684] systemd[1]: Reached target Path Units.654server # [ 40.958873] systemd[1]: Reached target Remote File Systems.655server # [ 40.963896] systemd[1]: Reached target Slice Units.656server # [ 40.967988] systemd[1]: Reached target Swaps.657server # [ 41.005490] systemd[1]: Listening on Process Core Dump Socket.658server # [ 41.033836] systemd[1]: Listening on Credential Encryption/Decryption.659server # [ 41.075789] systemd[1]: Starting Journal Log Access Socket...660server # [ 41.088266] systemd[1]: Listening on Journal Audit Socket.661server # [ 41.100742] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.662server # [ 41.108036] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki663server # [ 41.115765] systemd[1]: Listening on udev Control Socket.664server # [ 41.153207] systemd[1]: Mounting Huge Pages File System...665server # [ 41.201120] systemd[1]: Mounting POSIX Message Queue File System...666server # [ 41.269350] systemd[1]: Mounting Kernel Debug File System...667server # [ 41.348440] systemd[1]: Mounting Kernel Trace File System...668server # [ 41.468981] systemd[1]: Starting Create List of Static Device Nodes...669server # [ 41.625260] systemd[1]: Starting Load Kernel Module 9pnet_virtio...670server # [ 41.649146] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs671server # [ 41.853152] systemd[1]: Mounting Kernel Configuration File System...672server # [ 41.878080] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm673server # [ 41.909262] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore674server # [ 42.093855] systemd[1]: Starting Load Kernel Module fuse...675server # [ 42.116192] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67676server # [ 42.222025] systemd[1]: Starting Journal Service...677server # [ 42.418172] systemd[1]: Starting Load Kernel Modules...678server # [ 42.572237] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...679server # [ 42.745515] systemd[1]: Starting Remount Root and Kernel File Systems...680server # [ 42.772850] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki681server # [ 43.001029] systemd[1]: Starting Coldplug All udev Devices...682server # [ 43.096077] fuse: init (API version 7.45)683server # [ 43.400344] systemd-journald[311]: Collecting audit messages is enabled.684server # [ 43.517023] systemd[1]: Listening on Journal Log Access Socket.685server # [ 43.537395] systemd[1]: Mounted Huge Pages File System.686server # [ 43.545824] systemd[1]: Mounted POSIX Message Queue File System.687server # [ 43.559413] systemd[1]: Mounted Kernel Debug File System.688server # [ 43.568034] systemd[1]: Mounted Kernel Trace File System.689server # [ 43.585188] systemd[1]: Finished Create List of Static Device Nodes.690server # [ 43.600896] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.691server # [ 43.612902] systemd[1]: Finished Load Kernel Module 9pnet_virtio.692server # [ 43.624333] systemd[1]: Mounted Kernel Configuration File System.693server # [ 43.633191] systemd[1]: modprobe@fuse.service: Deactivated successfully.694server # [ 43.645048] systemd[1]: Finished Load Kernel Module fuse.695server # [ 43.661208] systemd[1]: Finished Load Kernel Modules.696server # [ 43.711727] systemd[1]: Mounting FUSE Control File System...697server # [ 43.775095] systemd[1]: Starting Firewall...698server # [ 43.832649] systemd[1]: Starting Apply Kernel Variables...699server # [ 43.821318] systemd[1]: Queued start job for default target Multi-User System.700server # [ 43.893563] systemd[1]: systemd-journald.service: Deactivated successfully.701server # [ 43.919069] systemd[1]: systemd-journald.service: Consumed 1.185s CPU time over 36.771s wall clock time, 9.8M memory peak.702server # [ 44.018322] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...703server # [ 43.942939] systemd-modules-load[312]: Using 2 probe threads704server # [ 43.962211] systemd-modules-load[312]: Module 'atkbd' is built in705server # [ 43.975107] systemd-modules-load[312]: Module 'loop' is built in706server # [ 44.075839] systemd[1]: Started Journal Service.707server # [ 44.187728] EXT4-fs (vda): re-mounted e05f0d32-00b0-40fc-aba8-c9330282002e.708server # [ 44.305431] systemd[1]: Finished Remount Root and Kernel File Systems.709server # [ 44.582227] systemd-oomd[313]: No swap; memory pressure usage will be degraded710server # [ 44.803433] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.711server # [ 45.181336] systemd[1]: Mounted FUSE Control File System.712server # [ 45.601372] systemd[1]: Starting Flush Journal to Persistent Storage...713server # [ 45.613901] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore714server # [ 45.818084] systemd[1]: Starting Load/Save OS Random Seed...715server # [ 45.834085] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki716server # [ 45.886269] systemd[1]: Finished Apply Kernel Variables.717server # [ 46.206280] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.718server # [ 46.420518] systemd[1]: Starting Create Static Device Nodes in /dev...719server # [ 46.645103] systemd-journald[311]: Received client request to flush runtime journal.720server # [ 47.109626] systemd[1]: Finished Load/Save OS Random Seed.721server # [ 47.118897] systemd[1]: Reached target First Boot Complete.722server # [ 47.153581] systemd[1]: Finished Flush Journal to Persistent Storage.723server # [ 47.659186] systemd[1]: Finished Create Static Device Nodes in /dev.724server # [ 47.717133] systemd[1]: Reached target Preparation for Local File Systems.725server # [ 47.767716] systemd[1]: Mounting /run/wrappers...726server # [ 47.858890] systemd[1]: Starting Rule-based Manager for Device Events and Files...727server # [ 48.404870] systemd[1]: Mounted /run/wrappers.728server # [ 48.453096] systemd[1]: Reached target Local File Systems.729server # [ 48.510240] systemd[1]: Listening on Boot Loader Control Service Socket.730server # [ 48.585327] systemd[1]: Starting register-nix-paths.service...731server # [ 48.714213] systemd[1]: Starting Create SUID/SGID Wrappers...732server # [ 48.737991] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.733server # [ 48.993630] systemd[1]: Starting Save Transient machine-id to Disk...734server # [ 49.286924] systemd[1]: Starting Create System Files and Directories...735server # [ 50.544164] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.736server # [ 50.605575] systemd[1]: Finished Save Transient machine-id to Disk.737server # [ 52.416880] systemd[1]: Finished Create System Files and Directories.738server # [ 52.690515] systemd[1]: Starting Rebuild Journal Catalog...739server # [ 52.881273] systemd[1]: Starting Record System Boot/Shutdown in UTMP...740server # [ 54.468337] systemd[1]: Finished Record System Boot/Shutdown in UTMP.741server # [ 55.415543] systemd[1]: Finished Rebuild Journal Catalog.742server # [ 55.537751] systemd[1]: Starting Update is Completed...743server # [ 56.455118] systemd[1]: Finished Update is Completed.744server: Guest root shell did not produce any data yet...745server: To debug, enter the VM and run 'systemctl status backdoor.service'.746server # [ 62.081750] systemd-udevd[358]: Using default interface naming scheme 'v260'.747server # [ 62.790883] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.748server # [ 62.855118] systemd[1]: Finished Create SUID/SGID Wrappers.749server # [ 62.874134] systemd[1]: suid-sgid-wrappers.service: Consumed 3.529s CPU time over 14.104s wall clock time, 5.3M memory peak.750server # [ 64.219218] systemd[1]: Started Rule-based Manager for Device Events and Files.751server # [ 65.113245] systemd[1]: Finished register-nix-paths.service.752server # [ 66.076249] mousedev: PS/2 mouse device common for all mice753server # [ 66.878075] systemd[1]: Finished Firewall.754server # [ 70.145924] systemd[1]: Finished Coldplug All udev Devices.755server # [ 70.149911] systemd[1]: Reached target System Initialization.756server # [ 70.154710] systemd[1]: Started Discard unused filesystem blocks once a week.757server # [ 70.166762] systemd[1]: Started Daily Cleanup of Temporary Directories.758server # [ 70.173956] systemd[1]: Reached target Timer Units.759server # [ 70.178379] systemd[1]: Listening on D-Bus System Message Bus Socket.760server # [ 70.185706] systemd[1]: Listening on Nix Daemon Socket.761server # [ 70.193523] systemd[1]: Listening on Hostname Service Socket.762server # [ 70.195346] systemd[1]: Reached target Socket Units.763server # [ 70.202886] systemd[1]: Reached target Basic System.764server # [ 70.208790] systemd[1]: Starting Import lastlog data into lastlog2 database...765server # [ 70.266458] systemd[1]: Starting Name Service Cache Daemon (nsncd)...766server # [ 70.341531] systemd[1]: Starting Post-Boot Actions...767server # [ 70.470154] systemd[1]: Started Reset console on configuration changes.768server # [ 70.672885] systemd[1]: Starting resolvconf update...769server # [ 71.522639] nsncd[568]: Oct 27 16:34:29.145 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"770server # [ 71.615958] systemd[1]: Starting D-Bus System Message Bus...771server # [ 71.653577] systemd[1]: Started Name Service Cache Daemon (nsncd).772server # [ 71.702298] systemd[1]: Finished Post-Boot Actions.773server # [ 72.003457] systemd[1]: Finished Import lastlog data into lastlog2 database.774server # [ 72.070454] systemd[1]: Reached target Host and Network Name Lookups.775server # [ 72.076064] systemd[1]: Reached target User and Group Name Lookups.776server # [ 72.253030] systemd[1]: Starting User Login Management...777server # [ 73.552544] dbus-broker-launch[576]: Looking up NSS user entry for 'systemd-timesync'...778server # [ 73.845290] dbus-broker-launch[576]: NSS returned no entry for 'systemd-timesync'779server # [ 73.863858] dbus-broker-launch[576]: Invalid user-name in /nix/store/3h8rckbl9vs21jahmva0fpck4y03w9xg-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"780server # [ 74.255759] systemd-logind[590]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)781server # [ 74.290146] systemd-logind[590]: New seat seat0.782server # [ 74.319491] systemd[1]: Started D-Bus System Message Bus.783server # [ 74.354252] systemd[1]: Started User Login Management.784server # [ 74.425427] systemd[1]: Starting linger-users.service...785server # [ 75.134686] dbus-broker-launch[576]: Ready786server # [ 75.210317] systemd[1]: linger-users.service: Deactivated successfully.787server # [ 75.220784] systemd[1]: Finished linger-users.service.788server # [ 75.422950] systemd[1]: Stopped target Host and Network Name Lookups.789server # [ 75.434666] systemd[1]: Stopping Host and Network Name Lookups...790server # [ 75.446376] systemd[1]: Stopped target User and Group Name Lookups.791server # [ 75.451921] systemd[1]: Stopping User and Group Name Lookups...792server # [ 75.462326] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...793server # [ 75.473369] systemd[1]: nscd.service: Deactivated successfully.794server # [ 75.481505] systemd[1]: Stopped Name Service Cache Daemon (nsncd).795server # [ 75.722487] systemd[1]: Starting Name Service Cache Daemon (nsncd)...796server # [ 76.461830] nsncd[658]: Oct 27 16:34:34.092 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"797server # [ 76.479181] systemd[1]: Started Name Service Cache Daemon (nsncd).798server # [ 76.489219] systemd[1]: Reached target Host and Network Name Lookups.799server # [ 76.497688] systemd[1]: Reached target User and Group Name Lookups.800server # [ 76.733356] systemd[1]: Finished resolvconf update.801server # [ 76.758703] systemd[1]: Reached target Preparation for Network.802server # [ 76.801206] systemd[1]: Starting DHCP Client...803server # [ 76.849903] systemd[1]: Starting Extra networking commands....804server # [ 79.476738] dhcpcd[691]: dhcpcd-10.3.1 starting805server # [ 79.675457] dhcpcd[742]: dev: loaded udev806server # [ 79.753697] dhcpcd[742]: no valid interfaces found807server # [ 79.758459] dhcpcd[742]: no valid interfaces found808server # [ 80.377271] systemd[1]: Finished Extra networking commands..809server # [ 80.392650] systemd[1]: Reached target Network.810server # [ 80.460981] systemd[1]: Starting PostgreSQL Database Server...811server # [ 80.561168] systemd[1]: Starting Permit User Sessions...812server # [ 81.435947] systemd[1]: Finished Permit User Sessions.813server # [ 81.606195] systemd[1]: Started Getty on tty1.814server # [ 81.625820] systemd[1]: Reached target Login Prompts.815server # [ 82.310093] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[786]: Initializing database at /var/lib/postgresql/data816server # [ 84.178364] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: The files belonging to this database system will be owned by user "postgres".817server # [ 84.195388] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: This user must also own the server process.818server # [ 84.268958] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: The database cluster will be initialized with locale "en_US.UTF-8".819server # [ 84.271514] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: The default database encoding has accordingly been set to "UTF8".820server # [ 84.274866] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: The default text search configuration will be set to "english".821server # [ 84.277766] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: Data page checksums are enabled.822server # [ 84.279519] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: fixing permissions on existing directory /var/lib/postgresql/data ... ok823server # [ 84.289232] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: creating subdirectories ... ok824server # [ 84.302890] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: selecting dynamic shared memory implementation ... posix825server # [ 85.463431] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: selecting default max_connections ... 100826server # [ 86.213680] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: selecting default shared_buffers ... 128MB827server: Guest root shell did not produce any data yet...828server: To debug, enter the VM and run 'systemctl status backdoor.service'.829server # [ 97.654920] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: selecting default time zone ... UTC830server # [ 97.691265] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: creating configuration files ... ok831server # [ 101.311484] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: running bootstrap script ... ok832server # [ 109.798921] dhcpcd[742]: timed out833server # [ 109.802193] dhcpcd[742]: timed out834server # [ 109.837817] systemd[1]: Started DHCP Client.835server # [ 111.407994] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: performing post-bootstrap initialization ... ok836server # [ 113.699448] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: syncing data to disk ... ok837server # [ 113.715745] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: initdb: warning: enabling "trust" authentication for local connections838server # [ 113.718881] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: 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.839server # [ 113.723814] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: Success. You can now start the database server using:840server # [ 113.726863] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[787]: /nix/store/8f61g0kn68hhlcd0wj7h40w8h17hfb75-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start841server # [ 115.526053] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[786]: Validating PostgreSQL configuration...842server # [ 115.947138] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[1029]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault843server # [ 116.802990] postgres[1031]: 2026-10-27 16:35:14.455 UTC [1031] LOG: pgaudit extension initialized844server # [ 117.719020] postgres[1031]: 2026-10-27 16:35:15.381 UTC [1031] LOG: pgsodium primary server secret key loaded845server # [ 118.276436] postgres[1031]: 2026-10-27 16:35:15.929 UTC [1031] LOG: vault primary server secret key loaded846server # [ 118.671553] postgres[1031]: 2026-10-27 16:35:16.335 UTC [1031] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.3.0, 64-bit847server # [ 118.689367] postgres[1031]: 2026-10-27 16:35:16.352 UTC [1031] LOG: listening on IPv4 address "0.0.0.0", port 5432848server # [ 118.693144] postgres[1031]: 2026-10-27 16:35:16.357 UTC [1031] LOG: listening on IPv6 address "::", port 5432849server # [ 118.715729] postgres[1031]: 2026-10-27 16:35:16.377 UTC [1031] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"850server # [ 118.827526] postgres[1056]: 2026-10-27 16:35:16.476 UTC [1056] LOG: database system was shut down at 2026-10-27 16:35:08 UTC851server # [ 119.022585] postgres[1059]: 2026-10-27 16:35:16.662 UTC [1059] LOG: TimescaleDB background worker launcher connected to shared catalogs852server # [ 119.030240] postgres[1031]: 2026-10-27 16:35:16.679 UTC [1031] LOG: database system is ready to accept connections853server: Guest root shell did not produce any data yet...854server: To debug, enter the VM and run 'systemctl status backdoor.service'.855server # [ 119.086070] postgres[1060]: 2026-10-27 16:35:16.704 UTC [1060] FATAL: role "postgres" does not exist856server # [ 119.161380] systemd[1]: Started PostgreSQL Database Server.857server # [ 119.210128] postgres[1031]: 2026-10-27 16:35:16.872 UTC [1031] LOG: background worker "pg_net 0.20.4 worker" (PID 1060) exited with exit code 1858server # [ 119.274173] systemd[1]: Starting Supabase Database Initialization...859server # [ 119.315308] postgres[1061]: 2026-10-27 16:35:16.959 UTC [1061] LOG: pg_cron scheduler started860server # [ 119.683322] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Waiting for PostgreSQL to be ready...861server # [ 120.298065] postgres[1072]: 2026-10-27 16:35:17.947 UTC [1072] FATAL: role "postgres" does not exist862server # [ 120.377505] postgres[1067]: ::1 2026-10-27 16:35:17.950 UTC [1067] root@root FATAL: role "root" does not exist863server # [ 120.390149] postgres[1031]: 2026-10-27 16:35:18.026 UTC [1031] LOG: background worker "pg_net 0.20.4 worker" (PID 1072) exited with exit code 1864server # [ 120.405754] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: PostgreSQL is ready865server # [ 120.410041] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Creating postgres role...866server # [ 121.049326] postgres[1080]: ::1 2026-10-27 16:35:18.689 UTC [1080] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN;867server # [ 121.124175] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1075]: CREATE ROLE868server # [ 121.627185] postgres[1093]: ::1 2026-10-27 16:35:19.282 UTC [1093] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres;869server # [ 121.675124] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1086]: ALTER DATABASE870server # [ 121.742562] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql871server # [ 122.021417] postgres[1095]: ::1 2026-10-27 16:35:19.674 UTC [1095] postgres@postgres LOG: statement: create publication supabase_realtime;872server # [ 122.039136] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: CREATE PUBLICATION873server # [ 122.046653] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: ALTER ROLE874server # [ 122.048132] postgres[1095]: ::1 2026-10-27 16:35:19.699 UTC [1095] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls;875server # [ 122.050633] postgres[1095]: ::1 2026-10-27 16:35:19.711 UTC [1095] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication;876server # [ 122.058954] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: CREATE ROLE877server # [ 122.062774] postgres[1095]: ::1 2026-10-27 16:35:19.723 UTC [1095] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls;878server # [ 122.073338] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: CREATE ROLE879server # [ 122.075074] postgres[1095]: ::1 2026-10-27 16:35:19.738 UTC [1095] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin;880server # [ 122.090284] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: GRANT ROLE881server # [ 122.098688] postgres[1095]: ::1 2026-10-27 16:35:19.756 UTC [1095] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin;882server # [ 122.105096] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: GRANT883server # [ 122.112734] postgres[1095]: ::1 2026-10-27 16:35:19.774 UTC [1095] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls;884server # [ 122.121694] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: CREATE ROLE885server # [ 122.132417] postgres[1095]: ::1 2026-10-27 16:35:19.784 UTC [1095] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user;886server # [ 122.140669] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: GRANT ROLE887server # [ 122.145310] postgres[1095]: ::1 2026-10-27 16:35:19.807 UTC [1095] postgres@postgres LOG: statement: create schema if not exists extensions;888server # [ 122.158885] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: CREATE SCHEMA889server # [ 122.163528] postgres[1095]: ::1 2026-10-27 16:35:19.823 UTC [1095] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions;890server # [ 124.998875] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: CREATE EXTENSION891server # [ 125.025429] postgres[1095]: ::1 2026-10-27 16:35:22.653 UTC [1095] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions;892server # [ 125.775051] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: CREATE EXTENSION893server # [ 125.785313] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: CREATE ROLE894server # [ 125.792004] postgres[1095]: ::1 2026-10-27 16:35:23.440 UTC [1095] postgres@postgres LOG: statement: create role anon nologin noinherit;895server # [ 125.798337] postgres[1095]: ::1 2026-10-27 16:35:23.450 UTC [1095] postgres@postgres LOG: statement: create role authenticated nologin noinherit;896server # [ 125.800089] postgres[1095]: ::1 2026-10-27 16:35:23.462 UTC [1095] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls;897server # [ 125.806217] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: CREATE ROLE898server # [ 125.810976] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: CREATE ROLE899server # [ 125.814058] postgres[1095]: ::1 2026-10-27 16:35:23.473 UTC [1095] postgres@postgres LOG: statement: create user authenticator noinherit;900server # [ 125.821670] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: CREATE ROLE901server # [ 125.826670] postgres[1095]: ::1 2026-10-27 16:35:23.487 UTC [1095] postgres@postgres LOG: statement: grant anon to authenticator;902server # [ 125.835281] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: GRANT ROLE903server # [ 125.839011] postgres[1095]: ::1 2026-10-27 16:35:23.500 UTC [1095] postgres@postgres LOG: statement: grant authenticated to authenticator;904server # [ 125.847354] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: GRANT ROLE905server # [ 125.850945] postgres[1095]: ::1 2026-10-27 16:35:23.514 UTC [1095] postgres@postgres LOG: statement: grant service_role to authenticator;906server # [ 125.857583] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: GRANT ROLE907server # [ 125.864447] postgres[1095]: ::1 2026-10-27 16:35:23.522 UTC [1095] postgres@postgres LOG: statement: grant supabase_admin to authenticator;908server # [ 125.871284] postgres[1095]: ::1 2026-10-27 16:35:23.529 UTC [1095] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role;909server # [ 125.880315] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: GRANT ROLE910server # [ 125.885020] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: GRANT911server # [ 125.894882] postgres[1095]: ::1 2026-10-27 16:35:23.540 UTC [1095] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;912server # [ 125.899875] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: ALTER DEFAULT PRIVILEGES913server # [ 125.903062] postgres[1095]: ::1 2026-10-27 16:35:23.564 UTC [1095] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;914server # [ 125.911649] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: ALTER DEFAULT PRIVILEGES915server # [ 125.914369] postgres[1095]: ::1 2026-10-27 16:35:23.576 UTC [1095] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;916server # [ 125.926458] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: ALTER DEFAULT PRIVILEGES917server # [ 125.928121] postgres[1095]: ::1 2026-10-27 16:35:23.590 UTC [1095] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role;918server # [ 125.939904] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: GRANT919server # [ 125.945327] postgres[1095]: ::1 2026-10-27 16:35:23.608 UTC [1095] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions;920server # [ 125.958180] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: ALTER ROLE921server # [ 125.961645] postgres[1095]: ::1 2026-10-27 16:35:23.623 UTC [1095] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all922server # [ 125.966022] postgres[1095]: on sequences to postgres, anon, authenticated, service_role;923server # [ 125.978054] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: ALTER DEFAULT PRIVILEGES924server # [ 125.981869] postgres[1095]: ::1 2026-10-27 16:35:23.642 UTC [1095] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all925server # [ 125.992712] postgres[1095]: on tables to postgres, anon, authenticated, service_role;926server # [ 125.997274] postgres[1095]: ::1 2026-10-27 16:35:23.653 UTC [1095] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all927server # [ 126.005525] postgres[1095]: on functions to postgres, anon, authenticated, service_role;928server # [ 126.026815] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: ALTER DEFAULT PRIVILEGES929server # [ 126.028286] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: ALTER DEFAULT PRIVILEGES930server # [ 126.070405] postgres[1095]: ::1 2026-10-27 16:35:23.667 UTC [1095] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s';931server # [ 126.083916] postgres[1095]: ::1 2026-10-27 16:35:23.680 UTC [1095] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s';932server # [ 126.100962] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: ALTER ROLE933server # [ 126.105668] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: ALTER ROLE934server # [ 126.126447] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql935server # [ 126.549831] postgres[1122]: ::1 2026-10-27 16:35:24.179 UTC [1122] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;936server # [ 126.570172] postgres[1122]: ::1 2026-10-27 16:35:24.213 UTC [1122] postgres@postgres LOG: statement: CREATE TABLE auth.users (937server # [ 126.575085] postgres[1122]: instance_id uuid NULL,938server # [ 126.585064] postgres[1122]: id uuid NOT NULL UNIQUE,939server # [ 126.593157] postgres[1122]: aud varchar(255) NULL,940server # [ 126.594406] postgres[1122]: "role" varchar(255) NULL,941server # [ 126.602026] postgres[1122]: email varchar(255) NULL UNIQUE,942server # [ 126.613233] postgres[1122]: encrypted_password varchar(255) NULL,943server # [ 126.618689] postgres[1122]: confirmed_at timestamptz NULL,944server # [ 126.624144] postgres[1122]: invited_at timestamptz NULL,945server # [ 126.631883] postgres[1122]: confirmation_token varchar(255) NULL,946server # [ 126.645660] postgres[1122]: confirmation_sent_at timestamptz NULL,947server # [ 126.651194] postgres[1122]: recovery_token varchar(255) NULL,948server # [ 126.653433] postgres[1122]: recovery_sent_at timestamptz NULL,949server # [ 126.658400] postgres[1122]: email_change_token varchar(255) NULL,950server # [ 126.667165] postgres[1122]: email_change varchar(255) NULL,951server # [ 126.669257] postgres[1122]: email_change_sent_at timestamptz NULL,952server # [ 126.670624] postgres[1122]: last_sign_in_at timestamptz NULL,953server # [ 126.671553] postgres[1122]: raw_app_meta_data jsonb NULL,954server # [ 126.677732] postgres[1122]: raw_user_meta_data jsonb NULL,955server # [ 126.679004] postgres[1122]: is_super_admin bool NULL,956server # [ 126.685300] postgres[1122]: created_at timestamptz NULL,957server # [ 126.690002] postgres[1122]: updated_at timestamptz NULL,958server # [ 126.694927] postgres[1122]: CONSTRAINT users_pkey PRIMARY KEY (id)959server # [ 126.701461] postgres[1122]: );960server # [ 126.706713] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE SCHEMA961server # [ 126.851782] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE TABLE962server # [ 126.859825] postgres[1122]: ::1 2026-10-27 16:35:24.521 UTC [1122] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);963server # [ 126.926321] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE INDEX964server # [ 126.936785] postgres[1122]: ::1 2026-10-27 16:35:24.597 UTC [1122] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);965server # [ 126.980236] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE INDEX966server # [ 126.994018] postgres[1122]: ::1 2026-10-27 16:35:24.653 UTC [1122] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';967server # [ 127.014720] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: COMMENT968server # [ 127.037341] postgres[1122]: ::1 2026-10-27 16:35:24.674 UTC [1122] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens (969server # [ 127.045688] postgres[1122]: instance_id uuid NULL,970server # [ 127.047548] postgres[1122]: id bigserial NOT NULL,971server # [ 127.058640] postgres[1122]: "token" varchar(255) NULL,972server # [ 127.065661] postgres[1122]: user_id varchar(255) NULL,973server # [ 127.077215] postgres[1122]: revoked bool NULL,974server # [ 127.085793] postgres[1122]: created_at timestamptz NULL,975server # [ 127.093968] postgres[1122]: updated_at timestamptz NULL,976server # [ 127.102183] postgres[1122]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)977server # [ 127.109986] postgres[1122]: );978server # [ 127.241617] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE TABLE979server # [ 127.243055] postgres[1122]: ::1 2026-10-27 16:35:24.905 UTC [1122] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);980server # [ 127.303005] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE INDEX981server # [ 127.310306] postgres[1122]: ::1 2026-10-27 16:35:24.974 UTC [1122] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id);982server # [ 127.353909] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE INDEX983server # [ 127.366972] postgres[1122]: ::1 2026-10-27 16:35:25.015 UTC [1122] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);984server # [ 127.403039] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE INDEX985server # [ 127.406927] postgres[1122]: ::1 2026-10-27 16:35:25.061 UTC [1122] postgres@postgres LOG: statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.';986server # [ 127.415899] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: COMMENT987server # [ 127.426461] postgres[1122]: ::1 2026-10-27 16:35:25.084 UTC [1122] postgres@postgres LOG: statement: CREATE TABLE auth.instances (988server # [ 127.427876] postgres[1122]: id uuid NOT NULL,989server # [ 127.433627] postgres[1122]: uuid uuid NULL,990server # [ 127.435329] postgres[1122]: raw_base_config text NULL,991server # [ 127.441797] postgres[1122]: created_at timestamptz NULL,992server # [ 127.442960] postgres[1122]: updated_at timestamptz NULL,993server # [ 127.447693] postgres[1122]: CONSTRAINT instances_pkey PRIMARY KEY (id)994server # [ 127.450129] postgres[1122]: );995server # [ 127.503390] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE TABLE996server # [ 127.505253] postgres[1122]: ::1 2026-10-27 16:35:25.163 UTC [1122] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';997server # [ 127.517704] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: COMMENT998server # [ 127.518995] postgres[1122]: ::1 2026-10-27 16:35:25.175 UTC [1122] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries (999server # [ 127.520391] postgres[1122]: instance_id uuid NULL,1000server # [ 127.537948] postgres[1122]: id uuid NOT NULL,1001server # [ 127.539133] postgres[1122]: payload json NULL,1002server # [ 127.541679] postgres[1122]: created_at timestamptz NULL,1003server # [ 127.544561] postgres[1122]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)1004server # [ 127.546376] postgres[1122]: );1005server # [ 127.582903] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE TABLE1006server # [ 127.588709] postgres[1122]: ::1 2026-10-27 16:35:25.252 UTC [1122] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);1007server # [ 127.629157] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE INDEX1008server # [ 127.630919] postgres[1122]: ::1 2026-10-27 16:35:25.291 UTC [1122] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';1009server # [ 127.645448] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: COMMENT1010server # [ 127.648028] postgres[1122]: ::1 2026-10-27 16:35:25.305 UTC [1122] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations (1011server # [ 127.649717] postgres[1122]: "version" varchar(255) NOT NULL,1012server # [ 127.653323] postgres[1122]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")1013server # [ 127.657495] postgres[1122]: );1014server # [ 127.693272] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE TABLE1015server # [ 127.696958] postgres[1122]: ::1 2026-10-27 16:35:25.360 UTC [1122] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';1016server # [ 127.718933] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: COMMENT1017server # [ 127.740911] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: INSERT 0 71018server # [ 127.745662] postgres[1122]: ::1 2026-10-27 16:35:25.407 UTC [1122] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$1019server # [ 127.749742] postgres[1122]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;1020server # [ 127.754356] postgres[1122]: $$ language sql stable;1021server # [ 127.762285] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE FUNCTION1022server # [ 127.769850] postgres[1122]: ::1 2026-10-27 16:35:25.430 UTC [1122] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$1023server # [ 127.774046] postgres[1122]: select nullif(current_setting('request.jwt.claim.role', true), '')::text;1024server # [ 127.781498] postgres[1122]: $$ language sql stable;1025server # [ 127.783842] postgres[1122]: ::1 2026-10-27 16:35:25.442 UTC [1122] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$1026server # [ 127.789372] postgres[1122]: select nullif(current_setting('request.jwt.claim.email', true), '')::text;1027server # [ 127.794075] postgres[1122]: $$ language sql stable;1028server # [ 127.797223] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE FUNCTION1029server # [ 127.803093] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE FUNCTION1030server # [ 127.809635] postgres[1122]: ::1 2026-10-27 16:35:25.459 UTC [1122] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;1031server # [ 127.814989] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: GRANT1032server # [ 127.820012] postgres[1122]: ::1 2026-10-27 16:35:25.483 UTC [1122] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1033server # [ 127.829373] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: CREATE ROLE1034server # [ 127.830757] postgres[1122]: ::1 2026-10-27 16:35:25.493 UTC [1122] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1035server # [ 127.838013] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: GRANT1036server # [ 127.839557] postgres[1122]: ::1 2026-10-27 16:35:25.502 UTC [1122] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1037server # [ 127.853347] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: GRANT1038server # [ 127.854737] postgres[1122]: ::1 2026-10-27 16:35:25.516 UTC [1122] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1039server # [ 127.860441] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: GRANT1040server # [ 127.867273] postgres[1122]: ::1 2026-10-27 16:35:25.527 UTC [1122] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth";1041server # [ 127.872039] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: ALTER ROLE1042server # [ 127.879709] postgres[1122]: ::1 2026-10-27 16:35:25.537 UTC [1122] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin;1043server # [ 127.890108] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: ALTER TABLE1044server # [ 127.895945] postgres[1122]: ::1 2026-10-27 16:35:25.557 UTC [1122] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;1045server # [ 127.905619] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: ALTER TABLE1046server # [ 127.907026] postgres[1122]: ::1 2026-10-27 16:35:25.570 UTC [1122] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;1047server # [ 127.921346] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: ALTER TABLE1048server # [ 127.922832] postgres[1122]: ::1 2026-10-27 16:35:25.582 UTC [1122] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;1049server # [ 127.933349] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: ALTER TABLE1050server # [ 127.937412] postgres[1122]: ::1 2026-10-27 16:35:25.599 UTC [1122] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;1051server # [ 127.948655] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1116]: ALTER TABLE1052server # [ 128.007723] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql1053server # [ 128.263404] postgres[1139]: ::1 2026-10-27 16:35:25.922 UTC [1139] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;1054server # [ 128.275430] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1138]: CREATE SCHEMA1055server # [ 128.279956] postgres[1139]: ::1 2026-10-27 16:35:25.936 UTC [1139] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1056server # [ 128.285941] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1138]: CREATE ROLE1057server # [ 128.289432] postgres[1139]: ::1 2026-10-27 16:35:25.953 UTC [1139] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage";1058server # [ 128.297779] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1138]: ALTER ROLE1059server # [ 128.301165] postgres[1139]: ::1 2026-10-27 16:35:25.961 UTC [1139] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;1060server # [ 128.312872] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1138]: GRANT1061server # [ 128.346831] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1138]: DO1062server # [ 128.397033] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql1063server # [ 128.640498] postgres[1141]: ::1 2026-10-27 16:35:26.295 UTC [1141] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;1064server # [ 128.651781] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: ALTER ROLE1065server # [ 128.657563] postgres[1141]: ::1 2026-10-27 16:35:26.317 UTC [1141] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;1066server # [ 128.665310] postgres[1141]: ::1 2026-10-27 16:35:26.327 UTC [1141] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()1067server # [ 128.668992] postgres[1141]: RETURNS event_trigger1068server # [ 128.673149] postgres[1141]: LANGUAGE plpgsql1069server # [ 128.677508] postgres[1141]: AS $$1070server # [ 128.680866] postgres[1141]: DECLARE1071server # [ 128.684277] postgres[1141]: schema_is_cron bool;1072server # [ 128.689601] postgres[1141]: BEGIN1073server # [ 128.690637] postgres[1141]: schema_is_cron = (1074server # [ 128.691182] postgres[1141]: SELECT n.nspname = 'cron'1075server # [ 128.691990] postgres[1141]: FROM pg_event_trigger_ddl_commands() AS ev1076server # [ 128.699038] postgres[1141]: LEFT JOIN pg_catalog.pg_namespace AS n1077server # [ 128.702070] postgres[1141]: ON ev.objid = n.oid1078server # [ 128.705448] postgres[1141]: );1079server # [ 128.706538] postgres[1141]:1080server # [ 128.707886] postgres[1141]: IF schema_is_cron1081server # [ 128.710104] postgres[1141]: THEN1082server # [ 128.711554] postgres[1141]: grant usage on schema cron to postgres with grant option;1083server # [ 128.716152] postgres[1141]:1084server # [ 128.717822] postgres[1141]: alter default privileges in schema cron grant all on tables to postgres with grant option;1085server # [ 128.718795] postgres[1141]: alter default privileges in schema cron grant all on functions to postgres with grant option;1086server # [ 128.722198] postgres[1141]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1087server # [ 128.723529] postgres[1141]:1088server # [ 128.726221] postgres[1141]: alter default privileges for user supabase_admin in schema cron grant all1089server # [ 128.731974] postgres[1141]: on sequences to postgres with grant option;1090server # [ 128.737878] postgres[1141]: alter default privileges for user supabase_admin in schema cron grant all1091server # [ 128.741710] postgres[1141]: on tables to postgres with grant option;1092server # [ 128.745741] postgres[1141]: alter default privileges for user supabase_admin in schema cron grant all1093server # [ 128.753616] postgres[1141]: on functions to postgres with grant option;1094server # [ 128.754976] postgres[1141]:1095server # [ 128.761133] postgres[1141]: grant all privileges on all tables in schema cron to postgres with grant option;1096server # [ 128.766869] postgres[1141]:1097server # [ 128.770658] postgres[1141]: END IF;1098server # [ 128.773062] postgres[1141]:1099server # [ 128.777835] postgres[1141]: END;1100server # [ 128.780513] postgres[1141]: $$;1101server # [ 128.781710] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: ALTER ROLE1102server # [ 128.782952] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: CREATE FUNCTION1103server # [ 128.784124] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: CREATE EVENT TRIGGER1104server # [ 128.787109] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: COMMENT1105server # [ 128.789532] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: CREATE FUNCTION1106server # [ 128.790643] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: COMMENT1107server # [ 128.793166] postgres[1141]: ::1 2026-10-27 16:35:26.353 UTC [1141] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')1108server # [ 128.795466] postgres[1141]: EXECUTE PROCEDURE extensions.grant_pg_cron_access();1109server # [ 128.796739] postgres[1141]: ::1 2026-10-27 16:35:26.369 UTC [1141] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';1110server # [ 128.801192] postgres[1141]: ::1 2026-10-27 16:35:26.386 UTC [1141] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()1111server # [ 128.803147] postgres[1141]: RETURNS event_trigger1112server # [ 128.805759] postgres[1141]: LANGUAGE plpgsql1113server # [ 128.807719] postgres[1141]: AS $$1114server # [ 128.810601] postgres[1141]: BEGIN1115server # [ 128.811878] postgres[1141]: IF EXISTS (1116server # [ 128.814205] postgres[1141]: SELECT 11117server # [ 128.817310] postgres[1141]: FROM pg_event_trigger_ddl_commands() AS ev1118server # [ 128.818839] postgres[1141]: JOIN pg_extension AS ext1119server # [ 128.822441] postgres[1141]: ON ev.objid = ext.oid1120server # [ 128.824235] postgres[1141]: WHERE ext.extname = 'pg_net'1121server # [ 128.830263] postgres[1141]: )1122server # [ 128.833130] postgres[1141]: THEN1123server # [ 128.834470] postgres[1141]: IF NOT EXISTS (1124server # [ 128.835984] postgres[1141]: SELECT 11125server # [ 128.839415] postgres[1141]: FROM pg_roles1126server # [ 128.841686] postgres[1141]: WHERE rolname = 'supabase_functions_admin'1127server # [ 128.842789] postgres[1141]: )1128server # [ 128.844461] postgres[1141]: THEN1129server # [ 128.845996] postgres[1141]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1130server # [ 128.847269] postgres[1141]: END IF;1131server # [ 128.848763] postgres[1141]:1132server # [ 128.850518] postgres[1141]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;1133server # [ 128.854501] postgres[1141]:1134server # [ 128.856129] postgres[1141]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1135server # [ 128.859347] postgres[1141]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1136server # [ 128.863279] postgres[1141]:1137server # [ 128.865556] postgres[1141]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1138server # [ 128.867966] postgres[1141]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1139server # [ 128.871073] postgres[1141]:1140server # [ 128.872632] postgres[1141]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1141server # [ 128.874458] postgres[1141]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1142server # [ 128.875411] postgres[1141]:1143server # [ 128.877976] postgres[1141]: 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;1144server # [ 128.882439] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: DO1145server # [ 128.884982] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: CREATE ROLE1146server # [ 128.887157] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: GRANT1147server # [ 128.890238] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: GRANT1148server # [ 128.892789] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: GRANT1149server # [ 128.894735] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: GRANT1150server # [ 128.896858] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: GRANT1151server # [ 128.898543] postgres[1141]: 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;1152server # [ 128.900346] postgres[1141]: END IF;1153server # [ 128.902566] postgres[1141]: END;1154server # [ 128.903276] postgres[1141]: $$;1155server # [ 128.904904] postgres[1141]: ::1 2026-10-27 16:35:26.399 UTC [1141] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';1156server # [ 128.906841] postgres[1141]: ::1 2026-10-27 16:35:26.450 UTC [1141] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;1157server # [ 128.910378] postgres[1141]: ::1 2026-10-27 16:35:26.460 UTC [1141] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user;1158server # [ 128.911932] postgres[1141]: ::1 2026-10-27 16:35:26.481 UTC [1141] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user;1159server # [ 128.915082] postgres[1141]: ::1 2026-10-27 16:35:26.490 UTC [1141] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;1160server # [ 128.917837] postgres[1141]: ::1 2026-10-27 16:35:26.499 UTC [1141] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;1161server # [ 128.919378] postgres[1141]: ::1 2026-10-27 16:35:26.526 UTC [1141] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;1162server # [ 128.921844] postgres[1141]: ::1 2026-10-27 16:35:26.537 UTC [1141] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;1163server # [ 128.923379] postgres[1141]: ::1 2026-10-27 16:35:26.554 UTC [1141] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;1164server # [ 128.926038] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: GRANT1165server # [ 128.927127] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: GRANT1166server # [ 128.928180] postgres[1141]: ::1 2026-10-27 16:35:26.564 UTC [1141] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;1167server # [ 128.940923] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: GRANT1168server # [ 128.949656] postgres[1141]: ::1 2026-10-27 16:35:26.607 UTC [1141] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;1169server # [ 128.987037] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: GRANT1170server # [ 129.003199] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1140]: DO1171server # [ 129.071387] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running pgbouncer auth schema...1172server # [ 129.478096] postgres[1147]: ::1 2026-10-27 16:35:27.106 UTC [1147] postgres@postgres LOG: statement: CREATE USER pgbouncer;1173server # [ 129.516494] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1142]: CREATE ROLE1174server # [ 129.521739] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1142]: REVOKE1175server # [ 129.523296] postgres[1147]: ::1 2026-10-27 16:35:27.158 UTC [1147] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;1176server # [ 129.528718] postgres[1147]: ::1 2026-10-27 16:35:27.185 UTC [1147] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;1177server # [ 129.597300] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1142]: CREATE SCHEMA1178server # [ 129.609058] postgres[1147]: ::1 2026-10-27 16:35:27.262 UTC [1147] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)1179server # [ 129.623062] postgres[1147]: RETURNS TABLE(username TEXT, password TEXT) AS1180server # [ 129.627229] postgres[1147]: $$1181server # [ 129.633392] postgres[1147]: BEGIN1182server # [ 129.641891] postgres[1147]: RAISE WARNING 'PgBouncer auth request: %', p_usename;1183server # [ 129.644167] postgres[1147]:1184server # [ 129.649194] postgres[1147]: RETURN QUERY1185server # [ 129.651269] postgres[1147]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow1186server # [ 129.657953] postgres[1147]: WHERE usename = p_usename;1187server # [ 129.659185] postgres[1147]: END;1188server # [ 129.661059] postgres[1147]: $$ LANGUAGE plpgsql1189server # [ 129.665749] postgres[1147]: SET search_path = ''1190server # [ 129.673322] postgres[1147]: SECURITY DEFINER;1191server # [ 129.675911] postgres[1147]: ::1 2026-10-27 16:35:27.309 UTC [1147] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;1192server # [ 129.681404] postgres[1147]: ::1 2026-10-27 16:35:27.321 UTC [1147] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;1193server # [ 129.686301] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1142]: CREATE FUNCTION1194server # [ 129.698750] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1142]: REVOKE1195server # [ 129.701200] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1142]: GRANT1196server # [ 129.733676] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running stat extension...1197server # [ 130.171906] postgres[1160]: ::1 2026-10-27 16:35:27.799 UTC [1160] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions;1198server # [ 130.201856] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping1199server # [ 130.229978] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: CREATE SCHEMA1200server # [ 130.244875] postgres[1160]: ::1 2026-10-27 16:35:27.901 UTC [1160] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;1201server # [ 131.275968] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1156]: CREATE EXTENSION1202server # [ 131.364596] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql1203server # [ 131.604007] postgres[1167]: ::1 2026-10-27 16:35:29.262 UTC [1167] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres;1204server # [ 131.617503] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1166]: GRANT1205server # [ 131.619946] postgres[1167]: ::1 2026-10-27 16:35:29.278 UTC [1167] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres;1206server # [ 131.628600] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1166]: GRANT1207server # [ 131.633099] postgres[1167]: ::1 2026-10-27 16:35:29.296 UTC [1167] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres;1208server # [ 131.641990] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1166]: GRANT1209server # [ 131.644975] postgres[1167]: ::1 2026-10-27 16:35:29.308 UTC [1167] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;1210server # [ 131.657963] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1166]: GRANT1211server # [ 131.665367] postgres[1167]: ::1 2026-10-27 16:35:29.325 UTC [1167] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;1212server # [ 131.673239] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1166]: GRANT1213server # [ 131.679097] postgres[1167]: ::1 2026-10-27 16:35:29.339 UTC [1167] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;1214server # [ 131.685805] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1166]: GRANT1215server # [ 131.691354] postgres[1167]: ::1 2026-10-27 16:35:29.352 UTC [1167] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;1216server # [ 131.698412] postgres[1167]: ::1 2026-10-27 16:35:29.359 UTC [1167] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;1217server # [ 131.700164] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1166]: GRANT1218server # [ 131.710181] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1166]: GRANT1219server # [ 131.713040] postgres[1167]: ::1 2026-10-27 16:35:29.375 UTC [1167] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;1220server # [ 131.740755] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1166]: GRANT1221server # [ 131.771682] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1166]: DO1222server # [ 131.778550] postgres[1167]: ::1 2026-10-27 16:35:29.439 UTC [1167] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;1223server # [ 131.789614] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1166]: ALTER ROLE1224server # [ 131.836742] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql1225server # [ 132.130186] postgres[1169]: ::1 2026-10-27 16:35:29.778 UTC [1169] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1226server # [ 132.157267] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: GRANT1227server # [ 132.160795] postgres[1169]: ::1 2026-10-27 16:35:29.809 UTC [1169] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1228server # [ 132.179095] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: GRANT1229server # [ 132.186401] postgres[1169]: ::1 2026-10-27 16:35:29.845 UTC [1169] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1230server # [ 132.195060] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: GRANT1231server # [ 132.202204] postgres[1169]: ::1 2026-10-27 16:35:29.859 UTC [1169] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;1232server # [ 132.205357] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: ALTER TABLE1233server # [ 132.206803] postgres[1169]: ::1 2026-10-27 16:35:29.869 UTC [1169] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;1234server # [ 132.219684] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: ALTER TABLE1235server # [ 132.223492] postgres[1169]: ::1 2026-10-27 16:35:29.884 UTC [1169] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;1236server # [ 132.227795] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: ALTER TABLE1237server # [ 132.234488] postgres[1169]: ::1 2026-10-27 16:35:29.897 UTC [1169] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;1238server # [ 132.245045] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: ALTER TABLE1239server # [ 132.248996] postgres[1169]: ::1 2026-10-27 16:35:29.908 UTC [1169] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;1240server # [ 132.257412] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: ALTER TABLE1241server # [ 132.263202] postgres[1169]: ::1 2026-10-27 16:35:29.925 UTC [1169] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres;1242server # [ 132.273222] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: GRANT1243server # [ 132.277476] postgres[1169]: ::1 2026-10-27 16:35:29.938 UTC [1169] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;1244server # [ 132.293029] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: GRANT1245server # [ 132.304822] postgres[1169]: ::1 2026-10-27 16:35:29.963 UTC [1169] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;1246server # [ 132.313333] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: GRANT1247server # [ 132.314645] postgres[1169]: ::1 2026-10-27 16:35:29.977 UTC [1169] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;1248server # [ 132.330704] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: GRANT1249server # [ 132.335522] postgres[1169]: ::1 2026-10-27 16:35:29.995 UTC [1169] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user;1250server # [ 132.357174] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: ALTER DEFAULT PRIVILEGES1251server # [ 132.366143] postgres[1169]: ::1 2026-10-27 16:35:30.026 UTC [1169] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1252server # [ 132.406904] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: ALTER DEFAULT PRIVILEGES1253server # [ 132.415161] postgres[1169]: ::1 2026-10-27 16:35:30.066 UTC [1169] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user;1254server # [ 132.422756] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1168]: ALTER DEFAULT PRIVILEGES1255server # [ 132.493064] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql1256server # [ 133.036619] postgres[1183]: ::1 2026-10-27 16:35:30.678 UTC [1183] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime;1257server # [ 133.098060] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1179]: CREATE SCHEMA1258server # [ 133.121151] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql1259server # [ 133.599029] postgres[1193]: ::1 2026-10-27 16:35:31.255 UTC [1193] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres;1260server # [ 133.622468] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1189]: GRANT1261server # [ 133.625344] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1189]: GRANT1262server # [ 133.629502] postgres[1193]: ::1 2026-10-27 16:35:31.283 UTC [1193] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;1263server # [ 133.633729] postgres[1193]: ::1 2026-10-27 16:35:31.289 UTC [1193] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;1264server # [ 133.637689] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1189]: GRANT1265server # [ 133.641383] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1189]: GRANT1266server # [ 133.648572] postgres[1193]: ::1 2026-10-27 16:35:31.293 UTC [1193] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;1267server # [ 133.705957] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql1268server # [ 133.994906] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1194]: DO1269server # [ 134.009159] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1194]: DO1270server # [ 134.021247] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1194]: DO1271server # [ 134.054706] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql1272server # [ 134.354982] postgres[1197]: ::1 2026-10-27 16:35:32.014 UTC [1197] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user;1273server # [ 134.382393] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1196]: ALTER DEFAULT PRIVILEGES1274server # [ 134.385505] postgres[1197]: ::1 2026-10-27 16:35:32.041 UTC [1197] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1275server # [ 134.393159] postgres[1197]: ::1 2026-10-27 16:35:32.055 UTC [1197] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user;1276server # [ 134.401882] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1196]: ALTER DEFAULT PRIVILEGES1277server # [ 134.406466] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1196]: ALTER DEFAULT PRIVILEGES1278server # [ 134.435210] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql1279server # [ 134.711763] postgres[1199]: ::1 2026-10-27 16:35:32.350 UTC [1199] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';1280server # [ 134.727359] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1198]: ALTER ROLE1281server # [ 134.754282] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql1282server # [ 135.038663] postgres[1201]: ::1 2026-10-27 16:35:32.686 UTC [1201] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1283server # [ 135.053605] postgres[1201]: ::1 2026-10-27 16:35:32.705 UTC [1201] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1284server # [ 135.059236] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1285server # [ 135.061189] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: DROP EVENT TRIGGER1286server # [ 135.063409] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1287server # [ 135.066772] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: DROP FUNCTION1288server # [ 135.070462] postgres[1201]: ::1 2026-10-27 16:35:32.721 UTC [1201] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1289server # [ 135.073588] postgres[1201]: DECLARE1290server # [ 135.074846] postgres[1201]: cmd record;1291server # [ 135.075701] postgres[1201]: BEGIN1292server # [ 135.077539] postgres[1201]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1293server # [ 135.081125] postgres[1201]: LOOP1294server # [ 135.082689] postgres[1201]: IF cmd.command_tag IN (1295server # [ 135.085800] postgres[1201]: 'CREATE SCHEMA', 'ALTER SCHEMA'1296server # [ 135.089207] postgres[1201]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1297server # [ 135.091788] postgres[1201]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1298server # [ 135.095348] postgres[1201]: , 'CREATE VIEW', 'ALTER VIEW'1299server # [ 135.097859] postgres[1201]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1300server # [ 135.101843] postgres[1201]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1301server # [ 135.104528] postgres[1201]: , 'CREATE TRIGGER'1302server # [ 135.106262] postgres[1201]: , 'CREATE TYPE'1303server # [ 135.109943] postgres[1201]: , 'CREATE RULE'1304server # [ 135.112218] postgres[1201]: , 'COMMENT'1305server # [ 135.114335] postgres[1201]: )1306server # [ 135.115465] postgres[1201]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1307server # [ 135.120276] postgres[1201]: AND cmd.schema_name is distinct from 'pg_temp'1308server # [ 135.122446] postgres[1201]: THEN1309server # [ 135.124041] postgres[1201]: NOTIFY pgrst, 'reload schema';1310server # [ 135.126511] postgres[1201]: END IF;1311server # [ 135.127250] postgres[1201]: END LOOP;1312server # [ 135.130424] postgres[1201]: END; $$ LANGUAGE plpgsql;1313server # [ 135.133871] postgres[1201]: ::1 2026-10-27 16:35:32.755 UTC [1201] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1314server # [ 135.139544] postgres[1201]: DECLARE1315server # [ 135.141974] postgres[1201]: obj record;1316server # [ 135.144042] postgres[1201]: BEGIN1317server # [ 135.147372] postgres[1201]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1318server # [ 135.148761] postgres[1201]: LOOP1319server # [ 135.154151] postgres[1201]: IF obj.object_type IN (1320server # [ 135.155331] postgres[1201]: 'schema'1321server # [ 135.157079] postgres[1201]: , 'table'1322server # [ 135.160659] postgres[1201]: , 'foreign table'1323server # [ 135.162168] postgres[1201]: , 'view'1324server # [ 135.163962] postgres[1201]: , 'materialized view'1325server # [ 135.165899] postgres[1201]: , 'function'1326server # [ 135.167547] postgres[1201]: , 'trigger'1327server # [ 135.170749] postgres[1201]: , 'type'1328server # [ 135.172163] postgres[1201]: , 'rule'1329server # [ 135.182159] postgres[1201]: )1330server # [ 135.190205] postgres[1201]: AND obj.is_temporary IS false -- no pg_temp objects1331server # [ 135.198945] postgres[1201]: THEN1332server # [ 135.204492] postgres[1201]: NOTIFY pgrst, 'reload schema';1333server # [ 135.217739] postgres[1201]: END IF;1334server # [ 135.225779] postgres[1201]: END LOOP;1335server # [ 135.229940] postgres[1201]: END; $$ LANGUAGE plpgsql;1336server # [ 135.237918] postgres[1201]: ::1 2026-10-27 16:35:32.775 UTC [1201] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1337server # [ 135.247350] postgres[1201]: ::1 2026-10-27 16:35:32.783 UTC [1201] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1338server # [ 135.257843] postgres[1201]: ON ddl_command_end1339server # [ 135.262560] postgres[1201]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1340server # [ 135.263993] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: CREATE FUNCTION1341server # [ 135.267514] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: CREATE FUNCTION1342server # [ 135.272079] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping1343server # [ 135.286484] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: DROP EVENT TRIGGER1344server # [ 135.293470] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: CREATE EVENT TRIGGER1345server # [ 135.295696] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping1346server # [ 135.307344] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: DROP EVENT TRIGGER1347server # [ 135.309728] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1200]: CREATE EVENT TRIGGER1348server # [ 135.315544] postgres[1201]: ::1 2026-10-27 16:35:32.806 UTC [1201] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1349server # [ 135.329331] postgres[1201]: ::1 2026-10-27 16:35:32.818 UTC [1201] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1350server # [ 135.333607] postgres[1201]: ON sql_drop1351server # [ 135.341096] postgres[1201]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1352server # [ 135.346137] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql1353server # [ 136.402891] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1202]: DO1354server # [ 136.451544] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql1355server # [ 136.826212] postgres[1225]: ::1 2026-10-27 16:35:34.470 UTC [1225] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public;1356server # [ 136.873947] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: CREATE SCHEMA1357server # [ 136.881910] postgres[1225]: ::1 2026-10-27 16:35:34.534 UTC [1225] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb);1358server # [ 136.895802] postgres[1225]: ::1 2026-10-27 16:35:34.551 UTC [1225] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1359server # [ 136.905389] postgres[1225]: "operationName" text default null,1360server # [ 136.907907] postgres[1225]: query text default null,1361server # [ 136.910005] postgres[1225]: variables jsonb default null,1362server # [ 136.913838] postgres[1225]: extensions jsonb default null1363server # [ 136.918116] postgres[1225]: )1364server # [ 136.919351] postgres[1225]: returns jsonb1365server # [ 136.924021] postgres[1225]: language plpgsql1366server # [ 136.928387] postgres[1225]: as $$1367server # [ 136.930689] postgres[1225]: DECLARE1368server # [ 136.932688] postgres[1225]: server_version float;1369server # [ 136.933789] postgres[1225]: BEGIN1370server # [ 136.935540] postgres[1225]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1371server # [ 136.938494] postgres[1225]:1372server # [ 136.942459] postgres[1225]: IF server_version >= 14 THEN1373server # [ 136.943808] postgres[1225]: RETURN jsonb_build_object(1374server # [ 136.945546] postgres[1225]: 'data', null::jsonb,1375server # [ 136.947235] postgres[1225]: 'errors', array['pg_graphql extension is not enabled.']1376server # [ 136.950347] postgres[1225]: );1377server # [ 136.952026] postgres[1225]: ELSE1378server # [ 136.955894] postgres[1225]: RETURN jsonb_build_object(1379server # [ 136.957745] postgres[1225]: 'data', null::jsonb,1380server # [ 136.959172] postgres[1225]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1381server # [ 136.961678] postgres[1225]: );1382server # [ 136.962688] postgres[1225]: END IF;1383server # [ 136.963805] postgres[1225]: END;1384server # [ 136.966450] postgres[1225]: $$;1385server # [ 136.968452] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping1386server # [ 136.970795] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: DROP FUNCTION1387server # [ 136.973316] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: CREATE FUNCTION1388server # [ 136.978081] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: GRANT1389server # [ 136.981171] postgres[1225]: ::1 2026-10-27 16:35:34.595 UTC [1225] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;1390server # [ 136.985759] postgres[1225]: ::1 2026-10-27 16:35:34.625 UTC [1225] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;1391server # [ 136.987926] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: ALTER DEFAULT PRIVILEGES1392server # [ 136.994130] postgres[1225]: ::1 2026-10-27 16:35:34.649 UTC [1225] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;1393server # [ 136.997305] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: ALTER DEFAULT PRIVILEGES1394server # [ 136.999422] postgres[1225]: ::1 2026-10-27 16:35:34.662 UTC [1225] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;1395server # [ 137.010894] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: ALTER DEFAULT PRIVILEGES1396server # [ 137.014314] postgres[1225]: ::1 2026-10-27 16:35:34.677 UTC [1225] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1397server # [ 137.017876] postgres[1225]: on sequences to postgres, anon, authenticated, service_role;1398server # [ 137.027434] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: ALTER DEFAULT PRIVILEGES1399server # [ 137.032232] postgres[1225]: ::1 2026-10-27 16:35:34.694 UTC [1225] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1400server # [ 137.039382] postgres[1225]: on tables to postgres, anon, authenticated, service_role;1401server # [ 137.044061] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: ALTER DEFAULT PRIVILEGES1402server # [ 137.046513] postgres[1225]: ::1 2026-10-27 16:35:34.708 UTC [1225] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1403server # [ 137.049372] postgres[1225]: on functions to postgres, anon, authenticated, service_role;1404server # [ 137.063999] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: ALTER DEFAULT PRIVILEGES1405server # [ 137.066830] postgres[1225]: ::1 2026-10-27 16:35:34.729 UTC [1225] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()1406server # [ 137.069357] postgres[1225]: RETURNS event_trigger1407server # [ 137.073153] postgres[1225]: LANGUAGE plpgsql1408server # [ 137.078091] postgres[1225]: AS $func$1409server # [ 137.080163] postgres[1225]: DECLARE1410server # [ 137.087988] postgres[1225]: func_is_graphql_resolve bool;1411server # [ 137.093957] postgres[1225]: BEGIN1412server # [ 137.096756] postgres[1225]: func_is_graphql_resolve = (1413server # [ 137.099715] postgres[1225]: SELECT n.proname = 'resolve'1414server # [ 137.106305] postgres[1225]: FROM pg_event_trigger_ddl_commands() AS ev1415server # [ 137.110071] postgres[1225]: LEFT JOIN pg_catalog.pg_proc AS n1416server # [ 137.118063] postgres[1225]: ON ev.objid = n.oid1417server # [ 137.119390] postgres[1225]: );1418server # [ 137.125233] postgres[1225]:1419server # [ 137.127043] postgres[1225]: IF func_is_graphql_resolve1420server # [ 137.129957] postgres[1225]: THEN1421server # [ 137.133251] postgres[1225]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1422server # [ 137.137734] postgres[1225]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1423server # [ 137.140404] postgres[1225]:1424server # [ 137.146027] postgres[1225]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1425server # [ 137.153069] postgres[1225]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1426server # [ 137.154905] postgres[1225]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1427server # [ 137.161200] postgres[1225]:1428server # [ 137.164018] postgres[1225]: DROP FUNCTION IF EXISTS graphql_public.graphql;1429server # [ 137.170222] postgres[1225]: create or replace function graphql_public.graphql(1430server # [ 137.171899] postgres[1225]: "operationName" text default null,1431server # [ 137.182082] postgres[1225]: query text default null,1432server # [ 137.197603] postgres[1225]: variables jsonb default null,1433server # [ 137.204829] postgres[1225]: extensions jsonb default null1434server # [ 137.205689] postgres[1225]: )1435server # [ 137.206953] postgres[1225]: returns jsonb1436server # [ 137.207969] postgres[1225]: language sql1437server # [ 137.233701] postgres[1225]: as $$1438server # [ 137.240808] postgres[1225]: SELECT graphql.resolve(query, coalesce(variables, '{}'));1439server # [ 137.249622] postgres[1225]: $$;1440server # [ 137.250917] postgres[1225]:1441server # [ 137.252364] postgres[1225]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1442server # [ 137.258401] postgres[1225]: END IF;1443server # [ 137.260508] postgres[1225]:1444server # [ 137.273249] postgres[1225]: END;1445server # [ 137.277132] postgres[1225]: $func$;1446server # [ 137.286788] postgres[1225]: ::1 2026-10-27 16:35:34.743 UTC [1225] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;1447server # [ 137.289214] postgres[1225]: ::1 2026-10-27 16:35:34.755 UTC [1225] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')1448server # [ 137.299788] postgres[1225]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access();1449server # [ 137.307770] postgres[1225]: ::1 2026-10-27 16:35:34.762 UTC [1225] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';1450server # [ 137.314885] postgres[1225]: ::1 2026-10-27 16:35:34.782 UTC [1225] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1451server # [ 137.321884] postgres[1225]: RETURNS event_trigger1452server # [ 137.324095] postgres[1225]: LANGUAGE plpgsql1453server # [ 137.327926] postgres[1225]: AS $func$1454server # [ 137.331072] postgres[1225]: DECLARE1455server # [ 137.333204] postgres[1225]: graphql_is_dropped bool;1456server # [ 137.335733] postgres[1225]: BEGIN1457server # [ 137.337784] postgres[1225]: graphql_is_dropped = (1458server # [ 137.342824] postgres[1225]: SELECT ev.schema_name = 'graphql_public'1459server # [ 137.345095] postgres[1225]: FROM pg_event_trigger_dropped_objects() AS ev1460server # [ 137.346616] postgres[1225]: WHERE ev.schema_name = 'graphql_public'1461server # [ 137.349812] postgres[1225]: );1462server # [ 137.350930] postgres[1225]:1463server # [ 137.358813] postgres[1225]: IF graphql_is_dropped1464server # [ 137.361689] postgres[1225]: THEN1465server # [ 137.363406] postgres[1225]: create or replace function graphql_public.graphql(1466server # [ 137.370416] postgres[1225]: "operationName" text default null,1467server # [ 137.372121] postgres[1225]: query text default null,1468server # [ 137.382460] postgres[1225]: variables jsonb default null,1469server # [ 137.384801] postgres[1225]: extensions jsonb default null1470server # [ 137.387686] postgres[1225]: )1471server # [ 137.390585] postgres[1225]: returns jsonb1472server # [ 137.393734] postgres[1225]: language plpgsql1473server # [ 137.397847] postgres[1225]: as $$1474server # [ 137.401449] postgres[1225]: DECLARE1475server # [ 137.404880] postgres[1225]: server_version float;1476server # [ 137.409990] postgres[1225]: BEGIN1477server # [ 137.413473] postgres[1225]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1478server # [ 137.414939] postgres[1225]:1479server # [ 137.421130] postgres[1225]: IF server_version >= 14 THEN1480server # [ 137.425547] postgres[1225]: RETURN jsonb_build_object(1481server # [ 137.427054] postgres[1225]: 'data', null::jsonb,1482server # [ 137.434305] postgres[1225]: 'errors', array['pg_graphql extension is not enabled.']1483server # [ 137.437351] postgres[1225]: );1484server # [ 137.438125] postgres[1225]: ELSE1485server # [ 137.438727] postgres[1225]: RETURN jsonb_build_object(1486server # [ 137.439210] postgres[1225]: 'data', null::jsonb,1487server # [ 137.439788] postgres[1225]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1488server # [ 137.444652] postgres[1225]: );1489server # [ 137.451947] postgres[1225]: END IF;1490server # [ 137.460023] postgres[1225]: END;1491server # [ 137.463196] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: CREATE FUNCTION1492server # [ 137.469282] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping1493server # [ 137.474893] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: DROP EVENT TRIGGER1494server # [ 137.477231] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: CREATE EVENT TRIGGER1495server # [ 137.482091] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: COMMENT1496server # [ 137.484109] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: CREATE FUNCTION1497server # [ 137.486928] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping1498server # [ 137.493842] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: DROP EVENT TRIGGER1499server # [ 137.495239] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: CREATE EVENT TRIGGER1500server # [ 137.496100] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1224]: COMMENT1501server # [ 137.499026] postgres[1225]: $$;1502server # [ 137.500030] postgres[1225]: END IF;1503server # [ 137.501250] postgres[1225]:1504server # [ 137.502164] postgres[1225]: END;1505server # [ 137.507499] postgres[1225]: $func$;1506server # [ 137.516161] postgres[1225]: ::1 2026-10-27 16:35:34.817 UTC [1225] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;1507server # [ 137.518913] postgres[1225]: ::1 2026-10-27 16:35:34.823 UTC [1225] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')1508server # [ 137.526546] postgres[1225]: EXECUTE PROCEDURE extensions.set_graphql_placeholder();1509server # [ 137.528836] postgres[1225]: ::1 2026-10-27 16:35:34.835 UTC [1225] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';1510server # [ 137.544818] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql1511server # [ 137.627464] postgres[1229]: ::1 2026-10-27 16:35:35.287 UTC [1229] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1512server # [ 137.649191] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1226]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1513server # [ 137.651294] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1226]: DROP EVENT TRIGGER1514server # [ 137.655484] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1226]: 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, skipping1515server # [ 137.662800] postgres[1229]: ::1 2026-10-27 16:35:35.300 UTC [1229] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1516server # [ 137.669648] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1226]: DROP FUNCTION1517server # [ 137.672957] postgres[1229]: ::1 2026-10-27 16:35:35.327 UTC [1229] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1518server # [ 137.674062] postgres[1229]: DECLARE1519server # [ 137.674504] postgres[1229]: cmd record;1520server # [ 137.681860] postgres[1229]: BEGIN1521server # [ 137.685823] postgres[1229]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1522server # [ 137.692990] postgres[1229]: LOOP1523server # [ 137.695138] postgres[1229]: IF cmd.command_tag IN (1524server # [ 137.699425] postgres[1229]: 'CREATE SCHEMA', 'ALTER SCHEMA'1525server # [ 137.702364] postgres[1229]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1526server # [ 137.706063] postgres[1229]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1527server # [ 137.707983] postgres[1229]: , 'CREATE VIEW', 'ALTER VIEW'1528server # [ 137.713883] postgres[1229]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1529server # [ 137.716891] postgres[1229]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1530server # [ 137.718239] postgres[1229]: , 'CREATE TRIGGER'1531server # [ 137.725515] postgres[1229]: , 'CREATE TYPE', 'ALTER TYPE'1532server # [ 137.728693] postgres[1229]: , 'CREATE RULE'1533server # [ 137.729681] postgres[1229]: , 'COMMENT'1534server # [ 137.730373] postgres[1229]: )1535server # [ 137.732237] postgres[1229]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1536server # [ 137.737810] postgres[1229]: AND cmd.schema_name is distinct from 'pg_temp'1537server # [ 137.738961] postgres[1229]: THEN1538server # [ 137.740353] postgres[1229]: NOTIFY pgrst, 'reload schema';1539server # [ 137.742616] postgres[1229]: END IF;1540server # [ 137.749401] postgres[1229]: END LOOP;1541server # [ 137.750694] postgres[1229]: END; $$ LANGUAGE plpgsql;1542server # [ 137.753626] postgres[1229]: ::1 2026-10-27 16:35:35.397 UTC [1229] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1543server # [ 137.761048] postgres[1229]: DECLARE1544server # [ 137.762587] postgres[1229]: obj record;1545server # [ 137.765028] postgres[1229]: BEGIN1546server # [ 137.769169] postgres[1229]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1547server # [ 137.770271] postgres[1229]: LOOP1548server # [ 137.773549] postgres[1229]: IF obj.object_type IN (1549server # [ 137.775861] postgres[1229]: 'schema'1550server # [ 137.782417] postgres[1229]: , 'table'1551server # [ 137.786968] postgres[1229]: , 'foreign table'1552server # [ 137.792794] postgres[1229]: , 'view'1553server # [ 137.797664] postgres[1229]: , 'materialized view'1554server # [ 137.801140] postgres[1229]: , 'function'1555server # [ 137.806449] postgres[1229]: , 'trigger'1556server # [ 137.808544] postgres[1229]: , 'type'1557server # [ 137.813553] postgres[1229]: , 'rule'1558server # [ 137.821125] postgres[1229]: )1559server # [ 137.821972] postgres[1229]: AND obj.is_temporary IS false -- no pg_temp objects1560server # [ 137.822708] postgres[1229]: THEN1561server # [ 137.824076] postgres[1229]: NOTIFY pgrst, 'reload schema';1562server # [ 137.830047] postgres[1229]: END IF;1563server # [ 137.840078] postgres[1229]: END LOOP;1564server # [ 137.849191] postgres[1229]: END; $$ LANGUAGE plpgsql;1565server # [ 137.863636] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1226]: CREATE FUNCTION1566server # [ 137.871301] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1226]: CREATE FUNCTION1567server # [ 137.882850] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1226]: DROP EVENT TRIGGER1568server # [ 137.890598] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1226]: CREATE EVENT TRIGGER1569server # [ 137.896485] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1226]: DROP EVENT TRIGGER1570server # [ 137.898455] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1226]: CREATE EVENT TRIGGER1571server # [ 137.909474] postgres[1229]: ::1 2026-10-27 16:35:35.426 UTC [1229] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1572server # [ 137.912635] postgres[1229]: ::1 2026-10-27 16:35:35.439 UTC [1229] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1573server # [ 137.929522] postgres[1229]: ON ddl_command_end1574server # [ 137.934065] postgres[1229]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1575server # [ 137.941006] postgres[1229]: ::1 2026-10-27 16:35:35.451 UTC [1229] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1576server # [ 137.948284] postgres[1229]: ::1 2026-10-27 16:35:35.466 UTC [1229] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1577server # [ 137.959815] postgres[1229]: ON sql_drop1578server # [ 137.969452] postgres[1229]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1579server # [ 137.972518] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql1580server # [ 138.229975] postgres[1231]: ::1 2026-10-27 16:35:35.882 UTC [1231] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;1581server # [ 138.247358] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1230]: ALTER ROLE1582server # [ 138.286317] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql1583server # [ 138.611403] postgres[1233]: ::1 2026-10-27 16:35:36.261 UTC [1233] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1584server # [ 138.617986] postgres[1233]: returns event_trigger1585server # [ 138.620083] postgres[1233]: language plpgsql1586server # [ 138.633387] postgres[1233]: AS $func$1587server # [ 138.638506] postgres[1233]: DECLARE1588server # [ 138.639942] postgres[1233]: func_is_graphql_resolve bool;1589server # [ 138.645282] postgres[1233]: BEGIN1590server # [ 138.649950] postgres[1233]: func_is_graphql_resolve = (1591server # [ 138.653567] postgres[1233]: SELECT n.proname = 'resolve'1592server # [ 138.657291] postgres[1233]: FROM pg_event_trigger_ddl_commands() AS ev1593server # [ 138.658717] postgres[1233]: LEFT JOIN pg_catalog.pg_proc AS n1594server # [ 138.665340] postgres[1233]: ON ev.objid = n.oid1595server # [ 138.666653] postgres[1233]: );1596server # [ 138.668085] postgres[1233]:1597server # [ 138.669428] postgres[1233]: IF func_is_graphql_resolve1598server # [ 138.672973] postgres[1233]: THEN1599server # [ 138.674509] postgres[1233]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1600server # [ 138.681254] postgres[1233]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1601server # [ 138.682758] postgres[1233]:1602server # [ 138.685883] postgres[1233]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1603server # [ 138.686935] postgres[1233]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1604server # [ 138.693632] postgres[1233]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1605server # [ 138.701709] postgres[1233]:1606server # [ 138.702657] postgres[1233]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1607server # [ 138.710007] postgres[1233]: DROP FUNCTION IF EXISTS graphql_public.graphql;1608server # [ 138.713153] postgres[1233]: create or replace function graphql_public.graphql(1609server # [ 138.714770] postgres[1233]: "operationName" text default null,1610server # [ 138.716058] postgres[1233]: query text default null,1611server # [ 138.719900] postgres[1233]: variables jsonb default null,1612server # [ 138.725360] postgres[1233]: extensions jsonb default null1613server # [ 138.727178] postgres[1233]: )1614server # [ 138.729419] postgres[1233]: returns jsonb1615server # [ 138.730511] postgres[1233]: language sql1616server # [ 138.733756] postgres[1233]: as $$1617server # [ 138.734502] postgres[1233]: -- This changed1618server # [ 138.735465] postgres[1233]: select graphql.resolve(1619server # [ 138.736008] postgres[1233]: query := query,1620server # [ 138.738990] postgres[1233]: variables := coalesce(variables, '{}'),1621server # [ 138.741362] postgres[1233]: "operationName" := "operationName",1622server # [ 138.742582] postgres[1233]: extensions := extensions1623server # [ 138.744070] postgres[1233]: );1624server # [ 138.745750] postgres[1233]: $$;1625server # [ 138.746495] postgres[1233]:1626server # [ 138.747186] postgres[1233]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1627server # [ 138.749558] postgres[1233]: END IF;1628server # [ 138.750380] postgres[1233]:1629server # [ 138.751286] postgres[1233]: END;1630server # [ 138.752101] postgres[1233]: $func$;1631server # [ 138.754452] postgres[1233]: ::1 2026-10-27 16:35:36.397 UTC [1233] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1632server # [ 138.757591] postgres[1233]: RETURNS event_trigger1633server # [ 138.759682] postgres[1233]: LANGUAGE plpgsql1634server # [ 138.762426] postgres[1233]: AS $func$1635server # [ 138.765670] postgres[1233]: DECLARE1636server # [ 138.767381] postgres[1233]: graphql_is_dropped bool;1637server # [ 138.770002] postgres[1233]: BEGIN1638server # [ 138.774008] postgres[1233]: graphql_is_dropped = (1639server # [ 138.775649] postgres[1233]: SELECT ev.schema_name = 'graphql_public'1640server # [ 138.778706] postgres[1233]: FROM pg_event_trigger_dropped_objects() AS ev1641server # [ 138.781080] postgres[1233]: WHERE ev.schema_name = 'graphql_public'1642server # [ 138.782244] postgres[1233]: );1643server # [ 138.783037] postgres[1233]:1644server # [ 138.785557] postgres[1233]: IF graphql_is_dropped1645server # [ 138.787075] postgres[1233]: THEN1646server # [ 138.788091] postgres[1233]: create or replace function graphql_public.graphql(1647server # [ 138.790408] postgres[1233]: "operationName" text default null,1648server # [ 138.791233] postgres[1233]: query text default null,1649server # [ 138.793452] postgres[1233]: variables jsonb default null,1650server # [ 138.794308] postgres[1233]: extensions jsonb default null1651server # [ 138.796620] postgres[1233]: )1652server # [ 138.798029] postgres[1233]: returns jsonb1653server # [ 138.798923] postgres[1233]: language plpgsql1654server # [ 138.801903] postgres[1233]: as $$1655server # [ 138.802908] postgres[1233]: DECLARE1656server # [ 138.803599] postgres[1233]: server_version float;1657server # [ 138.804270] postgres[1233]: BEGIN1658server # [ 138.805506] postgres[1233]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1659server # [ 138.807953] postgres[1233]:1660server # [ 138.810077] postgres[1233]: IF server_version >= 14 THEN1661server # [ 138.811413] postgres[1233]: RETURN jsonb_build_object(1662server # [ 138.812874] postgres[1233]: 'errors', jsonb_build_array(1663server # [ 138.813578] postgres[1233]: jsonb_build_object(1664server # [ 138.814913] postgres[1233]: 'message', 'pg_graphql extension is not enabled.'1665server # [ 138.816191] postgres[1233]: )1666server # [ 138.818339] postgres[1233]: )1667server # [ 138.819302] postgres[1233]: );1668server # [ 138.820959] postgres[1233]: ELSE1669server # [ 138.822135] postgres[1233]: RETURN jsonb_build_object(1670server # [ 138.823236] postgres[1233]: 'errors', jsonb_build_array(1671server # [ 138.825528] postgres[1233]: jsonb_build_object(1672server # [ 138.826681] postgres[1233]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1673server # [ 138.832033] postgres[1233]: )1674server # [ 138.837832] postgres[1233]: )1675server # [ 138.839092] postgres[1233]: );1676server # [ 138.841124] postgres[1233]: END IF;1677server # [ 138.843451] postgres[1233]: END;1678server # [ 138.845672] postgres[1233]: $$;1679server # [ 138.849210] postgres[1233]: END IF;1680server # [ 138.850524] postgres[1233]:1681server # [ 138.851233] postgres[1233]: END;1682server # [ 138.857065] postgres[1233]: $func$;1683server # [ 138.864617] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1232]: CREATE FUNCTION1684server # [ 138.866583] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1232]: CREATE FUNCTION1685server # [ 138.869513] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1232]: CREATE FUNCTION1686server # [ 138.870738] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1232]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping1687server # [ 138.873347] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1232]: DROP EXTENSION1688server # [ 138.876435] postgres[1233]: ::1 2026-10-27 16:35:36.438 UTC [1233] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1689server # [ 138.878503] postgres[1233]: "operationName" text default null,1690server # [ 138.883550] postgres[1233]: query text default null,1691server # [ 138.889609] postgres[1233]: variables jsonb default null,1692server # [ 138.898682] postgres[1233]: extensions jsonb default null1693server # [ 138.905482] postgres[1233]: )1694server # [ 138.910046] postgres[1233]: returns jsonb1695server # [ 138.917431] postgres[1233]: language plpgsql1696server # [ 138.926972] postgres[1233]: as $$1697server # [ 138.935116] postgres[1233]: DECLARE1698server # [ 138.937221] postgres[1233]: server_version float;1699server # [ 138.944568] postgres[1233]: BEGIN1700server # [ 138.950201] postgres[1233]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1701server # [ 138.954065] postgres[1233]:1702server # [ 138.957165] postgres[1233]: IF server_version >= 14 THEN1703server # [ 138.966972] postgres[1233]: RETURN jsonb_build_object(1704server # [ 138.977596] postgres[1233]: 'errors', jsonb_build_array(1705server # [ 138.985287] postgres[1233]: jsonb_build_object(1706server # [ 138.989173] postgres[1233]: 'message', 'pg_graphql extension is not enabled.'1707server # [ 138.996507] postgres[1233]: )1708server # [ 139.001916] postgres[1233]: )1709server # [ 139.002863] postgres[1233]: );1710server # [ 139.004567] postgres[1233]: ELSE1711server # [ 139.007852] postgres[1233]: RETURN jsonb_build_object(1712server # [ 139.013185] postgres[1233]: 'errors', jsonb_build_array(1713server # [ 139.015931] postgres[1233]: jsonb_build_object(1714server # [ 139.023295] postgres[1233]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1715server # [ 139.031270] postgres[1233]: )1716server # [ 139.039902] postgres[1233]: )1717server # [ 139.041754] postgres[1233]: );1718server # [ 139.043756] postgres[1233]: END IF;1719server # [ 139.051696] postgres[1233]: END;1720server # [ 139.060144] postgres[1233]: $$;1721server # [ 139.070753] postgres[1233]: ::1 2026-10-27 16:35:36.493 UTC [1233] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1722server # [ 140.536602] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1232]: DO1723server # [ 140.586924] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql1724server # [ 140.718841] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31725server # [ 140.947709] postgres[1252]: ::1 2026-10-27 16:35:38.602 UTC [1252] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres;1726server # [ 140.959696] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1249]: GRANT ROLE1727server # [ 141.000419] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql1728server # [ 141.378554] postgres[1257]: ::1 2026-10-27 16:35:39.019 UTC [1257] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1729server # [ 141.382204] postgres[1257]: returns event_trigger1730server # [ 141.385468] postgres[1257]: language plpgsql1731server # [ 141.389210] postgres[1257]: AS $func$1732server # [ 141.390593] postgres[1257]: DECLARE1733server # [ 141.397452] postgres[1257]: func_is_graphql_resolve bool;1734server # [ 141.398958] postgres[1257]: BEGIN1735server # [ 141.403112] postgres[1257]: func_is_graphql_resolve = (1736server # [ 141.408772] postgres[1257]: SELECT n.proname = 'resolve'1737server # [ 141.409864] postgres[1257]: FROM pg_event_trigger_ddl_commands() AS ev1738server # [ 141.411241] postgres[1257]: LEFT JOIN pg_catalog.pg_proc AS n1739server # [ 141.417216] postgres[1257]: ON ev.objid = n.oid1740server # [ 141.419390] postgres[1257]: );1741server # [ 141.425209] postgres[1257]:1742server # [ 141.426083] postgres[1257]: IF func_is_graphql_resolve1743server # [ 141.426888] postgres[1257]: THEN1744server # [ 141.428072] postgres[1257]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1745server # [ 141.434362] postgres[1257]: DROP FUNCTION IF EXISTS graphql_public.graphql;1746server # [ 141.437135] postgres[1257]: create or replace function graphql_public.graphql(1747server # [ 141.441458] postgres[1257]: "operationName" text default null,1748server # [ 141.442381] postgres[1257]: query text default null,1749server # [ 141.443143] postgres[1257]: variables jsonb default null,1750server # [ 141.445488] postgres[1257]: extensions jsonb default null1751server # [ 141.449152] postgres[1257]: )1752server # [ 141.450179] postgres[1257]: returns jsonb1753server # [ 141.453760] postgres[1257]: language sql1754server # [ 141.457148] postgres[1257]: as $$1755server # [ 141.461830] postgres[1257]: select graphql.resolve(1756server # [ 141.465228] postgres[1257]: query := query,1757server # [ 141.466255] postgres[1257]: variables := coalesce(variables, '{}'),1758server # [ 141.469664] postgres[1257]: "operationName" := "operationName",1759server # [ 141.470571] postgres[1257]: extensions := extensions1760server # [ 141.477481] postgres[1257]: );1761server # [ 141.478578] postgres[1257]: $$;1762server # [ 141.480009] postgres[1257]:1763server # [ 141.481675] postgres[1257]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1764server # [ 141.482536] postgres[1257]: -- function in the extension so we need to grant permissions on existing entities AND1765server # [ 141.483835] postgres[1257]: -- update default permissions to any others that are created after `graphql.resolve`1766server # [ 141.490314] postgres[1257]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1767server # [ 141.493029] postgres[1257]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1768server # [ 141.497043] postgres[1257]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1769server # [ 141.499154] postgres[1257]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1770server # [ 141.505157] postgres[1257]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1771server # [ 141.506774] postgres[1257]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1772server # [ 141.509474] postgres[1257]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1773server # [ 141.512116] postgres[1257]: END IF;1774server # [ 141.516832] postgres[1257]:1775server # [ 141.519528] postgres[1257]: END;1776server # [ 141.521009] postgres[1257]: $func$;1777server # [ 141.525147] postgres[1257]: ::1 2026-10-27 16:35:39.133 UTC [1257] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1778server # [ 141.530355] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1255]: CREATE FUNCTION1779server # [ 141.549319] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1255]: DROP EXTENSION1780server # [ 142.913731] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1255]: DO1781server # [ 142.937709] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql1782server # [ 144.104936] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1258]: DO1783server # [ 144.960886] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1258]: DO1784server # [ 145.024140] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql1785server # [ 145.354604] postgres[1281]: ::1 2026-10-27 16:35:43.008 UTC [1281] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s';1786server # [ 145.377590] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1280]: ALTER ROLE1787server # [ 145.412859] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql1788server # [ 145.690621] postgres[1283]: ::1 2026-10-27 16:35:43.342 UTC [1283] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator;1789server # [ 145.700078] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1282]: REVOKE ROLE1790server # [ 145.738451] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql1791server # [ 147.965713] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1284]: DO1792server # [ 148.009709] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql1793server # [ 148.355286] postgres[1307]: ::1 2026-10-27 16:35:46.010 UTC [1307] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres;1794server # [ 148.407723] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1303]: GRANT ROLE1795server # [ 148.439516] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql1796server # [ 148.745790] postgres[1309]: ::1 2026-10-27 16:35:46.393 UTC [1309] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option;1797server # [ 148.793822] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1308]: GRANT1798server # [ 148.798801] postgres[1309]: ::1 2026-10-27 16:35:46.453 UTC [1309] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option;1799server # [ 148.838008] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1308]: GRANT1800server # [ 148.841709] postgres[1309]: ::1 2026-10-27 16:35:46.503 UTC [1309] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option;1801server # [ 148.849261] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1308]: GRANT1802server # [ 148.853329] postgres[1309]: ::1 2026-10-27 16:35:46.515 UTC [1309] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;1803server # [ 148.869187] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1308]: ALTER DEFAULT PRIVILEGES1804server # [ 148.871983] postgres[1309]: ::1 2026-10-27 16:35:46.530 UTC [1309] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;1805server # [ 148.884900] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1308]: ALTER DEFAULT PRIVILEGES1806server # [ 148.886840] postgres[1309]: ::1 2026-10-27 16:35:46.545 UTC [1309] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;1807server # [ 148.896000] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1308]: ALTER DEFAULT PRIVILEGES1808server # [ 148.933338] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql1809server: Guest root shell did not produce any data yet...1810server: To debug, enter the VM and run 'systemctl status backdoor.service'.1811server # [ 149.200172] postgres[1311]: ::1 2026-10-27 16:35:46.857 UTC [1311] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres;1812server # [ 149.215396] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1310]: GRANT ROLE1813server # [ 149.258305] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql1814server # [ 149.544045] postgres[1313]: ::1 2026-10-27 16:35:47.198 UTC [1313] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin;1815server # [ 149.568218] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1312]: GRANT ROLE1816server # [ 149.593080] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql1817server # [ 149.965512] postgres[1317]: ::1 2026-10-27 16:35:47.615 UTC [1317] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit;1818server # [ 150.005057] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1314]: ALTER ROLE1819server # [ 150.010376] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1314]: ALTER ROLE1820server # [ 150.013932] postgres[1317]: ::1 2026-10-27 16:35:47.655 UTC [1317] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit;1821server # [ 150.018088] postgres[1317]: ::1 2026-10-27 16:35:47.674 UTC [1317] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit;1822server # [ 150.026072] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1314]: ALTER ROLE1823server # [ 150.079153] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1314]: DO1824server # [ 150.135396] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql1825server # [ 150.540077] postgres[1330]: ::1 2026-10-27 16:35:48.195 UTC [1330] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin;1826server # [ 150.569157] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1325]: GRANT ROLE1827server # [ 150.593116] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1325]: REVOKE ROLE1828server # [ 150.601292] postgres[1330]: ::1 2026-10-27 16:35:48.219 UTC [1330] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin;1829server # [ 150.662509] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql1830server # [ 151.026407] postgres[1336]: ::1 2026-10-27 16:35:48.671 UTC [1336] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1831server # [ 151.032039] postgres[1336]: returns event_trigger1832server # [ 151.043208] postgres[1336]: language plpgsql1833server # [ 151.046492] postgres[1336]: AS $func$1834server # [ 151.053889] postgres[1336]: DECLARE1835server # [ 151.058100] postgres[1336]: func_is_graphql_resolve bool;1836server # [ 151.065297] postgres[1336]: BEGIN1837server # [ 151.067212] postgres[1336]: func_is_graphql_resolve = (1838server # [ 151.077737] postgres[1336]: SELECT n.proname = 'resolve'1839server # [ 151.086324] postgres[1336]: FROM pg_event_trigger_ddl_commands() AS ev1840server # [ 151.089137] postgres[1336]: LEFT JOIN pg_catalog.pg_proc AS n1841server # [ 151.097801] postgres[1336]: ON ev.objid = n.oid1842server # [ 151.099680] postgres[1336]: );1843server # [ 151.106322] postgres[1336]:1844server # [ 151.107931] postgres[1336]: IF func_is_graphql_resolve1845server # [ 151.111752] postgres[1336]: THEN1846server # [ 151.117710] postgres[1336]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1847server # [ 151.125045] postgres[1336]: DROP FUNCTION IF EXISTS graphql_public.graphql;1848server # [ 151.126226] postgres[1336]: create or replace function graphql_public.graphql(1849server # [ 151.127132] postgres[1336]: "operationName" text default null,1850server # [ 151.130479] postgres[1336]: query text default null,1851server # [ 151.140006] postgres[1336]: variables jsonb default null,1852server # [ 151.143277] postgres[1336]: extensions jsonb default null1853server # [ 151.145465] postgres[1336]: )1854server # [ 151.149013] postgres[1336]: returns jsonb1855server # [ 151.151706] postgres[1336]: language sql1856server # [ 151.157135] postgres[1336]: as $$1857server # [ 151.158220] postgres[1336]: select graphql.resolve(1858server # [ 151.159229] postgres[1336]: query := query,1859server # [ 151.160753] postgres[1336]: variables := coalesce(variables, '{}'),1860server # [ 151.164360] postgres[1336]: "operationName" := "operationName",1861server # [ 151.166529] postgres[1336]: extensions := extensions1862server # [ 151.173044] postgres[1336]: );1863server # [ 151.174249] postgres[1336]: $$;1864server # [ 151.175142] postgres[1336]:1865server # [ 151.175730] postgres[1336]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1866server # [ 151.178373] postgres[1336]: -- function in the extension so we need to grant permissions on existing entities AND1867server # [ 151.179521] postgres[1336]: -- update default permissions to any others that are created after `graphql.resolve`1868server # [ 151.188022] postgres[1336]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1869server # [ 151.189780] postgres[1336]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1870server # [ 151.195328] postgres[1336]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1871server # [ 151.202450] postgres[1336]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1872server # [ 151.203746] postgres[1336]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1873server # [ 151.212755] postgres[1336]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1874server # [ 151.214332] postgres[1336]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1875server # [ 151.217462] postgres[1336]:1876server # [ 151.220242] postgres[1336]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles1877server # [ 151.223781] postgres[1336]: grant usage on schema graphql_public to postgres with grant option;1878server # [ 151.227735] postgres[1336]: grant usage on schema graphql to postgres with grant option;1879server # [ 151.237332] postgres[1336]: END IF;1880server # [ 151.238426] postgres[1336]:1881server # [ 151.240253] postgres[1336]: END;1882server # [ 151.242611] postgres[1336]: $func$;1883server # [ 151.247489] postgres[1336]: ::1 2026-10-27 16:35:48.809 UTC [1336] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1884server # [ 151.273838] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1333]: CREATE FUNCTION1885server # [ 151.282483] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1333]: DROP EXTENSION1886server # [ 152.675852] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1333]: DO1887server # [ 152.739543] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql1888server # [ 153.117503] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1340]: DO1889server # [ 153.138973] postgres[1341]: ::1 2026-10-27 16:35:50.770 UTC [1341] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger1890server # [ 153.145900] postgres[1341]: LANGUAGE plpgsql1891server # [ 153.157307] postgres[1341]: AS $$1892server # [ 153.159182] postgres[1341]: BEGIN1893server # [ 153.167761] postgres[1341]: IF EXISTS (1894server # [ 153.175655] postgres[1341]: SELECT1895server # [ 153.186188] postgres[1341]: FROM pg_event_trigger_ddl_commands() AS ev1896server # [ 153.187851] postgres[1341]: JOIN pg_extension AS ext1897server # [ 153.194332] postgres[1341]: ON ev.objid = ext.oid1898server # [ 153.201720] postgres[1341]: WHERE ext.extname = 'pg_cron'1899server # [ 153.205689] postgres[1341]: )1900server # [ 153.215062] postgres[1341]: THEN1901server # [ 153.221868] postgres[1341]: grant usage on schema cron to postgres with grant option;1902server # [ 153.223977] postgres[1341]:1903server # [ 153.237104] postgres[1341]: alter default privileges in schema cron grant all on tables to postgres with grant option;1904server # [ 153.240916] postgres[1341]: alter default privileges in schema cron grant all on functions to postgres with grant option;1905server # [ 153.250051] postgres[1341]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1906server # [ 153.257074] postgres[1341]:1907server # [ 153.258342] postgres[1341]: alter default privileges for user supabase_admin in schema cron grant all1908server # [ 153.265961] postgres[1341]: on sequences to postgres with grant option;1909server # [ 153.273812] postgres[1341]: alter default privileges for user supabase_admin in schema cron grant all1910server # [ 153.288568] postgres[1341]: on tables to postgres with grant option;1911server # [ 153.289942] postgres[1341]: alter default privileges for user supabase_admin in schema cron grant all1912server # [ 153.290807] postgres[1341]: on functions to postgres with grant option;1913server # [ 153.306018] postgres[1341]:1914server # [ 153.307953] postgres[1341]: grant all privileges on all tables in schema cron to postgres with grant option;1915server # [ 153.313244] postgres[1341]: revoke all on table cron.job from postgres;1916server # [ 153.324987] postgres[1341]: grant select on table cron.job to postgres with grant option;1917server # [ 153.337135] postgres[1341]: END IF;1918server # [ 153.338380] postgres[1341]: END;1919server # [ 153.339150] postgres[1341]: $$;1920server # [ 153.342589] postgres[1341]: ::1 2026-10-27 16:35:51.001 UTC [1341] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access;1921server # [ 153.346156] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1340]: CREATE FUNCTION1922server # [ 153.355538] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1340]: DROP EVENT TRIGGER1923server # [ 153.362002] postgres[1341]: ::1 2026-10-27 16:35:51.024 UTC [1341] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;1924server # [ 153.380267] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1340]: ALTER FUNCTION1925server # [ 153.386781] postgres[1341]: ::1 2026-10-27 16:35:51.045 UTC [1341] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end1926server # [ 153.389636] postgres[1341]: WHEN TAG IN ('CREATE EXTENSION')1927server # [ 153.391365] postgres[1341]: EXECUTE FUNCTION extensions.grant_pg_cron_access();1928server # [ 153.398696] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1340]: CREATE EVENT TRIGGER1929server # [ 153.453469] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql1930server # [ 153.922107] postgres[1360]: ::1 2026-10-27 16:35:51.576 UTC [1360] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s';1931server # [ 153.954885] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1354]: ALTER ROLE1932server # [ 154.010194] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql1933server # [ 154.273371] postgres[1365]: ::1 2026-10-27 16:35:51.926 UTC [1365] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin;1934server # [ 154.287871] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1364]: ALTER FUNCTION1935server # [ 154.301404] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1364]: ALTER FUNCTION1936server # [ 154.320677] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1364]: ALTER FUNCTION1937server # [ 154.331400] postgres[1365]: ::1 2026-10-27 16:35:51.950 UTC [1365] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;1938server # [ 154.344286] postgres[1365]: ::1 2026-10-27 16:35:51.954 UTC [1365] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;1939server # [ 154.357988] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql1940server # [ 154.633283] postgres[1369]: ::1 2026-10-27 16:35:52.287 UTC [1369] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres;1941server # [ 154.660594] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1366]: GRANT ROLE1942server # [ 154.685040] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql1943server # [ 155.133493] systemd[1]: Starting Virtual Console Setup...1944server # [ 155.376062] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1945server # [ 155.398166] systemd[1]: Stopped Virtual Console Setup.1946server # [ 155.549431] systemd[1]: Starting Virtual Console Setup...1947server # [ 155.718474] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1370]: DO1948server # [ 155.766111] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql1949server # [ 156.259202] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1375]: DO1950server # [ 156.264059] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1375]: DO1951server # [ 156.313422] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql1952server # [ 156.747108] postgres[1379]: ::1 2026-10-27 16:35:54.406 UTC [1379] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none;1953server # [ 156.808040] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1378]: ALTER ROLE1954server # [ 156.817648] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1378]: ALTER ROLE1955server # [ 156.820958] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1378]: ALTER ROLE1956server # [ 156.836154] postgres[1379]: ::1 2026-10-27 16:35:54.441 UTC [1379] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none;1957server # [ 156.838308] postgres[1379]: ::1 2026-10-27 16:35:54.465 UTC [1379] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none;1958server # [ 156.912158] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql1959server # [ 157.371073] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1380]: DO1960server # [ 157.390378] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql1961server # [ 158.040116] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1382]: DO1962server # [ 158.107953] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql1963server # [ 158.688916] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1384]: CREATE FUNCTION1964server # [ 158.705867] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1384]: DO1965server # [ 158.763094] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql1966server # [ 159.362522] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1386]: ALTER FUNCTION1967server # [ 159.381936] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1386]: GRANT1968server # [ 159.509598] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql1969server # [ 159.879043] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1388]: DROP EVENT TRIGGER1970server # [ 159.893956] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1388]: ALTER FUNCTION1971server # [ 159.904189] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1388]: CREATE EVENT TRIGGER1972server # [ 159.945937] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql1973server # [ 160.693388] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1390]: DO1974server # [ 160.757117] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql1975server # [ 160.994492] systemd-vconsole-setup[1374]: Configuration of first virtual console was skipped, ignoring remaining ones.1976server # [ 161.079988] systemd[1]: Finished Virtual Console Setup.1977server # [ 161.274066] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1402]: CREATE FUNCTION1978server # [ 161.281323] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1402]: GRANT1979server # [ 161.325847] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql1980server # [ 161.633770] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1415]: REVOKE ROLE1981server # [ 161.681502] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1415]: DO1982server # [ 161.691445] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1415]: DO1983server # [ 161.699390] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1415]: REVOKE ROLE1984server # [ 161.710066] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1415]: REVOKE1985server # [ 161.739378] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1415]: DO1986server # [ 161.786952] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql1987server # [ 162.092972] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1417]: DO1988server # [ 162.123956] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql1989server # [ 162.476455] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1419]: DO1990server # [ 162.493549] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql1991server # [ 162.878896] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1421]: DO1992server # [ 162.946455] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql1993server # [ 163.419291] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1427]: ALTER ROLE1994server # [ 163.485015] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql1995server # [ 163.970515] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1439]: GRANT ROLE1996server # [ 163.987384] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1439]: DO1997server # [ 164.041549] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql1998server # [ 164.384025] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1447]: GRANT1999server # [ 164.423180] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql2000server # [ 164.542858] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2001server # [ 164.890445] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1449]: CREATE FUNCTION2002server # [ 164.902405] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1449]: REVOKE2003server # [ 164.918449] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1449]: REVOKE2004server # [ 164.938201] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1449]: GRANT2005server # [ 164.985773] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql2006server # [ 165.326914] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1451]: DO2007server # [ 165.350333] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql2008server # [ 165.639780] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1453]: ALTER ROLE2009server # [ 165.665671] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql2010server # [ 166.045410] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1455]: DROP EXTENSION2011server # [ 166.059235] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql2012server # [ 166.590444] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1457]: CREATE FUNCTION2013server # [ 166.598085] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1457]: DROP EVENT TRIGGER2014server # [ 166.616767] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1457]: CREATE EVENT TRIGGER2015server # [ 166.677952] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql2016server # [ 167.156685] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1471]: DO2017server # [ 167.226608] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1471]: CREATE FUNCTION2018server # [ 167.301047] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql2019server # [ 167.642543] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1481]: CREATE FUNCTION2020server # [ 167.657167] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1481]: CREATE FUNCTION2021server # [ 167.711221] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql2022server # [ 167.987684] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1483]: CREATE FUNCTION2023server # [ 167.998476] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1483]: CREATE FUNCTION2024server # [ 168.009338] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1483]: CREATE FUNCTION2025server # [ 168.025505] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1483]: CREATE FUNCTION2026server # [ 168.039724] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1483]: CREATE FUNCTION2027server # [ 168.052953] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1483]: CREATE FUNCTION2028server # [ 168.085347] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Running postgresql schema...2029server # [ 168.377212] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER DATABASE2030server # [ 168.381812] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER DATABASE2031server # [ 168.446609] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER ROLE2032server # [ 168.498793] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER ROLE2033server # [ 168.559633] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER ROLE2034server # [ 168.609881] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER ROLE2035server # [ 168.667546] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER ROLE2036server # [ 168.723243] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER ROLE2037server # [ 168.789099] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER ROLE2038server # [ 168.913827] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER ROLE2039server # [ 169.042408] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER ROLE2040server # [ 169.066203] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1485]: ALTER ROLE2041server # [ 169.115285] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1064]: Database initialization complete2042server # [ 169.169264] systemd[1]: Finished Supabase Database Initialization.2043server # [ 170.143037] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2044server # [ 170.549950] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2045server # [ 170.620956] systemd[1]: Started backdoor.service.2046server # [ 170.662877] systemd[1]: Reached target Multi-User System.2047server # [ 170.689426] systemd[1]: Startup finished in 2.501s (kernel) + 25.220s (initrd) + 2min 22.964s (userspace) = 2min 50.685s.2048server # [ 170.974188] 8021q: 802.1Q VLAN Support v1.82049server # [ 171.241339] (udev-worker)[1489]: Network interface NamePolicy= disabled on kernel command line.2050server # connecting to host...2051server # [ 171.747712] cfg80211: Loading compiled-in X.509 certificates for regulatory database2052server: Guest shell says: b'Spawning backdoor root shell...\n'2053server: connected to guest root shell2054server: (connecting took 172.97 seconds)2055server: (finished: waiting for the VM to finish booting, in 172.97 seconds)2056server # [ 172.128422] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2057server # [ 172.129270] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2058server # [ 172.165484] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22059server # [ 172.166863] cfg80211: failed to load regulatory.db2060server: (finished: waiting for unit supabase-db-init.service, in 174.13 seconds)2061subtest: Check upgrade path with postgresql 152062server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS pgjwt;" 2063server # [ 173.188859] 8021q: adding VLAN 0 to HW filter on device eth02064server # [ 173.119314] dhcpcd[742]: eth0: waiting for carrier2065server # [ 173.127373] dhcpcd[742]: eth0: carrier acquired2066server # [ 173.327963] dhcpcd[742]: DUID 00:01:00:01:32:73:8f:7a:52:54:00:12:34:562067server # [ 173.335748] dhcpcd[742]: eth0: IAID 00:12:34:562068server # [ 173.345915] dhcpcd[742]: eth0: adding address fe80::5054:ff:fe12:34562069server # NOTICE: extension "pgjwt" does not exist, skipping2070server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS pgjwt;" , in 0.67 seconds)2071server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION pgjwt WITH VERSION '0.2.0' CASCADE;" 2072server # [ 174.939979] dhcpcd[742]: eth0: soliciting a DHCP lease2073server # [ 174.969097] dhcpcd[742]: eth0: offered 10.0.2.15 from 10.0.2.22074server # [ 175.000783] dhcpcd[742]: eth0: probing address 10.0.2.15/242075server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION pgjwt WITH VERSION '0.2.0' CASCADE;" , in 1.27 seconds)2076server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'pgjwt';" 2077server # [ 175.473975] dhcpcd[742]: eth0: soliciting an IPv6 router2078server # [ 175.477974] dhcpcd[742]: eth0: Router Advertisement from fe80::22079server # [ 175.494074] dhcpcd[742]: eth0: adding address fec0::5054:ff:fe12:3456/642080server # [ 175.508467] dhcpcd[742]: eth0: adding route to fec0::/642081server # [ 175.515157] dhcpcd[742]: eth0: adding default route via fe80::22082server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'pgjwt';" , in 0.79 seconds)2083(finished: subtest: Check upgrade path with postgresql 15, in 2.73 seconds)2084subtest: Check the install of the last version of the extension2085server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS pgjwt;" 2086server # [ 176.062217] (udev-worker)[1545]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.2087server # [ 176.073762] (udev-worker)[1545]: Network interface NamePolicy= disabled on kernel command line.2088server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS pgjwt;" , in 0.87 seconds)2089server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION pgjwt WITH VERSION '0.2.0' CASCADE;" 2090server # [ 177.339611] systemd[1]: Condition check resulted in Virtio network device being skipped.2091server # [ 177.394828] systemd[1]: Starting Address configuration of eth1...2092server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION pgjwt WITH VERSION '0.2.0' CASCADE;" , in 1.90 seconds)2093server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'pgjwt';" 2094server # [ 178.794550] 8021q: adding VLAN 0 to HW filter on device eth12095server # [ 179.030444] network-addresses-eth1-start[1578]: adding address 192.168.1.1/24... done2096server # [ 179.318721] network-addresses-eth1-start[1578]: adding address 2001:db8:1::1/64... done2097server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'pgjwt';" , in 0.96 seconds)2098(finished: subtest: Check the install of the last version of the extension, in 3.73 seconds)2099subtest: switch to postgresql 172100server # [ 179.687131] systemd[1]: Finished Address configuration of eth1.2101server # [ 180.197505] dhcpcd[742]: eth0: leased 10.0.2.15 for 86400 seconds2102server # [ 180.201066] dhcpcd[742]: eth0: adding route to 10.0.2.0/242103server # [ 180.202413] dhcpcd[742]: eth0: adding default route via 10.0.2.22104server # Checking switch inhibitors... done2105server # stopping the following units: postgresql.service, supabase-db-init.service2106server # [ 188.763877] nixos[1610]: switching to system configuration /nix/store/gykfmk8xam6da72bcbbygxdb1q7fnk5b-nixos-system-server-test2107server # [ 188.800564] systemd[1]: Stopped target Local File Systems.2108server # [ 188.815844] systemd[1]: supabase-db-init.service: Deactivated successfully.2109server # [ 188.822427] systemd[1]: Stopped Supabase Database Initialization.2110server # [ 188.825061] systemd[1]: supabase-db-init.service: Consumed 8.705s CPU time over 1min 9.531s wall clock time, 3.9M memory peak, 90.4K incoming IP traffic, 131K outgoing IP traffic.2111server # [ 188.852570] systemd[1]: Stopped target Remote File Systems.2112server # [ 188.879983] postgres[1031]: 2026-10-27 16:36:26.537 UTC [1031] LOG: received fast shutdown request2113server # [ 188.904696] systemd[1]: Stopping PostgreSQL Database Server...2114server # [ 188.915128] postgres[1031]: 2026-10-27 16:36:26.578 UTC [1031] LOG: aborting any active transactions2115server # [ 188.923839] postgres[1061]: 2026-10-27 16:36:26.579 UTC [1061] LOG: pg_cron scheduler shutting down2116server # [ 188.992790] postgres[1059]: 2026-10-27 16:36:26.603 UTC [1059] FATAL: terminating background worker "TimescaleDB Background Worker Launcher" due to administrator command2117server # [ 189.106870] postgres[1031]: 2026-10-27 16:36:26.770 UTC [1031] LOG: background worker "TimescaleDB Background Worker Launcher" (PID 1059) exited with exit code 12118server # [ 189.121401] postgres[1031]: 2026-10-27 16:36:26.782 UTC [1031] LOG: background worker "pg_cron launcher" (PID 1061) exited with exit code 12119server # [ 189.125718] postgres[1031]: 2026-10-27 16:36:26.782 UTC [1031] LOG: background worker "logical replication launcher" (PID 1062) exited with exit code 12120server # [ 189.128930] postgres[1031]: 2026-10-27 16:36:26.791 UTC [1031] LOG: background worker "pg_net 0.20.4 worker" (PID 1091) exited with exit code 12121server # [ 189.146280] postgres[1054]: 2026-10-27 16:36:26.795 UTC [1054] LOG: shutting down2122server # [ 189.149753] postgres[1054]: 2026-10-27 16:36:26.812 UTC [1054] LOG: checkpoint starting: shutdown immediate2123server # [ 189.840378] postgres[1054]: 2026-10-27 16:36:27.497 UTC [1054] LOG: checkpoint complete: wrote 269 buffers (1.6%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.136 s, sync=0.452 s, total=0.698 s; sync files=136, longest=0.025 s, average=0.004 s; distance=1994 kB, estimate=1994 kB2124server # [ 190.167461] postgres[1031]: 2026-10-27 16:36:27.826 UTC [1031] LOG: database system is shut down2125server # [ 190.287035] systemd[1]: postgresql.service: Deactivated successfully.2126server # [ 190.303676] systemd[1]: Stopped PostgreSQL Database Server.2127server # activating the configuration...2128server # [ 190.324338] systemd[1]: postgresql.service: Consumed 39.109s CPU time over 1min 49.816s wall clock time, 127.8M memory peak, 45.3M written to disk, 135.4K incoming IP traffic, 95K outgoing IP traffic.2129server # [ 190.855330] systemd-logind[590]: Watching system buttons on /dev/input/event0 (gpio-keys)2130server # setting up /etc...2131server # [ 197.039965] systemd-logind[590]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2132server # [ 198.303934] systemd[1]: Reload requested from client PID 1610 ('.switch-to-conf') (unit backdoor.service)...2133server # [ 198.307188] systemd[1]: Reloading...2134server # [ 205.023127] systemd[1]: Reloading finished in 6700 ms.2135server # restarting sysinit-reactivation.target2136server # [ 205.448037] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....2137server # [ 207.123377] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..2138server # [ 207.147188] systemd[1]: Reached target Reactivate sysinit units.2139server # reloading the following units: dbus-broker.service2140server # [ 207.200891] systemd[1]: Reloading D-Bus System Message Bus...2141server # [ 207.223407] dbus-broker-launch[576]: Caught SIGHUP, trigger reload.2142server # [ 207.493883] dbus-broker-launch[576]: Looking up NSS user entry for 'systemd-timesync'...2143server # [ 207.522715] dbus-broker-launch[576]: NSS returned no entry for 'systemd-timesync'2144server # [ 207.531190] dbus-broker-launch[576]: Invalid user-name in /nix/store/j5fip7fwpdbzg1ddp9srvimgq589fa5h-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2145server # [ 207.847143] systemd[1]: Reloaded D-Bus System Message Bus.2146server # starting the following units: postgresql.service, supabase-db-init.service2147server # [ 207.973306] systemd[1]: Reached target Remote File Systems.2148server # [ 208.086377] systemd[1]: Starting linger-users.service...2149server # [ 208.190678] systemd[1]: Starting PostgreSQL Major Version Migration...2150server # [ 208.478046] systemd[1]: Reached target Local File Systems.2151server # [ 208.497854] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2152server # [ 208.621612] systemd[1]: Starting Create SUID/SGID Wrappers...2153server # [ 208.630353] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2154server # [ 208.637720] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672155server # [ 208.653941] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2156server # [ 208.666327] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki2157server # [ 208.676795] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki2158server # [ 208.889920] systemd[1]: linger-users.service: Deactivated successfully.2159server # [ 208.917833] systemd[1]: Finished linger-users.service.2160server # [ 209.104910] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2161server # [ 209.339902] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1882]: Starting pg_upgrade from 15 to 172162server # [ 210.855881] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: The files belonging to this database system will be owned by user "postgres".2163server # [ 210.871552] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: This user must also own the server process.2164server # [ 210.953484] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: The database cluster will be initialized with locale "en_US.UTF-8".2165server # [ 210.962097] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: The default database encoding has accordingly been set to "UTF8".2166server # [ 210.969555] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: The default text search configuration will be set to "english".2167server # [ 210.970645] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: Data page checksums are enabled.2168server # [ 210.971837] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: fixing permissions on existing directory /var/lib/postgresql/data-17 ... ok2169server # [ 210.991023] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: creating subdirectories ... ok2170server # [ 210.994552] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: selecting dynamic shared memory implementation ... posix2171server # [ 212.549950] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: selecting default "max_connections" ... 1002172server # [ 213.629257] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: selecting default "shared_buffers" ... 128MB2173server # [ 216.579201] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2174server # [ 216.590767] systemd[1]: Finished Create SUID/SGID Wrappers.2175server # [ 216.610541] systemd[1]: suid-sgid-wrappers.service: Consumed 3.272s CPU time over 7.953s wall clock time, 3.2M memory peak.2176server # [ 224.194562] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: selecting default time zone ... UTC2177server # [ 224.240091] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: creating configuration files ... ok2178server # [ 227.729808] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: running bootstrap script ... ok2179server # [ 235.909985] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: performing post-bootstrap initialization ... ok2180server # [ 237.741591] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: syncing data to disk ... ok2181server # [ 237.745480] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: initdb: warning: enabling "trust" authentication for local connections2182server # [ 237.746888] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: 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.2183server # [ 237.748082] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: Success. You can now start the database server using:2184server # [ 237.758000] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[1893]: /nix/store/cvdbz3rf4mypaxs6qhj7dhdgkskxpfpa-postgresql-and-plugins-17.11/bin/pg_ctl -D /var/lib/postgresql/data-17 -l logfile start2185server # [ 242.898232] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[2156]: Performing Consistency Checks2186server # [ 242.997518] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[2156]: -----------------------------2187server # [ 243.017668] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[2156]: Checking cluster versions ok2188server # [ 247.368510] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[2156]: Checking database user is the install user ok2189server # [ 247.466235] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[2156]: Checking database connection settings ok2190server # [ 247.589315] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[2156]: Checking for prepared transactions ok2191server # [ 247.591314] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[2156]: Checking for contrib/isn with bigint-passing mismatch ok2192server # [ 248.391430] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[2156]: Checking data type usage ok2193server # [ 248.659655] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[2156]: Checking for not-null constraint inconsistencies ok2194server # [ 249.828024] rkg2jdnmlmvpd9qgwg37114rzk4gjg87-postgresql-migrate[2156]: Creating dump of global objects ok