vm-test-run-plv8
checks.aarch64-linux.ext-plv8
· build #143
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600 seconds5run the VM test script6additionally exposed symbols:7 server,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11server: starting vm12server # Disk image does not exist, creating the virtualisation disk image...13server # Formatting '/build/vm-state-server/tmp.zDNFBr3r8k', fmt=raw size=107374182414server # mke2fs 1.47.4 (6-Mar-2025)15server # Discarding device blocks: 0/262144 done16server # Creating filesystem with 262144 4k blocks and 65536 inodes17server # Filesystem UUID: a7942eb1-6834-4b32-a25c-60fba2d0e2da18server # Superblock backups stored on blocks:19server # 32768, 98304, 163840, 22937620server # 21server # Allocating group tables: 0/8 done22server # Writing inode tables: 0/8 done23server # Creating journal (8192 blocks): done24server # Writing superblocks and filesystem accounting information: 0/8 done25server: QEMU running (pid 13)26server # 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.40 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/ll4ryvjnmk0mkw603yy13nc08z02p028-nixos-system-server-test/init regInfo=/nix/store/dn87dmp4krbjyw8lslhly1hvaxn2f25i-closure-info/registration console=ttyAMA0,115200n8 console=tty068server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/dn87dmp4krbjyw8lslhly1hvaxn2f25i-closure-info/registration", will be passed to user space.69server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes70server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)71server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)72server # [ 0.000000] software IO TLB: area num 2.73server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)74server # [ 0.000000] Fallback order for Node 0: 075server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 104857676server # [ 0.000000] Policy zone: Normal77server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off78server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=179server # [ 0.000000] allocated 8388608 bytes of page_ext80server # [ 0.000000] ftrace: allocating 74832 entries in 294 pages81server # [ 0.000000] ftrace: allocated 294 pages with 4 groups82server # [ 0.000000] rcu: Hierarchical RCU implementation.83server # [ 0.000000] rcu: RCU event tracing is enabled.84server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2.85server # [ 0.000000] Trampoline variant of Tasks RCU enabled.86server # [ 0.000000] Rude variant of Tasks RCU enabled.87server # [ 0.000000] Tracing variant of Tasks RCU enabled.88server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.89server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=290server # [ 0.000000] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.91server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.92server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.93server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 094server # [ 0.000000] GICv3: 256 SPIs implemented95server # [ 0.000000] GICv3: 0 Extended SPIs implemented96server # [ 0.000000] Root IRQ handler: gic_handle_irq97server # [ 0.000000] GICv3: GICv3 features: 16 PPIs98server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=099server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000100server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]101server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b00000 (indirect, esz 8, psz 64K, shr 1)102server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b10000 (flat, esz 8, psz 64K, shr 1)103server # [ 0.000000] GICv3: using LPI property table @0x0000000100b20000104server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @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.000039] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns110server # [ 0.003290] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)111server # [ 0.014874] Console: colour dummy device 80x25112server # [ 0.016605] printk: legacy console [tty0] enabled113server # [ 0.022301] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)114server # [ 0.022696] pid_max: default: 32768 minimum: 301115server # [ 0.025254] LSM: initializing lsm=capability,landlock,yama,bpf,ima116server # [ 0.026735] landlock: Up and running.117server # [ 0.026783] Yama: becoming mindful.118server # [ 0.029336] LSM support for eBPF active119server # [ 0.032164] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)120server # [ 0.032527] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)121server # [ 0.070526] rcu: Hierarchical SRCU implementation.122server # [ 0.070617] rcu: Max phase no-delay instances is 1000.123server # [ 0.071710] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level124server # [ 0.079658] fsl-mc MSI: its@8080000 domain created125server # [ 0.081511] EFI services will not be available.126server # [ 0.083110] smp: Bringing up secondary CPUs ...127server # [ 0.086746] Detected PIPT I-cache on CPU1128server # [ 0.088055] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000129server # [ 0.088660] GICv3: CPU1: using allocated LPI pending table @0x0000000100b50000130server # [ 0.090288] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]131server # [ 0.093218] smp: Brought up 1 node, 2 CPUs132server # [ 0.093466] SMP: Total of 2 processors activated.133server # [ 0.093512] CPU: All CPU(s) started at EL1134server # [ 0.093926] CPU features: detected: Branch Target Identification135server # [ 0.093983] CPU features: detected: 32-bit EL0 Support136server # [ 0.094013] CPU features: detected: 32-bit EL1 Support137server # [ 0.094036] CPU features: detected: ARMv8.4 Translation Table Level138server # [ 0.094066] CPU features: detected: Instruction cache invalidation not required for I/D coherence139server # [ 0.094101] CPU features: detected: Data cache clean to the PoU not required for I/D coherence140server # [ 0.094149] CPU features: detected: Common not Private translations141server # [ 0.094172] CPU features: detected: CRC32 instructions142server # [ 0.094193] CPU features: detected: Data cache clean to Point of Deep Persistence143server # [ 0.094221] CPU features: detected: Data cache clean to Point of Persistence144server # [ 0.094249] CPU features: detected: Data independent timing control (DIT)145server # [ 0.094272] CPU features: detected: E0PD146server # [ 0.094295] CPU features: detected: Enhanced Counter Virtualization147server # [ 0.094318] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)148server # [ 0.094342] CPU features: detected: Enhanced Privileged Access Never149server # [ 0.094364] CPU features: detected: Enhanced Virtualization Traps150server # [ 0.094387] CPU features: detected: Fine Grained Traps151server # [ 0.094408] CPU features: detected: Guarded Control Stack (GCS)152server # [ 0.094469] CPU features: detected: Generic authentication (IMP DEF algorithm)153server # [ 0.094554] CPU features: detected: RCpc load-acquire (LDAPR)154server # [ 0.094595] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)155server # [ 0.094619] CPU features: detected: LSE atomic instructions156server # [ 0.094640] CPU features: detected: Memory Copy and Memory Set instructions157server # [ 0.094664] CPU features: detected: Privileged Access Never158server # [ 0.094701] CPU features: detected: PMUv3159server # [ 0.094720] CPU features: detected: SCTLR2160server # [ 0.094742] CPU features: detected: RAS Extension Support161server # [ 0.094793] CPU features: detected: RASv1p1 Extension Support162server # [ 0.094815] CPU features: detected: Random Number Generator163server # [ 0.094841] CPU features: detected: Speculation barrier (SB)164server # [ 0.094862] CPU features: detected: Stage-2 Force Write-Back165server # [ 0.094883] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality166server # [ 0.094909] CPU features: detected: TLB range maintenance instructions167server # [ 0.094931] CPU features: detected: WFx with timeout168server # [ 0.094994] CPU features: detected: Scalable Matrix Extension169server # [ 0.095020] CPU features: detected: FA64170server # [ 0.095039] CPU features: detected: SME2171server # [ 0.095057] CPU features: detected: Speculative Store Bypassing Safe (SSBS)172server # [ 0.095080] CPU features: detected: Scalable Vector Extension173server # [ 0.100586] alternatives: applying system-wide alternatives174server # [ 0.115477] CPU features: detected: Hardware dirty bit management on CPU0-1175server # [ 0.116092] SVE: maximum available vector length 256 bytes per vector176server # [ 0.116168] SVE: default vector length 64 bytes per vector177server # [ 0.117087] SME: minimum available vector length 16 bytes per vector178server # [ 0.117133] SME: maximum available vector length 256 bytes per vector179server # [ 0.117165] SME: default vector length 32 bytes per vector180server # [ 0.129958] Memory: 3904048K/4194304K available (24320K kernel code, 7090K rwdata, 26572K rodata, 4736K init, 1103K bss, 241772K reserved, 32768K cma-reserved)181server # [ 0.152519] devtmpfs: initialized182server # [ 0.180596] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear)183server # [ 0.180891] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear).184server # [ 0.183242] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL185server # [ 0.183308] 0 pages in range for non-PLT usage186server # [ 0.183355] 508272 pages in range for PLT usage187server # [ 0.185957] pinctrl core: initialized pinctrl subsystem188server # [ 0.195798] DMI not present or invalid.189server # [ 0.213963] NET: Registered PF_NETLINK/PF_ROUTE protocol family190server # [ 0.226482] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations191server # [ 0.227979] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations192server # [ 0.228897] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations193server # [ 0.229175] audit: initializing netlink subsys (disabled)194server # [ 0.231027] audit: type=2000 audit(0.144:1): state=initialized audit_enabled=0 res=1195server # [ 0.237332] thermal_sys: Registered thermal governor 'fair_share'196server # [ 0.237388] thermal_sys: Registered thermal governor 'bang_bang'197server # [ 0.237446] thermal_sys: Registered thermal governor 'step_wise'198server # [ 0.237477] thermal_sys: Registered thermal governor 'user_space'199server # [ 0.237503] thermal_sys: Registered thermal governor 'power_allocator'200server # [ 0.238259] cpuidle: using governor ladder201server # [ 0.238605] cpuidle: using governor menu202server # [ 0.240244] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.203server # [ 0.240994] ASID allocator initialised with 65536 entries204server # [ 0.247264] Serial: AMBA PL011 UART driver205server # [ 0.301776] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1206server # [ 0.305135] printk: console [ttyAMA0] enabled207server # [ 0.367431] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages208server # [ 0.367513] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page209server # [ 0.367553] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages210server # [ 0.367581] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page211server # [ 0.367608] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages212server # [ 0.367633] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page213server # [ 0.367660] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages214server # [ 0.367685] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page215server # [ 0.403144] fbcon: Taking over console216server # [ 0.403399] ACPI: Interpreter disabled.217server # [ 0.412474] iommu: Default domain type: Translated218server # [ 0.412541] iommu: DMA domain TLB invalidation policy: strict mode219server # [ 0.415974] SCSI subsystem initialized220server # [ 0.423047] usbcore: registered new interface driver usbfs221server # [ 0.425617] usbcore: registered new interface driver hub222server # [ 0.426168] usbcore: registered new device driver usb223server # [ 0.432632] pps_core: LinuxPPS API ver. 1 registered224server # [ 0.432849] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>225server # [ 0.432934] PTP clock support registered226server # [ 0.433471] EDAC MC: Ver: 3.0.0227server # [ 0.439018] scmi_core: SCMI protocol bus registered228server # [ 0.444311] FPGA manager framework229server # [ 0.453302] vgaarb: loaded230server # [ 0.460818] clocksource: Switched to clocksource arch_sys_counter231server # [ 0.467394] VFS: Disk quotas dquot_6.6.0232server # [ 0.467717] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)233server # [ 0.469291] netfs: FS-Cache loaded234server # [ 0.471840] pnp: PnP ACPI: disabled235server # [ 0.502009] NET: Registered PF_INET protocol family236server # [ 0.503003] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)237server # [ 0.599334] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)238server # [ 0.599510] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)239server # [ 0.599625] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)240server # [ 0.600014] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)241server # [ 0.600386] TCP: Hash tables configured (established 32768 bind 32768)242server # [ 0.603115] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)243server # [ 0.603545] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)244server # [ 0.604456] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)245server # [ 0.607885] NET: Registered PF_UNIX/PF_LOCAL protocol family246server # [ 0.608241] NET: Registered PF_XDP protocol family247server # [ 0.608389] PCI: CLS 0 bytes, default 64248server # [ 0.611795] Trying to unpack rootfs image as initramfs...249server # [ 0.617870] kvm [1]: HYP mode not available250server # [ 0.768067] Initialise system trusted keyrings251server # [ 0.769301] workingset: timestamp_bits=42 max_order=20 bucket_order=0252server # [ 0.774763] squashfs: version 4.0 (2009/01/31) Phillip Lougher253server # [ 0.775290] 9p: Installing v9fs 9p2000 file system support254server # [ 0.838439] Key type asymmetric registered255server # [ 0.838569] Asymmetric key parser 'x509' registered256server # [ 0.838917] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)257server # [ 0.843326] io scheduler mq-deadline registered258server # [ 0.843522] io scheduler kyber registered259server # [ 0.887069] pl061_gpio 9030000.pl061: PL061 GPIO chip registered260server # [ 0.893400] ledtrig-cpu: registered to indicate activity on CPUs261server # [ 0.897052] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:262server # [ 0.898616] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000263server # [ 0.899028] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000264server # [ 0.899115] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000265server # [ 0.899548] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits266server # [ 0.899937] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]267server # [ 0.901540] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00268server # [ 0.901892] pci_bus 0000:00: root bus resource [bus 00-ff]269server # [ 0.902000] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]270server # [ 0.902065] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]271server # [ 0.902107] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]272server # [ 0.906169] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint273server # [ 0.913900] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint274server # [ 0.914134] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]275server # [ 0.914194] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]276server # [ 0.914241] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]277server # [ 0.914308] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]278server # [ 0.914755] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint279server # [ 0.914825] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]280server # [ 0.914856] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]281server # [ 0.914888] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282server # [ 0.915250] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint283server # [ 0.915318] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]284server # [ 0.915348] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]285server # [ 0.915379] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]286server # [ 0.915756] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint287server # [ 0.915832] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]288server # [ 0.915867] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]289server # [ 0.915904] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290server # [ 0.916279] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint291server # [ 0.916354] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]292server # [ 0.916388] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]293server # [ 0.916424] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]294server # [ 0.916803] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint295server # [ 0.916877] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]296server # [ 0.916911] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]297server # [ 0.916948] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298server # [ 0.919451] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint299server # [ 0.920098] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]300server # [ 0.921979] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]301server # [ 0.922038] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]302server # [ 0.922080] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]303server # [ 0.923203] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint304server # [ 0.923393] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]305server # [ 0.923438] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]306server # [ 0.924931] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint307server # [ 0.926880] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]308server # [ 0.927058] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]309server # [ 0.930637] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint310server # [ 0.930970] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]311server # [ 0.932090] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint312server # [ 0.933320] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]313server # [ 0.933369] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]314server # [ 0.933413] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]315server # [ 0.934610] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint316server # [ 0.935104] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]317server # [ 0.935196] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]318server # [ 0.936078] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]319server # [ 0.944307] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned320server # [ 0.944508] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned321server # [ 0.944614] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned322server # [ 0.945030] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned323server # [ 0.945111] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned324server # [ 0.945162] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned325server # [ 0.945210] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned326server # [ 0.945255] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned327server # [ 0.947460] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned328server # [ 0.947793] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned329server # [ 0.948046] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned330server # [ 0.948107] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned331server # [ 0.948585] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned332server # [ 0.948831] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned333server # [ 0.952750] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned334server # [ 0.952802] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned335server # [ 0.952841] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned336server # [ 0.952878] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned337server # [ 0.952917] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned338server # [ 0.953851] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned339server # [ 0.954077] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned340server # [ 0.954217] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned341server # [ 0.954293] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned342server # [ 0.954891] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned343server # [ 0.955619] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned344server # [ 0.956224] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned345server # [ 0.956636] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned346server # [ 0.956702] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned347server # [ 0.956742] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned348server # [ 0.957280] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned349server # [ 0.957340] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned350server # [ 0.957383] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned351server # [ 0.957430] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned352server # [ 0.957474] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned353server # [ 0.958765] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]354server # [ 0.961527] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]355server # [ 0.961685] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]356server # [ 0.969929] pci 0000:00:0a.0: enabling device (0000 -> 0002)357server # [ 1.043115] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)358server # [ 1.048087] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)359server # [ 1.052660] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)360server # [ 1.056461] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)361server # [ 1.059699] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)362server # [ 1.063118] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)363server # [ 1.069095] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)364server # [ 1.070952] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)365server # [ 1.073237] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)366server # [ 1.076725] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)367server # [ 1.080655] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)368server # [ 1.100120] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled369server # [ 1.115031] msm_serial: driver initialized370server # [ 1.116481] SuperH (H)SCI(F) driver initialized371server # [ 1.117278] STM32 USART driver initialized372server # [ 1.171376] loop: module loaded373server # [ 1.171922] virtio_blk virtio5: 2/0/0 default/read/poll queues374server # [ 1.176361] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)375server # [ 1.187911] megasas: 07.734.00.00-rc1376server # [ 1.192992] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]377server # [ 1.197324] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000378server # [ 1.197849] Intel/Sharp Extended Query Table at 0x0031379server # [ 1.199392] Using buffer write method380server # [ 1.200096] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]381server # [ 1.202330] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000382server # [ 1.202445] Intel/Sharp Extended Query Table at 0x0031383server # [ 1.203377] Using buffer write method384server # [ 1.203509] Concatenating MTD devices:385server # [ 1.203543] (0): "0.flash"386server # [ 1.203568] (1): "0.flash"387server # [ 1.203590] into device "0.flash"388server # [ 1.712389] Freeing initrd memory: 25488K389server # [ 1.822842] tun: Universal TUN/TAP device driver, 1.6390server # [ 1.837123] thunder_xcv, ver 1.0391server # [ 1.837321] thunder_bgx, ver 1.0392server # [ 1.837481] nicpf, ver 1.0393server # [ 1.840422] e1000: Intel(R) PRO/1000 Network Driver394server # [ 1.840469] e1000: Copyright (c) 1999-2006 Intel Corporation.395server # [ 1.840614] e1000e: Intel(R) PRO/1000 Network Driver396server # [ 1.840643] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.397server # [ 1.840765] igb: Intel(R) Gigabit Ethernet Network Driver398server # [ 1.840794] igb: Copyright (c) 2007-2014 Intel Corporation.399server # [ 1.841755] igbvf: Intel(R) Gigabit Virtual Function Network Driver400server # [ 1.841812] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.401server # [ 1.843040] sky2: driver version 1.30402server # [ 1.853140] ehci-pci 0000:00:0a.0: EHCI Host Controller403server # [ 1.853495] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1404server # [ 1.855809] usbcore: registered new interface driver usb-storage405server # [ 1.856553] usbcore: registered new interface driver usbserial_generic406server # [ 1.856805] usbserial: USB Serial support registered for generic407server # [ 1.860579] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000408server # [ 1.861478] hv_vmbus: registering driver hyperv_keyboard409server # [ 1.868714] rtc-pl031 9010000.pl031: registered as rtc0410server # [ 1.869168] rtc-pl031 9010000.pl031: setting system clock to 2026-10-06T23:58:16 UTC (1791331096)411server # [ 1.870842] i2c_dev: i2c /dev entries driver412server # [ 1.875292] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00413server # [ 1.882600] hub 1-0:1.0: USB hub found414server # [ 1.883902] hub 1-0:1.0: 6 ports detected415server # [ 1.887297] sdhci: Secure Digital Host Controller Interface driver416server # [ 1.887360] sdhci: Copyright(c) Pierre Ossman417server # [ 1.888767] Synopsys Designware Multimedia Card Interface Driver418server # [ 1.891069] sdhci-pltfm: SDHCI platform and OF driver helper419server # [ 1.900924] hid: raw HID events driver (C) Jiri Kosina420server # [ 1.903944] usbcore: registered new interface driver usbhid421server # [ 1.904004] usbhid: USB HID core driver422server # [ 1.912272] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available423server # [ 1.922136] drop_monitor: Initializing network drop monitor service424server # [ 1.923183] NET: Registered PF_INET6 protocol family425server # [ 1.932552] Segment Routing with IPv6426server # [ 1.933162] In-situ OAM (IOAM) with IPv6427server # [ 1.933955] NET: Registered PF_PACKET protocol family428server # [ 1.935758] 9pnet: Installing 9P2000 support429server # [ 1.940653] Key type dns_resolver registered430server # [ 1.986149] registered taskstats version 1431server # [ 1.988120] Loading compiled-in X.509 certificates432server # [ 2.050437] Demotion targets for Node 0: null433server # [ 2.051482] Key type .fscrypt registered434server # [ 2.051669] Key type fscrypt-provisioning registered435server # [ 2.055366] ima: No TPM chip found, activating TPM-bypass!436server # [ 2.055474] ima: Allocated hash algorithm: sha1437server # [ 2.057119] ima: No architecture policies found438server # [ 2.064833] input: gpio-keys as /devices/platform/gpio-keys/input/input0439server # [ 2.108033] clk: Disabling unused clocks440server # [ 2.108243] PM: genpd: Disabling unused power domains441server # [ 2.146277] usb 1-1: new high-speed USB device number 2 using ehci-pci442server # [ 2.367909] 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.433492] 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.434782] Freeing unused kernel memory: 4736K445server # [ 2.435830] Run /init as init process446server # [ 2.565232] usb 1-2: new high-speed USB device number 3 using ehci-pci447server # [ 2.565490] systemd[1]: Successfully made /usr/ read-only.448server # [ 2.773659] 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.774423] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0450server # [ 2.920427] 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 # [ 2.920638] systemd[1]: Detected virtualization qemu.452server # [ 2.920937] systemd[1]: Detected architecture arm64.453server # [ 2.921006] systemd[1]: Running in initrd.454server # [ 2.931488] systemd[1]: Initializing machine ID from random generator.455server # [ 2.935252] systemd[1]: Hostname set to <server>.456server # [ 3.544975] systemd[1]: Queued start job for default target Initrd Default Target.457server # [ 3.612084] systemd[1]: Created slice Slice /system/modprobe.458server # [ 3.615312] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.459server # [ 3.617769] systemd[1]: Expecting device /dev/disk/by-label/nixos...460server # [ 3.618479] systemd[1]: Reached target Path Units.461server # [ 3.618690] systemd[1]: Reached target Slice Units.462server # [ 3.618831] systemd[1]: Reached target Swaps.463server # [ 3.618977] systemd[1]: Reached target Timer Units.464server # [ 3.623976] systemd[1]: Listening on D-Bus System Message Bus Socket.465server # [ 3.627036] systemd[1]: Listening on Journal Socket (/dev/log).466server # [ 3.627990] systemd[1]: Listening on Journal Sockets.467server # [ 3.628781] systemd[1]: Listening on udev Control Socket.468server # [ 3.629915] systemd[1]: Listening on udev Kernel Socket.469server # [ 3.630570] systemd[1]: Reached target Socket Units.470server # [ 3.648801] systemd[1]: Starting Create List of Static Device Nodes...471server # [ 3.667052] systemd[1]: Starting Load Kernel Module 9pnet_virtio...472server # [ 3.668793] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs473server # [ 3.723410] systemd[1]: Mounting Kernel Configuration File System...474server # [ 3.811739] systemd[1]: Starting Journal Service...475server # [ 3.853429] systemd[1]: Starting Load Kernel Modules...476server # [ 3.863492] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki477server # [ 3.878582] systemd[1]: Starting Coldplug All udev Devices...478server # [ 3.983384] systemd[1]: Finished Create List of Static Device Nodes.479server # [ 4.060199] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.480server # [ 4.078346] systemd[1]: Finished Load Kernel Module 9pnet_virtio.481server # [ 4.096455] systemd[1]: Mounted Kernel Configuration File System.482server # [ 4.162475] systemd-journald[81]: Collecting audit messages is disabled.483server # [ 4.175056] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...484server # [ 4.470184] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.485server # [ 4.487068] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev486server # [ 4.490613] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0487server # [ 4.509545] [drm] features: -virgl +edid -resource_blob -host_visible488server # [ 4.509806] [drm] features: -context_init489server # [ 4.513191] [drm] number of scanouts: 1490server # [ 4.513305] [drm] number of cap sets: 0491server # [ 4.638738] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic492server # [ 4.638885] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0493server # [ 4.662624] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.494server # [ 4.742696] Console: switching to colour frame buffer device 160x50495server # [ 4.753861] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device496server # [ 4.771978] systemd[1]: Starting Create Static Device Nodes in /dev...497server # [ 4.811476] systemd[1]: Finished Load Kernel Modules.498server # [ 4.878278] systemd[1]: Starting Apply Kernel Variables...499server # [ 5.170947] systemd[1]: Finished Create Static Device Nodes in /dev.500server # [ 5.183224] systemd[1]: Reached target Preparation for Local File Systems.501server # [ 5.189978] systemd[1]: Reached target Local File Systems.502server # [ 5.238072] systemd[1]: Starting Rule-based Manager for Device Events and Files...503server # [ 5.259892] systemd[1]: Finished Apply Kernel Variables.504server # [ 5.452210] systemd[1]: Started Journal Service.505server # [ 5.317409] systemd-modules-load[82]: Using 2 probe threads506server # [ 5.331689] systemd-modules-load[82]: Module 'virtio_balloon' is built in507server # [ 5.348057] systemd-modules-load[82]: Module 'virtio_console' is built in508server # [ 5.373372] systemd-modules-load[82]: Inserted module 'dm_mod'509server # [ 5.376061] systemd-modules-load[82]: Module 'virtio_rng' is built in510server # [ 5.383472] systemd-modules-load[82]: Inserted module 'virtio_gpu'511server # [ 5.392366] systemd[1]: Starting Create System Files and Directories...512server # [ 5.654267] systemd-udevd[89]: Using default interface naming scheme 'v260'.513server # [ 5.663942] systemd[1]: Finished Create System Files and Directories.514server # [ 5.955285] systemd[1]: Started Rule-based Manager for Device Events and Files.515server # [ 6.335924] systemd[1]: Starting Virtual Console Setup...516server # [ 6.661897] systemd-vconsole-setup[111]: Configuration of first virtual console was skipped, ignoring remaining ones.517server # [ 6.685657] systemd[1]: Finished Virtual Console Setup.518server # [ 10.870060] systemd[1]: Finished Coldplug All udev Devices.519server # [ 10.879604] systemd[1]: Reached target System Initialization.520server # [ 10.882305] systemd[1]: Reached target Basic System.521server # [ 13.681363] (udev-worker)[127]: Network interface NamePolicy= disabled on kernel command line.522server # [ 13.725416] (udev-worker)[115]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.523server # [ 13.738830] (udev-worker)[115]: Network interface NamePolicy= disabled on kernel command line.524server # [ 13.875550] systemd[1]: Found device /dev/disk/by-label/nixos.525server # [ 13.912058] systemd[1]: Reached target Initrd Root Device.526server # [ 13.933345] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...527server # [ 14.319524] systemd-fsck[139]: nixos: clean, 12/65536 files, 13019/262144 blocks528server # [ 14.365473] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.529server # [ 14.397879] systemd[1]: Mounting /sysroot...530server # [ 14.879589] EXT4-fs (vda): mounted filesystem a7942eb1-6834-4b32-a25c-60fba2d0e2da r/w with ordered data mode. Quota mode: none.531server # [ 14.769905] systemd[1]: Mounted /sysroot.532server # [ 14.782628] systemd[1]: Reached target Initrd Root File System.533server # [ 14.802232] systemd[1]: Starting Mountpoints Configured in the Real Root...534server # [ 14.952360] systemd-sysroot-fstab-check[147]: /sysroot should be mounted in the initrd, will request daemon-reload.535server # [ 14.977251] systemd[1]: Reload requested from client PID 147 ('systemd-sysroot') (unit initrd-parse-etc.service)...536server # [ 14.981783] systemd[1]: Reloading...537server # [ 16.187305] systemd[1]: Reloading finished in 1197 ms.538server # [ 16.251938] systemd-sysroot-fstab-check[147]: Requesting initrd-fs.target/start/replace...539server # [ 16.271634] systemd-sysroot-fstab-check[147]: Requesting swap.target/start/replace...540server # [ 16.293615] systemd[1]: initrd-parse-etc.service: Deactivated successfully.541server # [ 16.298227] systemd[1]: Finished Mountpoints Configured in the Real Root.542server # [ 16.300635] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.543server # [ 16.356847] systemd[1]: Mounting /sysroot/nix/.rw-store...544server # [ 16.407707] systemd[1]: Mounting /sysroot/run...545server # [ 16.456811] systemd[1]: Starting Load Kernel Module 9pnet_virtio...546server # [ 16.630559] systemd[1]: Mounted /sysroot/nix/.rw-store.547server # [ 16.678928] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.548server # [ 16.710449] systemd[1]: Finished Load Kernel Module 9pnet_virtio.549server # [ 16.775494] systemd[1]: Mounted /sysroot/run.550server # [ 16.865492] systemd[1]: Mounting /sysroot/nix/.ro-store...551server # [ 16.919800] systemd[1]: Mounting /sysroot/tmp/shared...552server # [ 16.996651] systemd[1]: Mounting /sysroot/tmp/xchg...553server # [ 17.100093] systemd[1]: Starting rw-sysroot-nix-store.service...554server # [ 17.689233] systemd[1]: Mounted /sysroot/nix/.ro-store.555server # [ 17.694051] systemd[1]: Mounted /sysroot/tmp/shared.556server # [ 17.699690] systemd[1]: Mounted /sysroot/tmp/xchg.557server # [ 17.702090] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.558server # [ 17.711151] systemd[1]: Finished rw-sysroot-nix-store.service.559server # [ 17.818680] systemd[1]: Mounting /sysroot/nix/store...560server # [ 18.089298] systemd[1]: Mounted /sysroot/nix/store.561server # [ 18.114554] systemd[1]: Reached target Initrd File Systems.562server # [ 18.130542] systemd[1]: Starting Find NixOS closure...563server # [ 18.155699] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...564server # [ 18.348893] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.565server # [ 18.721151] systemd[1]: Finished Find NixOS closure.566server # [ 18.735530] systemd[1]: Reached target Initrd Default Target.567server # [ 18.787333] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...568server # [ 19.165904] systemd[1]: Stopped target Initrd Default Target.569server # [ 19.179620] systemd[1]: Stopped target Basic System.570server # [ 19.187309] systemd[1]: Stopped target Initrd Root Device.571server # [ 19.200893] systemd[1]: Stopped target Path Units.572server # [ 19.204362] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.573server # [ 19.215583] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.574server # [ 19.223688] systemd[1]: Stopped target Slice Units.575server # [ 19.229992] systemd[1]: Stopped target Socket Units.576server # [ 19.231118] systemd[1]: Stopped target System Initialization.577server # [ 19.238256] systemd[1]: Stopped target Swaps.578server # [ 19.240696] systemd[1]: Stopped target Timer Units.579server # [ 19.243761] systemd[1]: dbus.socket: Deactivated successfully.580server # [ 19.250713] systemd[1]: Closed D-Bus System Message Bus Socket.581server # [ 19.258069] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.582server # [ 19.261957] systemd[1]: Stopped Find NixOS closure.583server # [ 19.306572] systemd[1]: Starting Load Kernel Module 9pnet_virtio...584server # [ 19.367583] systemd[1]: Starting rw-sysroot-nix-store.service...585server # [ 19.371127] systemd[1]: systemd-sysctl.service: Deactivated successfully.586server # [ 19.383930] systemd[1]: Stopped Apply Kernel Variables.587server # [ 19.394617] systemd[1]: systemd-modules-load.service: Deactivated successfully.588server # [ 19.413627] systemd[1]: Stopped Load Kernel Modules.589server # [ 19.421574] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.590server # [ 19.437966] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.591server # [ 19.454371] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.592server # [ 19.461466] systemd[1]: Stopped Create System Files and Directories.593server # [ 19.467231] systemd[1]: Stopped target Local File Systems.594server # [ 19.473771] systemd[1]: Stopped target Preparation for Local File Systems.595server # [ 19.482466] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.596server # [ 19.491133] systemd[1]: Stopped Coldplug All udev Devices.597server # [ 19.495597] systemd[1]: systemd-udev-trigger.service: Consumed 5.603s CPU time over 15.756s wall clock time, 9.3M memory peak.598server # [ 19.504896] systemd[1]: Stopping Rule-based Manager for Device Events and Files...599server # [ 19.509800] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.600server # [ 19.521907] systemd[1]: Stopped Virtual Console Setup.601server # [ 19.640709] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.602server # [ 19.648641] systemd[1]: Finished Load Kernel Module 9pnet_virtio.603server # [ 19.667423] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.604server # [ 19.677330] systemd[1]: Finished rw-sysroot-nix-store.service.605server # [ 19.728758] systemd[1]: initrd-cleanup.service: Deactivated successfully.606server # [ 19.739190] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.607server # [ 20.031152] systemd[1]: systemd-udevd.service: Deactivated successfully.608server # [ 20.038905] systemd[1]: Stopped Rule-based Manager for Device Events and Files.609server # [ 20.042514] systemd[1]: systemd-udevd.service: Consumed 10.789s CPU time over 14.938s wall clock time, 23.2M memory peak.610server # [ 20.047567] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.611server # [ 20.051285] systemd[1]: Closed udev Control Socket.612server # [ 20.067252] systemd[1]: Starting Cleanup udev Database...613server # [ 20.068618] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.614server # [ 20.075512] systemd[1]: Stopped Create Static Device Nodes in /dev.615server # [ 20.077337] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.616server # [ 20.079482] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.617server # [ 20.082200] systemd[1]: kmod-static-nodes.service: Deactivated successfully.618server # [ 20.083882] systemd[1]: Stopped Create List of Static Device Nodes.619server # [ 20.232386] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.620server # [ 20.235302] systemd[1]: Finished Cleanup udev Database.621server # [ 20.250402] systemd[1]: Reached target Switch Root.622server # [ 20.267875] systemd[1]: Starting NixOS Activation...623server # [ 21.917477] initrd-nixos-activation-start[239]: booting system configuration /nix/store/ll4ryvjnmk0mkw603yy13nc08z02p028-nixos-system-server-test624server # [ 22.519164] initrd-nixos-activation-start[239]: running activation script...625server # [ 26.521969] initrd-nixos-activation-start[262]: setting up /etc...626server: Guest root shell did not produce any data yet...627server: To debug, enter the VM and run 'systemctl status backdoor.service'.628server # [ 29.263752] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.629server # [ 29.266662] systemd[1]: Finished NixOS Activation.630server # [ 29.269513] systemd[1]: initrd-nixos-activation.service: Consumed 4.711s CPU time over 8.995s wall clock time, 22.8M memory peak.631server # [ 29.284859] systemd[1]: Starting Switch Root...632server # [ 29.405262] systemd[1]: Switching root.633server # [ 29.687251] systemd-journald[81]: Received SIGTERM from PID 1 (systemd).634server # [ 32.217238] 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)635server # [ 32.218478] systemd[1]: Detected virtualization qemu.636server # [ 32.219654] systemd[1]: Detected architecture arm64.637server # [ 32.221134] systemd[1]: Detected first boot.638server # [ 32.262204] systemd[1]: Initializing machine ID from random generator.639server # [ 33.505205] systemd[1]: bpf-restrict-fs: LSM BPF program attached640server # [ 34.930952] systemd[1]: Applying preset policy.641server # [ 38.977458] systemd[1]: Populated /etc with preset unit settings.642server # [ 43.454265] systemd[1]: initrd-switch-root.service: Deactivated successfully.643server # [ 43.456907] systemd[1]: Stopped initrd-switch-root.service.644server # [ 43.482849] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.645server # [ 43.501000] systemd[1]: Created slice Slice /system/getty.646server # [ 43.518161] systemd[1]: Created slice User and Session Slice.647server # [ 43.524421] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.648server # [ 43.531837] systemd[1]: Started Forward Password Requests to Wall Directory Watch.649server # [ 43.536495] systemd[1]: Expecting device /dev/hvc0...650server # [ 43.540964] systemd[1]: Expecting device /dev/ttyAMA0...651server # [ 43.544820] systemd[1]: Reached target Local Encrypted Volumes.652server # [ 43.549887] systemd[1]: Stopped target initrd-fs.target.653server # [ 43.552057] systemd[1]: Stopped target initrd-root-fs.target.654server # [ 43.557907] systemd[1]: Stopped target initrd-switch-root.target.655server # [ 43.562636] systemd[1]: Reached target Virtual Machines and Containers.656server # [ 43.567011] systemd[1]: Reached target Path Units.657server # [ 43.571446] systemd[1]: Reached target Remote File Systems.658server # [ 43.575052] systemd[1]: Reached target Slice Units.659server # [ 43.578540] systemd[1]: Reached target Swaps.660server # [ 43.618698] systemd[1]: Listening on Process Core Dump Socket.661server # [ 43.645155] systemd[1]: Listening on Credential Encryption/Decryption.662server # [ 43.689044] systemd[1]: Starting Journal Log Access Socket...663server # [ 43.704803] systemd[1]: Listening on Journal Audit Socket.664server # [ 43.723130] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.665server # [ 43.730002] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki666server # [ 43.738753] systemd[1]: Listening on udev Control Socket.667server # [ 43.777527] systemd[1]: Mounting Huge Pages File System...668server # [ 43.816272] systemd[1]: Mounting POSIX Message Queue File System...669server # [ 43.915159] systemd[1]: Mounting Kernel Debug File System...670server # [ 43.996966] systemd[1]: Mounting Kernel Trace File System...671server # [ 44.140700] systemd[1]: Starting Create List of Static Device Nodes...672server # [ 44.275794] systemd[1]: Starting Load Kernel Module 9pnet_virtio...673server # [ 44.288370] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs674server # [ 44.362218] systemd[1]: Mounting Kernel Configuration File System...675server # [ 44.373463] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm676server # [ 44.378744] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore677server # [ 44.498872] systemd[1]: Starting Load Kernel Module fuse...678server # [ 44.514249] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67679server # [ 44.921142] systemd[1]: Starting Journal Service...680server # [ 45.024335] systemd[1]: Starting Load Kernel Modules...681server # [ 45.244770] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...682server # [ 45.418875] systemd[1]: Starting Remount Root and Kernel File Systems...683server # [ 45.439446] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki684server # [ 45.552244] fuse: init (API version 7.45)685server # [ 45.592720] systemd[1]: Starting Coldplug All udev Devices...686server # [ 46.055201] systemd[1]: Listening on Journal Log Access Socket.687server # [ 46.102400] systemd[1]: Mounted Huge Pages File System.688server # [ 46.111407] systemd[1]: Mounted POSIX Message Queue File System.689server # [ 46.126140] systemd[1]: Mounted Kernel Debug File System.690server # [ 46.138175] systemd[1]: Mounted Kernel Trace File System.691server # [ 46.163029] systemd[1]: Finished Create List of Static Device Nodes.692server # [ 46.178688] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.693server # [ 46.188069] systemd[1]: Finished Load Kernel Module 9pnet_virtio.694server # [ 46.303335] systemd[1]: Mounted Kernel Configuration File System.695server # [ 46.327411] systemd[1]: modprobe@fuse.service: Deactivated successfully.696server # [ 46.358283] systemd[1]: Finished Load Kernel Module fuse.697server # [ 46.412128] systemd[1]: Finished Load Kernel Modules.698server # [ 46.559678] systemd[1]: Mounting FUSE Control File System...699server # [ 46.695887] systemd[1]: Starting Firewall...700server # [ 46.710855] systemd-journald[333]: Collecting audit messages is enabled.701server # [ 46.787805] systemd[1]: Starting Apply Kernel Variables...702server # [ 47.007638] systemd[1]: Queued start job for default target Multi-User System.703server # [ 47.023599] systemd[1]: systemd-journald.service: Deactivated successfully.704server # [ 47.028666] systemd[1]: systemd-journald.service: Consumed 1.445s CPU time over 39.564s wall clock time, 9.9M memory peak.705server # [ 47.041260] systemd-modules-load[334]: Using 2 probe threads706server # [ 47.189994] EXT4-fs (vda): re-mounted a7942eb1-6834-4b32-a25c-60fba2d0e2da.707server # [ 47.056193] systemd-modules-load[334]: Module 'atkbd' is built in708server # [ 47.078228] systemd-modules-load[334]: Module 'loop' is built in709server # [ 47.256108] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...710server # [ 47.384052] systemd[1]: Started Journal Service.711server # [ 47.435492] systemd[1]: Finished Remount Root and Kernel File Systems.712server # [ 47.696674] systemd-oomd[335]: No swap; memory pressure usage will be degraded713server # [ 48.051882] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.714server # [ 48.375835] systemd[1]: Mounted FUSE Control File System.715server # [ 48.722041] systemd[1]: Finished Apply Kernel Variables.716server # [ 49.152153] systemd[1]: Starting Flush Journal to Persistent Storage...717server # [ 49.160773] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore718server # [ 49.269393] systemd[1]: Starting Load/Save OS Random Seed...719server # [ 49.271043] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki720server # [ 49.581475] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.721server # [ 49.874877] systemd[1]: Starting Create Static Device Nodes in /dev...722server # [ 50.064004] systemd-journald[333]: Received client request to flush runtime journal.723server # [ 50.599323] systemd[1]: Finished Load/Save OS Random Seed.724server # [ 50.627103] systemd[1]: Reached target First Boot Complete.725server # [ 50.662296] systemd[1]: Finished Flush Journal to Persistent Storage.726server # [ 51.066699] systemd[1]: Finished Create Static Device Nodes in /dev.727server # [ 51.119459] systemd[1]: Reached target Preparation for Local File Systems.728server # [ 51.179989] systemd[1]: Mounting /run/wrappers...729server # [ 51.271625] systemd[1]: Starting Rule-based Manager for Device Events and Files...730server # [ 51.868149] systemd[1]: Mounted /run/wrappers.731server # [ 51.889857] systemd[1]: Reached target Local File Systems.732server # [ 51.973425] systemd[1]: Listening on Boot Loader Control Service Socket.733server # [ 52.044791] systemd[1]: Starting register-nix-paths.service...734server # [ 52.187676] systemd[1]: Starting Create SUID/SGID Wrappers...735server # [ 52.203343] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.736server # [ 52.388996] systemd[1]: Starting Save Transient machine-id to Disk...737server # [ 52.661486] systemd[1]: Starting Create System Files and Directories...738server # [ 54.173382] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.739server # [ 54.242702] systemd[1]: Finished Save Transient machine-id to Disk.740server # [ 55.954168] systemd[1]: Finished Create System Files and Directories.741server # [ 56.197506] systemd[1]: Starting Rebuild Journal Catalog...742server # [ 56.494292] systemd[1]: Starting Record System Boot/Shutdown in UTMP...743server # [ 58.246457] systemd[1]: Finished Record System Boot/Shutdown in UTMP.744server: Guest root shell did not produce any data yet...745server: To debug, enter the VM and run 'systemctl status backdoor.service'.746server # [ 59.236300] systemd[1]: Finished Rebuild Journal Catalog.747server # [ 59.385411] systemd[1]: Starting Update is Completed...748server # [ 60.427776] systemd[1]: Finished Update is Completed.749server # [ 65.502375] systemd-udevd[382]: Using default interface naming scheme 'v260'.750server # [ 66.200067] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.751server # [ 66.233575] systemd[1]: Finished Create SUID/SGID Wrappers.752server # [ 66.249493] systemd[1]: suid-sgid-wrappers.service: Consumed 3.507s CPU time over 14.031s wall clock time, 5.4M memory peak.753server # [ 67.894955] systemd[1]: Started Rule-based Manager for Device Events and Files.754server # [ 69.171534] systemd[1]: Finished register-nix-paths.service.755server # [ 69.631589] mousedev: PS/2 mouse device common for all mice756server # [ 70.561211] systemd[1]: Finished Firewall.757server # [ 74.142145] systemd[1]: Finished Coldplug All udev Devices.758server # [ 74.159180] systemd[1]: Reached target System Initialization.759server # [ 74.170344] systemd[1]: Started Discard unused filesystem blocks once a week.760server # [ 74.182941] systemd[1]: Started Daily Cleanup of Temporary Directories.761server # [ 74.192220] systemd[1]: Reached target Timer Units.762server # [ 74.202766] systemd[1]: Listening on D-Bus System Message Bus Socket.763server # [ 74.214804] systemd[1]: Listening on Nix Daemon Socket.764server # [ 74.220594] systemd[1]: Listening on Hostname Service Socket.765server # [ 74.227296] systemd[1]: Reached target Socket Units.766server # [ 74.234702] systemd[1]: Reached target Basic System.767server # [ 74.271764] systemd[1]: Starting Import lastlog data into lastlog2 database...768server # [ 74.350842] systemd[1]: Starting Name Service Cache Daemon (nsncd)...769server # [ 74.455059] systemd[1]: Starting Post-Boot Actions...770server # [ 74.658868] systemd[1]: Started Reset console on configuration changes.771server # [ 74.854325] systemd[1]: Starting resolvconf update...772server # [ 75.539964] systemd[1]: Finished Post-Boot Actions.773server # [ 75.895565] nsncd[590]: Oct 06 23:59:30.629 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"774server # [ 75.977121] systemd[1]: Starting D-Bus System Message Bus...775server # [ 76.002733] systemd[1]: Started Name Service Cache Daemon (nsncd).776server # [ 76.081664] systemd[1]: Finished Import lastlog data into lastlog2 database.777server # [ 76.104740] systemd[1]: Reached target Host and Network Name Lookups.778server # [ 76.119686] systemd[1]: Reached target User and Group Name Lookups.779server # [ 76.286094] systemd[1]: Starting User Login Management...780server # [ 77.911316] dbus-broker-launch[607]: Looking up NSS user entry for 'systemd-timesync'...781server # [ 78.192084] systemd-logind[612]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)782server # [ 78.211598] dbus-broker-launch[607]: NSS returned no entry for 'systemd-timesync'783server # [ 78.215809] dbus-broker-launch[607]: Invalid user-name in /nix/store/62wal8y6jvsipyjy235plnw6k1qcscn0-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"784server # [ 78.230545] systemd-logind[612]: New seat seat0.785server # [ 78.339369] systemd[1]: Started User Login Management.786server # [ 78.478046] systemd[1]: Starting linger-users.service...787server # [ 78.640367] systemd[1]: Started D-Bus System Message Bus.788server # [ 79.220891] systemd[1]: linger-users.service: Deactivated successfully.789server # [ 79.260948] systemd[1]: Finished linger-users.service.790server # [ 79.279491] dbus-broker-launch[607]: Ready791server # [ 79.646746] systemd[1]: Stopped target Host and Network Name Lookups.792server # [ 79.662278] systemd[1]: Stopping Host and Network Name Lookups...793server # [ 79.673185] systemd[1]: Stopped target User and Group Name Lookups.794server # [ 79.675645] systemd[1]: Stopping User and Group Name Lookups...795server # [ 79.681006] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...796server # [ 79.703260] systemd[1]: nscd.service: Deactivated successfully.797server # [ 79.714613] systemd[1]: Stopped Name Service Cache Daemon (nsncd).798server # [ 79.937741] systemd[1]: Starting Name Service Cache Daemon (nsncd)...799server # [ 80.678976] systemd[1]: Started Name Service Cache Daemon (nsncd).800server # [ 80.691870] nsncd[672]: Oct 06 23:59:35.431 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"801server # [ 80.699770] systemd[1]: Reached target Host and Network Name Lookups.802server # [ 80.711567] systemd[1]: Reached target User and Group Name Lookups.803server # [ 81.119283] systemd[1]: Finished resolvconf update.804server # [ 81.137379] systemd[1]: Reached target Preparation for Network.805server # [ 81.185645] systemd[1]: Starting DHCP Client...806server # [ 81.233017] systemd[1]: Starting Extra networking commands....807server # [ 83.994799] dhcpcd[714]: dhcpcd-10.3.1 starting808server # [ 84.202949] dhcpcd[776]: dev: loaded udev809server # [ 84.349929] dhcpcd[776]: no valid interfaces found810server # [ 84.351838] dhcpcd[776]: no valid interfaces found811server # [ 84.391649] systemd[1]: Finished Extra networking commands..812server # [ 84.402096] systemd[1]: Reached target Network.813server # [ 84.450291] systemd[1]: Starting PostgreSQL Database Server...814server # [ 84.498950] systemd[1]: Starting Permit User Sessions...815server # [ 84.982749] systemd[1]: Finished Permit User Sessions.816server # [ 85.107824] systemd[1]: Started Getty on tty1.817server # [ 85.145209] systemd[1]: Reached target Login Prompts.818server # [ 86.003912] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[794]: Initializing database at /var/lib/postgresql/data819server # [ 87.646157] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: The files belonging to this database system will be owned by user "postgres".820server # [ 87.650931] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: This user must also own the server process.821server # [ 87.754798] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: The database cluster will be initialized with locale "en_US.UTF-8".822server # [ 87.756224] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: The default database encoding has accordingly been set to "UTF8".823server # [ 87.761316] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: The default text search configuration will be set to "english".824server # [ 87.763191] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: Data page checksums are enabled.825server # [ 87.770230] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: fixing permissions on existing directory /var/lib/postgresql/data ... ok826server # [ 87.775395] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: creating subdirectories ... ok827server # [ 87.785399] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: selecting dynamic shared memory implementation ... posix828server: Guest root shell did not produce any data yet...829server: To debug, enter the VM and run 'systemctl status backdoor.service'.830server # [ 89.199583] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: selecting default max_connections ... 100831server # [ 89.850452] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: selecting default shared_buffers ... 128MB832server # [ 101.028205] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: selecting default time zone ... UTC833server # [ 101.084228] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: creating configuration files ... ok834server # [ 104.904926] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: running bootstrap script ... ok835server # [ 114.383222] dhcpcd[776]: timed out836server # [ 114.395752] dhcpcd[776]: timed out837server # [ 114.408424] systemd[1]: Started DHCP Client.838server # [ 115.323917] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: performing post-bootstrap initialization ... ok839server # [ 117.794641] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: syncing data to disk ... ok840server # [ 117.807807] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: initdb: warning: enabling "trust" authentication for local connections841server # [ 117.813837] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: initdb: hint: You can change this by editing pg_hba.conf or using the option -A, or --auth-local and --auth-host, the next time you run initdb.842server # [ 117.822979] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: Success. You can now start the database server using:843server # [ 117.827616] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[808]: /nix/store/wci7v43bmwrfyq70ig1hf0ryax0p916n-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start844server: Guest root shell did not produce any data yet...845server: To debug, enter the VM and run 'systemctl status backdoor.service'.846server # [ 119.530236] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[794]: Validating PostgreSQL configuration...847server # [ 119.949266] wyacxvfngkssr519w1xcwmcaphhkfvhk-postgresql-init[1052]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault848server # [ 120.850908] postgres[1054]: 2026-10-07 00:00:15.608 UTC [1054] LOG: pgaudit extension initialized849server # [ 121.768249] postgres[1054]: 2026-10-07 00:00:16.543 UTC [1054] LOG: pgsodium primary server secret key loaded850server # [ 122.481288] postgres[1054]: 2026-10-07 00:00:17.242 UTC [1054] LOG: vault primary server secret key loaded851server # [ 122.858920] postgres[1054]: 2026-10-07 00:00:17.633 UTC [1054] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.3.0, 64-bit852server # [ 122.877487] postgres[1054]: 2026-10-07 00:00:17.651 UTC [1054] LOG: listening on IPv4 address "0.0.0.0", port 5432853server # [ 122.883500] postgres[1054]: 2026-10-07 00:00:17.653 UTC [1054] LOG: listening on IPv6 address "::", port 5432854server # [ 122.898192] postgres[1054]: 2026-10-07 00:00:17.671 UTC [1054] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"855server # [ 122.999378] postgres[1079]: 2026-10-07 00:00:17.763 UTC [1079] LOG: database system was shut down at 2026-10-07 00:00:09 UTC856server # [ 123.212338] postgres[1082]: 2026-10-07 00:00:17.984 UTC [1082] LOG: TimescaleDB background worker launcher connected to shared catalogs857server # [ 123.253505] postgres[1054]: 2026-10-07 00:00:18.026 UTC [1054] LOG: database system is ready to accept connections858server # [ 123.316926] postgres[1083]: 2026-10-07 00:00:18.036 UTC [1083] FATAL: role "postgres" does not exist859server # [ 123.359945] systemd[1]: Started PostgreSQL Database Server.860server # [ 123.436059] postgres[1084]: 2026-10-07 00:00:18.191 UTC [1084] LOG: pg_cron scheduler started861server # [ 123.449007] postgres[1054]: 2026-10-07 00:00:18.193 UTC [1054] LOG: background worker "pg_net 0.20.4 worker" (PID 1083) exited with exit code 1862server # [ 123.491744] systemd[1]: Starting Supabase Database Initialization...863server # [ 123.839341] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Waiting for PostgreSQL to be ready...864server # [ 124.368008] postgres[1090]: ::1 2026-10-07 00:00:19.137 UTC [1090] root@root FATAL: role "root" does not exist865server # [ 124.414302] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: PostgreSQL is ready866server # [ 124.423404] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Creating postgres role...867server # [ 124.522399] postgres[1092]: 2026-10-07 00:00:19.283 UTC [1092] FATAL: role "postgres" does not exist868server # [ 124.571122] postgres[1054]: 2026-10-07 00:00:19.338 UTC [1054] LOG: background worker "pg_net 0.20.4 worker" (PID 1092) exited with exit code 1869server # [ 125.070599] postgres[1098]: ::1 2026-10-07 00:00:19.826 UTC [1098] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN;870server # [ 125.143796] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1091]: CREATE ROLE871server # [ 125.611539] postgres[1109]: ::1 2026-10-07 00:00:20.373 UTC [1109] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres;872server # [ 125.659464] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1105]: ALTER DATABASE873server # [ 125.755691] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000000-initial-schema.sql874server # [ 126.189467] postgres[1117]: ::1 2026-10-07 00:00:20.955 UTC [1117] postgres@postgres LOG: statement: create publication supabase_realtime;875server # [ 126.227192] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: CREATE PUBLICATION876server # [ 126.230858] postgres[1117]: ::1 2026-10-07 00:00:21.001 UTC [1117] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls;877server # [ 126.236367] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: ALTER ROLE878server # [ 126.239081] postgres[1117]: ::1 2026-10-07 00:00:21.012 UTC [1117] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication;879server # [ 126.252722] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: CREATE ROLE880server # [ 126.255612] postgres[1117]: ::1 2026-10-07 00:00:21.023 UTC [1117] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls;881server # [ 126.262396] postgres[1117]: ::1 2026-10-07 00:00:21.033 UTC [1117] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin;882server # [ 126.274565] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: CREATE ROLE883server # [ 126.282214] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: GRANT ROLE884server # [ 126.295934] postgres[1117]: ::1 2026-10-07 00:00:21.046 UTC [1117] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin;885server # [ 126.298568] postgres[1117]: ::1 2026-10-07 00:00:21.054 UTC [1117] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls;886server # [ 126.301708] postgres[1117]: ::1 2026-10-07 00:00:21.062 UTC [1117] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user;887server # [ 126.303026] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: GRANT888server # [ 126.305150] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: CREATE ROLE889server # [ 126.306434] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: GRANT ROLE890server # [ 126.307845] postgres[1117]: ::1 2026-10-07 00:00:21.077 UTC [1117] postgres@postgres LOG: statement: create schema if not exists extensions;891server # [ 126.330968] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: CREATE SCHEMA892server # [ 126.336941] postgres[1117]: ::1 2026-10-07 00:00:21.110 UTC [1117] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions;893server # [ 129.015623] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: CREATE EXTENSION894server # [ 129.037698] postgres[1117]: ::1 2026-10-07 00:00:23.779 UTC [1117] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions;895server # [ 129.919268] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: CREATE EXTENSION896server # [ 129.927144] postgres[1117]: ::1 2026-10-07 00:00:24.698 UTC [1117] postgres@postgres LOG: statement: create role anon nologin noinherit;897server # [ 129.934732] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: CREATE ROLE898server # [ 129.938639] postgres[1117]: ::1 2026-10-07 00:00:24.713 UTC [1117] postgres@postgres LOG: statement: create role authenticated nologin noinherit;899server # [ 129.950317] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: CREATE ROLE900server # [ 129.953555] postgres[1117]: ::1 2026-10-07 00:00:24.727 UTC [1117] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls;901server # [ 129.959356] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: CREATE ROLE902server # [ 129.963058] postgres[1117]: ::1 2026-10-07 00:00:24.735 UTC [1117] postgres@postgres LOG: statement: create user authenticator noinherit;903server # [ 129.973136] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: CREATE ROLE904server # [ 129.977479] postgres[1117]: ::1 2026-10-07 00:00:24.747 UTC [1117] postgres@postgres LOG: statement: grant anon to authenticator;905server # [ 129.988144] postgres[1117]: ::1 2026-10-07 00:00:24.760 UTC [1117] postgres@postgres LOG: statement: grant authenticated to authenticator;906server # [ 129.992188] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: GRANT ROLE907server # [ 129.998167] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: GRANT ROLE908server # [ 130.002750] postgres[1117]: ::1 2026-10-07 00:00:24.777 UTC [1117] postgres@postgres LOG: statement: grant service_role to authenticator;909server # [ 130.015957] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: GRANT ROLE910server # [ 130.027631] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: GRANT ROLE911server # [ 130.037532] postgres[1117]: ::1 2026-10-07 00:00:24.787 UTC [1117] postgres@postgres LOG: statement: grant supabase_admin to authenticator;912server # [ 130.042408] postgres[1117]: ::1 2026-10-07 00:00:24.796 UTC [1117] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role;913server # [ 130.046322] postgres[1117]: ::1 2026-10-07 00:00:24.805 UTC [1117] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;914server # [ 130.049796] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: GRANT915server # [ 130.056943] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: ALTER DEFAULT PRIVILEGES916server # [ 130.058180] postgres[1117]: ::1 2026-10-07 00:00:24.832 UTC [1117] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;917server # [ 130.066855] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: ALTER DEFAULT PRIVILEGES918server # [ 130.068885] postgres[1117]: ::1 2026-10-07 00:00:24.842 UTC [1117] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;919server # [ 130.082961] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: ALTER DEFAULT PRIVILEGES920server # [ 130.090776] postgres[1117]: ::1 2026-10-07 00:00:24.860 UTC [1117] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role;921server # [ 130.094621] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: GRANT922server # [ 130.098543] postgres[1117]: ::1 2026-10-07 00:00:24.870 UTC [1117] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions;923server # [ 130.107549] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: ALTER ROLE924server # [ 130.110585] postgres[1117]: ::1 2026-10-07 00:00:24.883 UTC [1117] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all925server # [ 130.114892] postgres[1117]: on sequences to postgres, anon, authenticated, service_role;926server # [ 130.122373] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: ALTER DEFAULT PRIVILEGES927server # [ 130.129996] postgres[1117]: ::1 2026-10-07 00:00:24.900 UTC [1117] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all928server # [ 130.138232] postgres[1117]: on tables to postgres, anon, authenticated, service_role;929server # [ 130.145722] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: ALTER DEFAULT PRIVILEGES930server # [ 130.147137] postgres[1117]: ::1 2026-10-07 00:00:24.918 UTC [1117] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all931server # [ 130.153105] postgres[1117]: on functions to postgres, anon, authenticated, service_role;932server # [ 130.159300] postgres[1117]: ::1 2026-10-07 00:00:24.931 UTC [1117] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s';933server # [ 130.161633] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: ALTER DEFAULT PRIVILEGES934server # [ 130.170665] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: ALTER ROLE935server # [ 130.174585] postgres[1117]: ::1 2026-10-07 00:00:24.942 UTC [1117] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s';936server # [ 130.178777] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1113]: ALTER ROLE937server # [ 130.235283] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000001-auth-schema.sql938server # [ 130.540018] postgres[1140]: ::1 2026-10-07 00:00:25.294 UTC [1140] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;939server # [ 130.557974] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE SCHEMA940server # [ 130.562148] postgres[1140]: ::1 2026-10-07 00:00:25.325 UTC [1140] postgres@postgres LOG: statement: CREATE TABLE auth.users (941server # [ 130.565885] postgres[1140]: instance_id uuid NULL,942server # [ 130.567961] postgres[1140]: id uuid NOT NULL UNIQUE,943server # [ 130.571199] postgres[1140]: aud varchar(255) NULL,944server # [ 130.575134] postgres[1140]: "role" varchar(255) NULL,945server # [ 130.581079] postgres[1140]: email varchar(255) NULL UNIQUE,946server # [ 130.582541] postgres[1140]: encrypted_password varchar(255) NULL,947server # [ 130.583864] postgres[1140]: confirmed_at timestamptz NULL,948server # [ 130.589531] postgres[1140]: invited_at timestamptz NULL,949server # [ 130.592912] postgres[1140]: confirmation_token varchar(255) NULL,950server # [ 130.594639] postgres[1140]: confirmation_sent_at timestamptz NULL,951server # [ 130.597160] postgres[1140]: recovery_token varchar(255) NULL,952server # [ 130.599889] postgres[1140]: recovery_sent_at timestamptz NULL,953server # [ 130.603534] postgres[1140]: email_change_token varchar(255) NULL,954server # [ 130.605874] postgres[1140]: email_change varchar(255) NULL,955server # [ 130.607167] postgres[1140]: email_change_sent_at timestamptz NULL,956server # [ 130.608375] postgres[1140]: last_sign_in_at timestamptz NULL,957server # [ 130.611165] postgres[1140]: raw_app_meta_data jsonb NULL,958server # [ 130.614023] postgres[1140]: raw_user_meta_data jsonb NULL,959server # [ 130.624049] postgres[1140]: is_super_admin bool NULL,960server # [ 130.628370] postgres[1140]: created_at timestamptz NULL,961server # [ 130.631771] postgres[1140]: updated_at timestamptz NULL,962server # [ 130.636357] postgres[1140]: CONSTRAINT users_pkey PRIMARY KEY (id)963server # [ 130.638845] postgres[1140]: );964server # [ 130.755380] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE TABLE965server # [ 130.775007] postgres[1140]: ::1 2026-10-07 00:00:25.537 UTC [1140] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);966server # [ 130.813264] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE INDEX967server # [ 130.815865] postgres[1140]: ::1 2026-10-07 00:00:25.590 UTC [1140] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);968server # [ 130.863840] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE INDEX969server # [ 130.869394] postgres[1140]: ::1 2026-10-07 00:00:25.642 UTC [1140] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';970server # [ 130.877461] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: COMMENT971server # [ 130.879410] postgres[1140]: ::1 2026-10-07 00:00:25.653 UTC [1140] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens (972server # [ 130.885473] postgres[1140]: instance_id uuid NULL,973server # [ 130.886645] postgres[1140]: id bigserial NOT NULL,974server # [ 130.893680] postgres[1140]: "token" varchar(255) NULL,975server # [ 130.894880] postgres[1140]: user_id varchar(255) NULL,976server # [ 130.896371] postgres[1140]: revoked bool NULL,977server # [ 130.897120] postgres[1140]: created_at timestamptz NULL,978server # [ 130.905412] postgres[1140]: updated_at timestamptz NULL,979server # [ 130.907440] postgres[1140]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)980server # [ 130.913330] postgres[1140]: );981server # [ 131.031649] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE TABLE982server # [ 131.034796] postgres[1140]: ::1 2026-10-07 00:00:25.806 UTC [1140] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);983server # [ 131.075535] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE INDEX984server # [ 131.087133] postgres[1140]: ::1 2026-10-07 00:00:25.852 UTC [1140] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id);985server # [ 131.168834] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE INDEX986server # [ 131.178554] postgres[1140]: ::1 2026-10-07 00:00:25.953 UTC [1140] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);987server # [ 131.243642] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE INDEX988server # [ 131.254852] postgres[1140]: ::1 2026-10-07 00:00:26.024 UTC [1140] postgres@postgres LOG: statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.';989server # [ 131.266663] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: COMMENT990server # [ 131.271078] postgres[1140]: ::1 2026-10-07 00:00:26.044 UTC [1140] postgres@postgres LOG: statement: CREATE TABLE auth.instances (991server # [ 131.277191] postgres[1140]: id uuid NOT NULL,992server # [ 131.279835] postgres[1140]: uuid uuid NULL,993server # [ 131.282225] postgres[1140]: raw_base_config text NULL,994server # [ 131.285389] postgres[1140]: created_at timestamptz NULL,995server # [ 131.286227] postgres[1140]: updated_at timestamptz NULL,996server # [ 131.286762] postgres[1140]: CONSTRAINT instances_pkey PRIMARY KEY (id)997server # [ 131.293681] postgres[1140]: );998server # [ 131.377493] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE TABLE999server # [ 131.381123] postgres[1140]: ::1 2026-10-07 00:00:26.152 UTC [1140] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';1000server # [ 131.387523] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: COMMENT1001server # [ 131.389247] postgres[1140]: ::1 2026-10-07 00:00:26.163 UTC [1140] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries (1002server # [ 131.391103] postgres[1140]: instance_id uuid NULL,1003server # [ 131.393999] postgres[1140]: id uuid NOT NULL,1004server # [ 131.397696] postgres[1140]: payload json NULL,1005server # [ 131.399485] postgres[1140]: created_at timestamptz NULL,1006server # [ 131.401623] postgres[1140]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)1007server # [ 131.403199] postgres[1140]: );1008server # [ 131.517373] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE TABLE1009server # [ 131.529559] postgres[1140]: ::1 2026-10-07 00:00:26.299 UTC [1140] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);1010server # [ 131.582585] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE INDEX1011server # [ 131.587043] postgres[1140]: ::1 2026-10-07 00:00:26.350 UTC [1140] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';1012server # [ 131.594126] postgres[1140]: ::1 2026-10-07 00:00:26.366 UTC [1140] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations (1013server # [ 131.597465] postgres[1140]: "version" varchar(255) NOT NULL,1014server # [ 131.599350] postgres[1140]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")1015server # [ 131.600361] postgres[1140]: );1016server # [ 131.607209] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: COMMENT1017server # [ 131.668565] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE TABLE1018server # [ 131.670857] postgres[1140]: ::1 2026-10-07 00:00:26.445 UTC [1140] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';1019server # [ 131.684862] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: COMMENT1020server # [ 131.723593] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: INSERT 0 71021server # [ 131.728380] postgres[1140]: ::1 2026-10-07 00:00:26.501 UTC [1140] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$1022server # [ 131.738038] postgres[1140]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;1023server # [ 131.741390] postgres[1140]: $$ language sql stable;1024server # [ 131.747806] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE FUNCTION1025server # [ 131.751370] postgres[1140]: ::1 2026-10-07 00:00:26.524 UTC [1140] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$1026server # [ 131.758004] postgres[1140]: select nullif(current_setting('request.jwt.claim.role', true), '')::text;1027server # [ 131.766502] postgres[1140]: $$ language sql stable;1028server # [ 131.773726] postgres[1140]: ::1 2026-10-07 00:00:26.537 UTC [1140] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$1029server # [ 131.775650] postgres[1140]: select nullif(current_setting('request.jwt.claim.email', true), '')::text;1030server # [ 131.783642] postgres[1140]: $$ language sql stable;1031server # [ 131.785612] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE FUNCTION1032server # [ 131.789340] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE FUNCTION1033server # [ 131.790337] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: GRANT1034server # [ 131.798021] postgres[1140]: ::1 2026-10-07 00:00:26.550 UTC [1140] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;1035server # [ 131.799994] postgres[1140]: ::1 2026-10-07 00:00:26.565 UTC [1140] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1036server # [ 131.802760] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: CREATE ROLE1037server # [ 131.805963] postgres[1140]: ::1 2026-10-07 00:00:26.579 UTC [1140] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1038server # [ 131.814859] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: GRANT1039server # [ 131.821677] postgres[1140]: ::1 2026-10-07 00:00:26.591 UTC [1140] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1040server # [ 131.831206] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: GRANT1041server # [ 131.833309] postgres[1140]: ::1 2026-10-07 00:00:26.607 UTC [1140] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1042server # [ 131.843897] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: GRANT1043server # [ 131.846071] postgres[1140]: ::1 2026-10-07 00:00:26.620 UTC [1140] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth";1044server # [ 131.853701] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: ALTER ROLE1045server # [ 131.861897] postgres[1140]: ::1 2026-10-07 00:00:26.636 UTC [1140] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin;1046server # [ 131.886122] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: ALTER TABLE1047server # [ 131.889570] postgres[1140]: ::1 2026-10-07 00:00:26.662 UTC [1140] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;1048server # [ 131.914567] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: ALTER TABLE1049server # [ 131.915783] postgres[1140]: ::1 2026-10-07 00:00:26.690 UTC [1140] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;1050server # [ 131.926162] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: ALTER TABLE1051server # [ 131.930214] postgres[1140]: ::1 2026-10-07 00:00:26.705 UTC [1140] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;1052server # [ 131.939110] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: ALTER TABLE1053server # [ 131.946055] postgres[1140]: ::1 2026-10-07 00:00:26.715 UTC [1140] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;1054server # [ 131.950083] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1139]: ALTER TABLE1055server # [ 132.011750] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000002-storage-schema.sql1056server # [ 132.302045] postgres[1162]: ::1 2026-10-07 00:00:27.065 UTC [1162] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;1057server # [ 132.327630] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1161]: CREATE SCHEMA1058server # [ 132.330318] postgres[1162]: ::1 2026-10-07 00:00:27.094 UTC [1162] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1059server # [ 132.338290] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1161]: CREATE ROLE1060server # [ 132.340318] postgres[1162]: ::1 2026-10-07 00:00:27.114 UTC [1162] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage";1061server # [ 132.350025] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1161]: ALTER ROLE1062server # [ 132.357682] postgres[1162]: ::1 2026-10-07 00:00:27.126 UTC [1162] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;1063server # [ 132.359999] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1161]: GRANT1064server # [ 132.392812] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1161]: DO1065server # [ 132.437401] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000003-post-setup.sql1066server # [ 132.800554] postgres[1164]: ::1 2026-10-07 00:00:27.568 UTC [1164] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;1067server # [ 132.825592] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: ALTER ROLE1068server # [ 132.827555] postgres[1164]: ::1 2026-10-07 00:00:27.598 UTC [1164] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;1069server # [ 132.840160] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: ALTER ROLE1070server # [ 132.845616] postgres[1164]: ::1 2026-10-07 00:00:27.618 UTC [1164] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()1071server # [ 132.847675] postgres[1164]: RETURNS event_trigger1072server # [ 132.853841] postgres[1164]: LANGUAGE plpgsql1073server # [ 132.855946] postgres[1164]: AS $$1074server # [ 132.857901] postgres[1164]: DECLARE1075server # [ 132.861907] postgres[1164]: schema_is_cron bool;1076server # [ 132.863037] postgres[1164]: BEGIN1077server # [ 132.869998] postgres[1164]: schema_is_cron = (1078server # [ 132.878358] postgres[1164]: SELECT n.nspname = 'cron'1079server # [ 132.886866] postgres[1164]: FROM pg_event_trigger_ddl_commands() AS ev1080server # [ 132.888755] postgres[1164]: LEFT JOIN pg_catalog.pg_namespace AS n1081server # [ 132.892034] postgres[1164]: ON ev.objid = n.oid1082server # [ 132.902338] postgres[1164]: );1083server # [ 132.903283] postgres[1164]:1084server # [ 132.905128] postgres[1164]: IF schema_is_cron1085server # [ 132.907846] postgres[1164]: THEN1086server # [ 132.914747] postgres[1164]: grant usage on schema cron to postgres with grant option;1087server # [ 132.916233] postgres[1164]:1088server # [ 132.917995] postgres[1164]: alter default privileges in schema cron grant all on tables to postgres with grant option;1089server # [ 132.919249] postgres[1164]: alter default privileges in schema cron grant all on functions to postgres with grant option;1090server # [ 132.921873] postgres[1164]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1091server # [ 132.926561] postgres[1164]:1092server # [ 132.929626] postgres[1164]: alter default privileges for user supabase_admin in schema cron grant all1093server # [ 132.934603] postgres[1164]: on sequences to postgres with grant option;1094server # [ 132.941693] postgres[1164]: alter default privileges for user supabase_admin in schema cron grant all1095server # [ 132.943479] postgres[1164]: on tables to postgres with grant option;1096server # [ 132.945973] postgres[1164]: alter default privileges for user supabase_admin in schema cron grant all1097server # [ 132.952295] postgres[1164]: on functions to postgres with grant option;1098server # [ 132.958667] postgres[1164]:1099server # [ 132.963539] postgres[1164]: grant all privileges on all tables in schema cron to postgres with grant option;1100server # [ 132.970235] postgres[1164]:1101server # [ 132.974448] postgres[1164]: END IF;1102server # [ 132.976865] postgres[1164]:1103server # [ 132.978857] postgres[1164]: END;1104server # [ 132.982469] postgres[1164]: $$;1105server # [ 132.983643] postgres[1164]: ::1 2026-10-07 00:00:27.671 UTC [1164] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')1106server # [ 132.985678] postgres[1164]: EXECUTE PROCEDURE extensions.grant_pg_cron_access();1107server # [ 132.986657] postgres[1164]: ::1 2026-10-07 00:00:27.689 UTC [1164] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';1108server # [ 132.989361] postgres[1164]: ::1 2026-10-07 00:00:27.713 UTC [1164] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()1109server # [ 132.991924] postgres[1164]: RETURNS event_trigger1110server # [ 132.993758] postgres[1164]: LANGUAGE plpgsql1111server # [ 132.994595] postgres[1164]: AS $$1112server # [ 132.996016] postgres[1164]: BEGIN1113server # [ 132.999543] postgres[1164]: IF EXISTS (1114server # [ 133.001679] postgres[1164]: SELECT 11115server # [ 133.003085] postgres[1164]: FROM pg_event_trigger_ddl_commands() AS ev1116server # [ 133.005468] postgres[1164]: JOIN pg_extension AS ext1117server # [ 133.006708] postgres[1164]: ON ev.objid = ext.oid1118server # [ 133.009535] postgres[1164]: WHERE ext.extname = 'pg_net'1119server # [ 133.010797] postgres[1164]: )1120server # [ 133.013686] postgres[1164]: THEN1121server # [ 133.015115] postgres[1164]: IF NOT EXISTS (1122server # [ 133.016042] postgres[1164]: SELECT 11123server # [ 133.018642] postgres[1164]: FROM pg_roles1124server # [ 133.021230] postgres[1164]: WHERE rolname = 'supabase_functions_admin'1125server # [ 133.023243] postgres[1164]: )1126server # [ 133.025912] postgres[1164]: THEN1127server # [ 133.026961] postgres[1164]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1128server # [ 133.029932] postgres[1164]: END IF;1129server # [ 133.031164] postgres[1164]:1130server # [ 133.032975] postgres[1164]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;1131server # [ 133.035925] postgres[1164]:1132server # [ 133.038784] postgres[1164]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1133server # [ 133.045301] postgres[1164]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1134server # [ 133.050193] postgres[1164]:1135server # [ 133.053549] postgres[1164]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1136server # [ 133.057577] postgres[1164]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1137server # [ 133.060682] postgres[1164]:1138server # [ 133.063485] postgres[1164]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1139server # [ 133.066182] postgres[1164]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1140server # [ 133.067302] postgres[1164]:1141server # [ 133.072098] postgres[1164]: 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;1142server # [ 133.078947] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: CREATE FUNCTION1143server # [ 133.083145] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: CREATE EVENT TRIGGER1144server # [ 133.093620] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: COMMENT1145server # [ 133.094948] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: CREATE FUNCTION1146server # [ 133.098048] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: COMMENT1147server # [ 133.099689] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: DO1148server # [ 133.102237] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: CREATE ROLE1149server # [ 133.104969] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: GRANT1150server # [ 133.107507] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: GRANT1151server # [ 133.115540] postgres[1164]: 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 # [ 133.122332] postgres[1164]: END IF;1153server # [ 133.128093] postgres[1164]: END;1154server # [ 133.133587] postgres[1164]: $$;1155server # [ 133.134621] postgres[1164]: ::1 2026-10-07 00:00:27.735 UTC [1164] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';1156server # [ 133.141486] postgres[1164]: ::1 2026-10-07 00:00:27.801 UTC [1164] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;1157server # [ 133.142753] postgres[1164]: ::1 2026-10-07 00:00:27.818 UTC [1164] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user;1158server # [ 133.144591] postgres[1164]: ::1 2026-10-07 00:00:27.831 UTC [1164] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user;1159server # [ 133.152795] postgres[1164]: ::1 2026-10-07 00:00:27.850 UTC [1164] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;1160server # [ 133.157130] postgres[1164]: ::1 2026-10-07 00:00:27.865 UTC [1164] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;1161server # [ 133.165291] postgres[1164]: ::1 2026-10-07 00:00:27.885 UTC [1164] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;1162server # [ 133.167363] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: GRANT1163server # [ 133.172965] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: GRANT1164server # [ 133.174603] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: GRANT1165server # [ 133.175392] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: GRANT1166server # [ 133.181695] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: GRANT1167server # [ 133.182436] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: GRANT1168server # [ 133.183089] postgres[1164]: ::1 2026-10-07 00:00:27.893 UTC [1164] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;1169server # [ 133.183852] postgres[1164]: ::1 2026-10-07 00:00:27.901 UTC [1164] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;1170server # [ 133.189585] postgres[1164]: ::1 2026-10-07 00:00:27.906 UTC [1164] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;1171server # [ 133.191080] postgres[1164]: ::1 2026-10-07 00:00:27.937 UTC [1164] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;1172server # [ 133.215857] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: GRANT1173server # [ 133.239606] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1163]: DO1174server # [ 133.301512] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running pgbouncer auth schema...1175server # [ 133.617537] postgres[1166]: ::1 2026-10-07 00:00:28.366 UTC [1166] postgres@postgres LOG: statement: CREATE USER pgbouncer;1176server # [ 133.623117] postgres[1166]: ::1 2026-10-07 00:00:28.389 UTC [1166] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;1177server # [ 133.634439] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1165]: CREATE ROLE1178server # [ 133.637019] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1165]: REVOKE1179server # [ 133.642870] postgres[1166]: ::1 2026-10-07 00:00:28.414 UTC [1166] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;1180server # [ 133.726653] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1165]: CREATE SCHEMA1181server # [ 133.742443] postgres[1166]: ::1 2026-10-07 00:00:28.505 UTC [1166] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)1182server # [ 133.747082] postgres[1166]: RETURNS TABLE(username TEXT, password TEXT) AS1183server # [ 133.754505] postgres[1166]: $$1184server # [ 133.765179] postgres[1166]: BEGIN1185server # [ 133.776946] postgres[1166]: RAISE WARNING 'PgBouncer auth request: %', p_usename;1186server # [ 133.781169] postgres[1166]:1187server # [ 133.798395] postgres[1166]: RETURN QUERY1188server # [ 133.808352] postgres[1166]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow1189server # [ 133.821788] postgres[1166]: WHERE usename = p_usename;1190server # [ 133.827187] postgres[1166]: END;1191server # [ 133.833409] postgres[1166]: $$ LANGUAGE plpgsql1192server # [ 133.845999] postgres[1166]: SET search_path = ''1193server # [ 133.859472] postgres[1166]: SECURITY DEFINER;1194server # [ 133.886057] postgres[1166]: ::1 2026-10-07 00:00:28.561 UTC [1166] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;1195server # [ 133.900990] postgres[1166]: ::1 2026-10-07 00:00:28.579 UTC [1166] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;1196server # [ 133.906402] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1165]: CREATE FUNCTION1197server # [ 133.917384] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1165]: REVOKE1198server # [ 133.921905] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1165]: GRANT1199server # [ 133.928298] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running stat extension...1200server # [ 134.364757] postgres[1178]: ::1 2026-10-07 00:00:29.125 UTC [1178] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions;1201server # [ 134.404687] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1173]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping1202server # [ 134.449504] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1173]: CREATE SCHEMA1203server # [ 134.457852] postgres[1178]: ::1 2026-10-07 00:00:29.230 UTC [1178] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;1204server # [ 135.718352] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1173]: CREATE EXTENSION1205server # [ 135.783791] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/10000000000000_demote-postgres.sql1206server # [ 136.061217] postgres[1190]: ::1 2026-10-07 00:00:30.823 UTC [1190] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres;1207server # [ 136.082170] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1189]: GRANT1208server # [ 136.086635] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1189]: GRANT1209server # [ 136.091848] postgres[1190]: ::1 2026-10-07 00:00:30.847 UTC [1190] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres;1210server # [ 136.093457] postgres[1190]: ::1 2026-10-07 00:00:30.858 UTC [1190] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres;1211server # [ 136.096886] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1189]: GRANT1212server # [ 136.098072] postgres[1190]: ::1 2026-10-07 00:00:30.872 UTC [1190] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;1213server # [ 136.108168] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1189]: GRANT1214server # [ 136.115510] postgres[1190]: ::1 2026-10-07 00:00:30.885 UTC [1190] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;1215server # [ 136.130051] postgres[1190]: ::1 2026-10-07 00:00:30.895 UTC [1190] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;1216server # [ 136.132537] postgres[1190]: ::1 2026-10-07 00:00:30.903 UTC [1190] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;1217server # [ 136.137731] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1189]: GRANT1218server # [ 136.142327] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1189]: GRANT1219server # [ 136.145750] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1189]: GRANT1220server # [ 136.149872] postgres[1190]: ::1 2026-10-07 00:00:30.906 UTC [1190] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;1221server # [ 136.154358] postgres[1190]: ::1 2026-10-07 00:00:30.917 UTC [1190] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;1222server # [ 136.161971] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1189]: GRANT1223server # [ 136.170413] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1189]: GRANT1224server # [ 136.199174] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1189]: DO1225server # [ 136.204268] postgres[1190]: ::1 2026-10-07 00:00:30.976 UTC [1190] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;1226server # [ 136.210539] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1189]: ALTER ROLE1227server # [ 136.257771] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211115181400_update-auth-permissions.sql1228server # [ 136.545423] postgres[1192]: ::1 2026-10-07 00:00:31.307 UTC [1192] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1229server # [ 136.571652] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: GRANT1230server # [ 136.574611] postgres[1192]: ::1 2026-10-07 00:00:31.333 UTC [1192] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1231server # [ 136.585378] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: GRANT1232server # [ 136.591948] postgres[1192]: ::1 2026-10-07 00:00:31.366 UTC [1192] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1233server # [ 136.605913] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: GRANT1234server # [ 136.610650] postgres[1192]: ::1 2026-10-07 00:00:31.382 UTC [1192] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;1235server # [ 136.620678] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: ALTER TABLE1236server # [ 136.626323] postgres[1192]: ::1 2026-10-07 00:00:31.398 UTC [1192] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;1237server # [ 136.635898] postgres[1192]: ::1 2026-10-07 00:00:31.409 UTC [1192] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;1238server # [ 136.644847] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: ALTER TABLE1239server # [ 136.658261] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: ALTER TABLE1240server # [ 136.668628] postgres[1192]: ::1 2026-10-07 00:00:31.434 UTC [1192] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;1241server # [ 136.673550] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: ALTER TABLE1242server # [ 136.675691] postgres[1192]: ::1 2026-10-07 00:00:31.446 UTC [1192] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;1243server # [ 136.684101] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: ALTER TABLE1244server # [ 136.690576] postgres[1192]: ::1 2026-10-07 00:00:31.462 UTC [1192] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres;1245server # [ 136.703718] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: GRANT1246server # [ 136.710240] postgres[1192]: ::1 2026-10-07 00:00:31.482 UTC [1192] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;1247server # [ 136.720763] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: GRANT1248server # [ 136.722821] postgres[1192]: ::1 2026-10-07 00:00:31.495 UTC [1192] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;1249server # [ 136.733237] postgres[1192]: ::1 2026-10-07 00:00:31.506 UTC [1192] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;1250server # [ 136.738072] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: GRANT1251server # [ 136.746831] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: GRANT1252server # [ 136.750022] postgres[1192]: ::1 2026-10-07 00:00:31.525 UTC [1192] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user;1253server # [ 136.763583] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: ALTER DEFAULT PRIVILEGES1254server # [ 136.769656] postgres[1192]: ::1 2026-10-07 00:00:31.538 UTC [1192] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1255server # [ 136.798798] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: ALTER DEFAULT PRIVILEGES1256server # [ 136.817777] postgres[1192]: ::1 2026-10-07 00:00:31.562 UTC [1192] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user;1257server # [ 136.838910] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1191]: ALTER DEFAULT PRIVILEGES1258server # [ 136.900076] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211118015519_create-realtime-schema.sql1259server # [ 137.350343] postgres[1203]: ::1 2026-10-07 00:00:32.100 UTC [1203] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime;1260server # [ 137.410326] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1197]: CREATE SCHEMA1261server # [ 137.475419] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211122051245_update-realtime-permissions.sql1262server # [ 138.007654] postgres[1212]: ::1 2026-10-07 00:00:32.757 UTC [1212] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres;1263server # [ 138.081519] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1207]: GRANT1264server # [ 138.087574] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1207]: GRANT1265server # [ 138.095031] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1207]: GRANT1266server # [ 138.109935] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1207]: GRANT1267server # [ 138.122563] postgres[1212]: ::1 2026-10-07 00:00:32.797 UTC [1212] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;1268server # [ 138.138041] postgres[1212]: ::1 2026-10-07 00:00:32.812 UTC [1212] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;1269server # [ 138.142078] postgres[1212]: ::1 2026-10-07 00:00:32.815 UTC [1212] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;1270server # [ 138.175898] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211124212715_update-auth-owner.sql1271server # [ 138.491431] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1217]: DO1272server # [ 138.503302] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1217]: DO1273server # [ 138.530928] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1217]: DO1274server # [ 138.563815] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211130151719_update-realtime-permissions.sql1275server # [ 138.839989] postgres[1220]: ::1 2026-10-07 00:00:33.606 UTC [1220] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user;1276server # [ 138.870733] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1219]: ALTER DEFAULT PRIVILEGES1277server # [ 138.875006] postgres[1220]: ::1 2026-10-07 00:00:33.639 UTC [1220] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1278server # [ 138.879861] postgres[1220]: ::1 2026-10-07 00:00:33.649 UTC [1220] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user;1279server # [ 138.887146] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1219]: ALTER DEFAULT PRIVILEGES1280server # [ 138.898980] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1219]: ALTER DEFAULT PRIVILEGES1281server # [ 138.935533] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql1282server # [ 139.219967] postgres[1222]: ::1 2026-10-07 00:00:33.986 UTC [1222] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';1283server # [ 139.248192] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1221]: ALTER ROLE1284server # [ 139.298431] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql1285server # [ 139.592628] postgres[1224]: ::1 2026-10-07 00:00:34.361 UTC [1224] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1286server # [ 139.604584] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1287server # [ 139.608512] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: DROP EVENT TRIGGER1288server # [ 139.614331] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1289server # [ 139.623615] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: DROP FUNCTION1290server # [ 139.627508] postgres[1224]: ::1 2026-10-07 00:00:34.367 UTC [1224] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1291server # [ 139.633891] postgres[1224]: ::1 2026-10-07 00:00:34.373 UTC [1224] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1292server # [ 139.635240] postgres[1224]: DECLARE1293server # [ 139.636023] postgres[1224]: cmd record;1294server # [ 139.637445] postgres[1224]: BEGIN1295server # [ 139.639314] postgres[1224]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1296server # [ 139.640463] postgres[1224]: LOOP1297server # [ 139.643685] postgres[1224]: IF cmd.command_tag IN (1298server # [ 139.645699] postgres[1224]: 'CREATE SCHEMA', 'ALTER SCHEMA'1299server # [ 139.646944] postgres[1224]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1300server # [ 139.656810] postgres[1224]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1301server # [ 139.664012] postgres[1224]: , 'CREATE VIEW', 'ALTER VIEW'1302server # [ 139.671872] postgres[1224]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1303server # [ 139.680971] postgres[1224]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1304server # [ 139.691912] postgres[1224]: , 'CREATE TRIGGER'1305server # [ 139.706566] postgres[1224]: , 'CREATE TYPE'1306server # [ 139.717843] postgres[1224]: , 'CREATE RULE'1307server # [ 139.719931] postgres[1224]: , 'COMMENT'1308server # [ 139.734953] postgres[1224]: )1309server # [ 139.751392] postgres[1224]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1310server # [ 139.762761] postgres[1224]: AND cmd.schema_name is distinct from 'pg_temp'1311server # [ 139.771698] postgres[1224]: THEN1312server # [ 139.781492] postgres[1224]: NOTIFY pgrst, 'reload schema';1313server # [ 139.783388] postgres[1224]: END IF;1314server # [ 139.804908] postgres[1224]: END LOOP;1315server # [ 139.808174] postgres[1224]: END; $$ LANGUAGE plpgsql;1316server # [ 139.815263] postgres[1224]: ::1 2026-10-07 00:00:34.395 UTC [1224] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1317server # [ 139.827553] postgres[1224]: DECLARE1318server # [ 139.834409] postgres[1224]: obj record;1319server # [ 139.838383] postgres[1224]: BEGIN1320server # [ 139.845595] postgres[1224]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1321server # [ 139.850948] postgres[1224]: LOOP1322server # [ 139.857103] postgres[1224]: IF obj.object_type IN (1323server # [ 139.865958] postgres[1224]: 'schema'1324server # [ 139.878648] postgres[1224]: , 'table'1325server # [ 139.882073] postgres[1224]: , 'foreign table'1326server # [ 139.884606] postgres[1224]: , 'view'1327server # [ 139.888004] postgres[1224]: , 'materialized view'1328server # [ 139.893720] postgres[1224]: , 'function'1329server # [ 139.897183] postgres[1224]: , 'trigger'1330server # [ 139.900561] postgres[1224]: , 'type'1331server # [ 139.902699] postgres[1224]: , 'rule'1332server # [ 139.906587] postgres[1224]: )1333server # [ 139.909181] postgres[1224]: AND obj.is_temporary IS false -- no pg_temp objects1334server # [ 139.910747] postgres[1224]: THEN1335server # [ 139.913340] postgres[1224]: NOTIFY pgrst, 'reload schema';1336server # [ 139.914878] postgres[1224]: END IF;1337server # [ 139.917604] postgres[1224]: END LOOP;1338server # [ 139.919065] postgres[1224]: END; $$ LANGUAGE plpgsql;1339server # [ 139.921717] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: CREATE FUNCTION1340server # [ 139.923959] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: CREATE FUNCTION1341server # [ 139.925727] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping1342server # [ 139.929159] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: DROP EVENT TRIGGER1343server # [ 139.931740] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: CREATE EVENT TRIGGER1344server # [ 139.940029] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping1345server # [ 139.944622] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: DROP EVENT TRIGGER1346server # [ 139.951927] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1223]: CREATE EVENT TRIGGER1347server # [ 139.960789] postgres[1224]: ::1 2026-10-07 00:00:34.417 UTC [1224] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1348server # [ 139.969806] postgres[1224]: ::1 2026-10-07 00:00:34.425 UTC [1224] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1349server # [ 139.973217] postgres[1224]: ON ddl_command_end1350server # [ 139.984720] postgres[1224]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1351server # [ 139.986534] postgres[1224]: ::1 2026-10-07 00:00:34.435 UTC [1224] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1352server # [ 139.987876] postgres[1224]: ::1 2026-10-07 00:00:34.441 UTC [1224] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1353server # [ 139.992546] postgres[1224]: ON sql_drop1354server # [ 139.995010] postgres[1224]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1355server # [ 139.998031] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql1356server # [ 141.063047] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1225]: DO1357server # [ 141.145686] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql1358server # [ 141.657262] postgres[1245]: ::1 2026-10-07 00:00:36.410 UTC [1245] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public;1359server # [ 141.723290] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: CREATE SCHEMA1360server # [ 141.731551] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping1361server # [ 141.738686] postgres[1245]: ::1 2026-10-07 00:00:36.494 UTC [1245] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb);1362server # [ 141.745981] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: DROP FUNCTION1363server # [ 141.753013] postgres[1245]: ::1 2026-10-07 00:00:36.514 UTC [1245] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1364server # [ 141.754917] postgres[1245]: "operationName" text default null,1365server # [ 141.760843] postgres[1245]: query text default null,1366server # [ 141.762485] postgres[1245]: variables jsonb default null,1367server # [ 141.765727] postgres[1245]: extensions jsonb default null1368server # [ 141.768119] postgres[1245]: )1369server # [ 141.770634] postgres[1245]: returns jsonb1370server # [ 141.771781] postgres[1245]: language plpgsql1371server # [ 141.774178] postgres[1245]: as $$1372server # [ 141.777023] postgres[1245]: DECLARE1373server # [ 141.778363] postgres[1245]: server_version float;1374server # [ 141.779393] postgres[1245]: BEGIN1375server # [ 141.781005] postgres[1245]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1376server # [ 141.782978] postgres[1245]:1377server # [ 141.783774] postgres[1245]: IF server_version >= 14 THEN1378server # [ 141.785907] postgres[1245]: RETURN jsonb_build_object(1379server # [ 141.787229] postgres[1245]: 'data', null::jsonb,1380server # [ 141.788128] postgres[1245]: 'errors', array['pg_graphql extension is not enabled.']1381server # [ 141.791843] postgres[1245]: );1382server # [ 141.793979] postgres[1245]: ELSE1383server # [ 141.795057] postgres[1245]: RETURN jsonb_build_object(1384server # [ 141.796326] postgres[1245]: 'data', null::jsonb,1385server # [ 141.798895] postgres[1245]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1386server # [ 141.799999] postgres[1245]: );1387server # [ 141.802061] postgres[1245]: END IF;1388server # [ 141.804365] postgres[1245]: END;1389server # [ 141.806260] postgres[1245]: $$;1390server # [ 141.807679] postgres[1245]: ::1 2026-10-07 00:00:36.558 UTC [1245] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;1391server # [ 141.813855] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: CREATE FUNCTION1392server # [ 141.826744] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: GRANT1393server # [ 141.834626] postgres[1245]: ::1 2026-10-07 00:00:36.605 UTC [1245] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;1394server # [ 141.846260] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: ALTER DEFAULT PRIVILEGES1395server # [ 141.853606] postgres[1245]: ::1 2026-10-07 00:00:36.624 UTC [1245] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;1396server # [ 141.859792] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: ALTER DEFAULT PRIVILEGES1397server # [ 141.866048] postgres[1245]: ::1 2026-10-07 00:00:36.637 UTC [1245] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;1398server # [ 141.885669] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: ALTER DEFAULT PRIVILEGES1399server # [ 141.893321] postgres[1245]: ::1 2026-10-07 00:00:36.657 UTC [1245] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1400server # [ 141.895142] postgres[1245]: on sequences to postgres, anon, authenticated, service_role;1401server # [ 141.902040] postgres[1245]: ::1 2026-10-07 00:00:36.670 UTC [1245] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1402server # [ 141.903283] postgres[1245]: on tables to postgres, anon, authenticated, service_role;1403server # [ 141.904078] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: ALTER DEFAULT PRIVILEGES1404server # [ 141.914410] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: ALTER DEFAULT PRIVILEGES1405server # [ 141.916995] postgres[1245]: ::1 2026-10-07 00:00:36.682 UTC [1245] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1406server # [ 141.923032] postgres[1245]: on functions to postgres, anon, authenticated, service_role;1407server # [ 141.929951] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: ALTER DEFAULT PRIVILEGES1408server # [ 141.937420] postgres[1245]: ::1 2026-10-07 00:00:36.707 UTC [1245] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()1409server # [ 141.943991] postgres[1245]: RETURNS event_trigger1410server # [ 141.946890] postgres[1245]: LANGUAGE plpgsql1411server # [ 141.947519] postgres[1245]: AS $func$1412server # [ 141.949838] postgres[1245]: DECLARE1413server # [ 141.954151] postgres[1245]: func_is_graphql_resolve bool;1414server # [ 141.959739] postgres[1245]: BEGIN1415server # [ 141.962272] postgres[1245]: func_is_graphql_resolve = (1416server # [ 141.969920] postgres[1245]: SELECT n.proname = 'resolve'1417server # [ 141.975202] postgres[1245]: FROM pg_event_trigger_ddl_commands() AS ev1418server # [ 141.977478] postgres[1245]: LEFT JOIN pg_catalog.pg_proc AS n1419server # [ 141.978636] postgres[1245]: ON ev.objid = n.oid1420server # [ 141.979877] postgres[1245]: );1421server # [ 141.981676] postgres[1245]:1422server # [ 141.982675] postgres[1245]: IF func_is_graphql_resolve1423server # [ 141.983792] postgres[1245]: THEN1424server # [ 141.984346] postgres[1245]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1425server # [ 141.987307] postgres[1245]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1426server # [ 141.989917] postgres[1245]:1427server # [ 141.991096] postgres[1245]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1428server # [ 141.993585] postgres[1245]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1429server # [ 141.994879] postgres[1245]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1430server # [ 141.995849] postgres[1245]:1431server # [ 141.997928] postgres[1245]: DROP FUNCTION IF EXISTS graphql_public.graphql;1432server # [ 141.999688] postgres[1245]: create or replace function graphql_public.graphql(1433server # [ 142.001321] postgres[1245]: "operationName" text default null,1434server # [ 142.002238] postgres[1245]: query text default null,1435server # [ 142.003924] postgres[1245]: variables jsonb default null,1436server # [ 142.005661] postgres[1245]: extensions jsonb default null1437server # [ 142.006636] postgres[1245]: )1438server # [ 142.007549] postgres[1245]: returns jsonb1439server # [ 142.008856] postgres[1245]: language sql1440server # [ 142.009709] postgres[1245]: as $$1441server # [ 142.011637] postgres[1245]: SELECT graphql.resolve(query, coalesce(variables, '{}'));1442server # [ 142.013729] postgres[1245]: $$;1443server # [ 142.015928] postgres[1245]:1444server # [ 142.018730] postgres[1245]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1445server # [ 142.020160] postgres[1245]: END IF;1446server # [ 142.022484] postgres[1245]:1447server # [ 142.023505] postgres[1245]: END;1448server # [ 142.025870] postgres[1245]: $func$;1449server # [ 142.028027] postgres[1245]: ::1 2026-10-07 00:00:36.746 UTC [1245] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;1450server # [ 142.029824] postgres[1245]: ::1 2026-10-07 00:00:36.757 UTC [1245] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')1451server # [ 142.031001] postgres[1245]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access();1452server # [ 142.034072] postgres[1245]: ::1 2026-10-07 00:00:36.777 UTC [1245] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';1453server # [ 142.036265] postgres[1245]: ::1 2026-10-07 00:00:36.794 UTC [1245] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1454server # [ 142.039809] postgres[1245]: RETURNS event_trigger1455server # [ 142.041995] postgres[1245]: LANGUAGE plpgsql1456server # [ 142.043296] postgres[1245]: AS $func$1457server # [ 142.044588] postgres[1245]: DECLARE1458server # [ 142.046495] postgres[1245]: graphql_is_dropped bool;1459server # [ 142.047405] postgres[1245]: BEGIN1460server # [ 142.050111] postgres[1245]: graphql_is_dropped = (1461server # [ 142.051628] postgres[1245]: SELECT ev.schema_name = 'graphql_public'1462server # [ 142.053782] postgres[1245]: FROM pg_event_trigger_dropped_objects() AS ev1463server # [ 142.054786] postgres[1245]: WHERE ev.schema_name = 'graphql_public'1464server # [ 142.056225] postgres[1245]: );1465server # [ 142.058622] postgres[1245]:1466server # [ 142.061219] postgres[1245]: IF graphql_is_dropped1467server # [ 142.064948] postgres[1245]: THEN1468server # [ 142.066331] postgres[1245]: create or replace function graphql_public.graphql(1469server # [ 142.070062] postgres[1245]: "operationName" text default null,1470server # [ 142.073588] postgres[1245]: query text default null,1471server # [ 142.079124] postgres[1245]: variables jsonb default null,1472server # [ 142.082824] postgres[1245]: extensions jsonb default null1473server # [ 142.090233] postgres[1245]: )1474server # [ 142.091070] postgres[1245]: returns jsonb1475server # [ 142.093698] postgres[1245]: language plpgsql1476server # [ 142.097429] postgres[1245]: as $$1477server # [ 142.098638] postgres[1245]: DECLARE1478server # [ 142.108421] postgres[1245]: server_version float;1479server # [ 142.110043] postgres[1245]: BEGIN1480server # [ 142.121862] postgres[1245]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1481server # [ 142.125439] postgres[1245]:1482server # [ 142.127891] postgres[1245]: IF server_version >= 14 THEN1483server # [ 142.139554] postgres[1245]: RETURN jsonb_build_object(1484server # [ 142.146409] postgres[1245]: 'data', null::jsonb,1485server # [ 142.154286] postgres[1245]: 'errors', array['pg_graphql extension is not enabled.']1486server # [ 142.158551] postgres[1245]: );1487server # [ 142.178851] postgres[1245]: ELSE1488server # [ 142.180960] postgres[1245]: RETURN jsonb_build_object(1489server # [ 142.182215] postgres[1245]: 'data', null::jsonb,1490server # [ 142.183718] postgres[1245]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1491server # [ 142.189871] postgres[1245]: );1492server # [ 142.193544] postgres[1245]: END IF;1493server # [ 142.197412] postgres[1245]: END;1494server # [ 142.204705] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: CREATE FUNCTION1495server # [ 142.210760] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping1496server # [ 142.214215] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: DROP EVENT TRIGGER1497server # [ 142.219011] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: CREATE EVENT TRIGGER1498server # [ 142.222808] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: COMMENT1499server # [ 142.225987] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: CREATE FUNCTION1500server # [ 142.234141] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping1501server # [ 142.242133] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: DROP EVENT TRIGGER1502server # [ 142.247679] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: CREATE EVENT TRIGGER1503server # [ 142.253776] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1242]: COMMENT1504server # [ 142.261979] postgres[1245]: $$;1505server # [ 142.264094] postgres[1245]: END IF;1506server # [ 142.265741] postgres[1245]:1507server # [ 142.268720] postgres[1245]: END;1508server # [ 142.269936] postgres[1245]: $func$;1509server # [ 142.270850] postgres[1245]: ::1 2026-10-07 00:00:36.857 UTC [1245] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;1510server # [ 142.273968] postgres[1245]: ::1 2026-10-07 00:00:36.863 UTC [1245] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')1511server # [ 142.277338] postgres[1245]: EXECUTE PROCEDURE extensions.set_graphql_placeholder();1512server # [ 142.281284] postgres[1245]: ::1 2026-10-07 00:00:36.875 UTC [1245] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';1513server # [ 142.294422] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql1514server # [ 142.475088] postgres[1250]: ::1 2026-10-07 00:00:37.241 UTC [1250] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1515server # [ 142.482233] postgres[1250]: ::1 2026-10-07 00:00:37.246 UTC [1250] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1516server # [ 142.503822] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1249]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1517server # [ 142.510110] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1249]: DROP EVENT TRIGGER1518server # [ 142.511137] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1249]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1519server # [ 142.518741] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1249]: DROP FUNCTION1520server # [ 142.521766] postgres[1250]: ::1 2026-10-07 00:00:37.262 UTC [1250] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1521server # [ 142.529771] postgres[1250]: DECLARE1522server # [ 142.531004] postgres[1250]: cmd record;1523server # [ 142.532139] postgres[1250]: BEGIN1524server # [ 142.537320] postgres[1250]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1525server # [ 142.538745] postgres[1250]: LOOP1526server # [ 142.543982] postgres[1250]: IF cmd.command_tag IN (1527server # [ 142.546147] postgres[1250]: 'CREATE SCHEMA', 'ALTER SCHEMA'1528server # [ 142.548262] postgres[1250]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1529server # [ 142.554991] postgres[1250]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1530server # [ 142.561887] postgres[1250]: , 'CREATE VIEW', 'ALTER VIEW'1531server # [ 142.562843] postgres[1250]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1532server # [ 142.563711] postgres[1250]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1533server # [ 142.569983] postgres[1250]: , 'CREATE TRIGGER'1534server # [ 142.577163] postgres[1250]: , 'CREATE TYPE', 'ALTER TYPE'1535server # [ 142.580002] postgres[1250]: , 'CREATE RULE'1536server # [ 142.585900] postgres[1250]: , 'COMMENT'1537server # [ 142.586901] postgres[1250]: )1538server # [ 142.589492] postgres[1250]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1539server # [ 142.593741] postgres[1250]: AND cmd.schema_name is distinct from 'pg_temp'1540server # [ 142.596664] postgres[1250]: THEN1541server # [ 142.603611] postgres[1250]: NOTIFY pgrst, 'reload schema';1542server # [ 142.610710] postgres[1250]: END IF;1543server # [ 142.616233] postgres[1250]: END LOOP;1544server # [ 142.623182] postgres[1250]: END; $$ LANGUAGE plpgsql;1545server # [ 142.626140] postgres[1250]: ::1 2026-10-07 00:00:37.333 UTC [1250] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1546server # [ 142.633524] postgres[1250]: DECLARE1547server # [ 142.636258] postgres[1250]: obj record;1548server # [ 142.640727] postgres[1250]: BEGIN1549server # [ 142.642510] postgres[1250]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1550server # [ 142.645617] postgres[1250]: LOOP1551server # [ 142.653267] postgres[1250]: IF obj.object_type IN (1552server # [ 142.654988] postgres[1250]: 'schema'1553server # [ 142.657930] postgres[1250]: , 'table'1554server # [ 142.659221] postgres[1250]: , 'foreign table'1555server # [ 142.661592] postgres[1250]: , 'view'1556server # [ 142.662750] postgres[1250]: , 'materialized view'1557server # [ 142.665603] postgres[1250]: , 'function'1558server # [ 142.668166] postgres[1250]: , 'trigger'1559server # [ 142.670308] postgres[1250]: , 'type'1560server # [ 142.672277] postgres[1250]: , 'rule'1561server # [ 142.677393] postgres[1250]: )1562server # [ 142.679510] postgres[1250]: AND obj.is_temporary IS false -- no pg_temp objects1563server # [ 142.683106] postgres[1250]: THEN1564server # [ 142.684034] postgres[1250]: NOTIFY pgrst, 'reload schema';1565server # [ 142.685914] postgres[1250]: END IF;1566server # [ 142.702016] postgres[1250]: END LOOP;1567server # [ 142.711807] postgres[1250]: END; $$ LANGUAGE plpgsql;1568server # [ 142.716683] postgres[1250]: ::1 2026-10-07 00:00:37.370 UTC [1250] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1569server # [ 142.728169] postgres[1250]: ::1 2026-10-07 00:00:37.385 UTC [1250] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1570server # [ 142.735591] postgres[1250]: ON ddl_command_end1571server # [ 142.739067] postgres[1250]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1572server # [ 142.743664] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1249]: CREATE FUNCTION1573server # [ 142.746368] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1249]: CREATE FUNCTION1574server # [ 142.749528] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1249]: DROP EVENT TRIGGER1575server # [ 142.752753] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1249]: CREATE EVENT TRIGGER1576server # [ 142.755026] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1249]: DROP EVENT TRIGGER1577server # [ 142.758739] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1249]: CREATE EVENT TRIGGER1578server # [ 142.763901] postgres[1250]: ::1 2026-10-07 00:00:37.408 UTC [1250] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1579server # [ 142.768071] postgres[1250]: ::1 2026-10-07 00:00:37.433 UTC [1250] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1580server # [ 142.772605] postgres[1250]: ON sql_drop1581server # [ 142.775792] postgres[1250]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1582server # [ 142.781222] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220322085208_gotrue-session-limit.sql1583server # [ 143.065865] postgres[1252]: ::1 2026-10-07 00:00:37.821 UTC [1252] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;1584server # [ 143.107870] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1251]: ALTER ROLE1585server # [ 143.116859] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql1586server # [ 143.585341] postgres[1261]: ::1 2026-10-07 00:00:38.350 UTC [1261] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1587server # [ 143.590753] postgres[1261]: returns event_trigger1588server # [ 143.599597] postgres[1261]: language plpgsql1589server # [ 143.601594] postgres[1261]: AS $func$1590server # [ 143.602454] postgres[1261]: DECLARE1591server # [ 143.603546] postgres[1261]: func_is_graphql_resolve bool;1592server # [ 143.605479] postgres[1261]: BEGIN1593server # [ 143.614959] postgres[1261]: func_is_graphql_resolve = (1594server # [ 143.617549] postgres[1261]: SELECT n.proname = 'resolve'1595server # [ 143.622807] postgres[1261]: FROM pg_event_trigger_ddl_commands() AS ev1596server # [ 143.629749] postgres[1261]: LEFT JOIN pg_catalog.pg_proc AS n1597server # [ 143.630566] postgres[1261]: ON ev.objid = n.oid1598server # [ 143.631468] postgres[1261]: );1599server # [ 143.633813] postgres[1261]:1600server # [ 143.637814] postgres[1261]: IF func_is_graphql_resolve1601server # [ 143.646251] postgres[1261]: THEN1602server # [ 143.647954] postgres[1261]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1603server # [ 143.650638] postgres[1261]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1604server # [ 143.653534] postgres[1261]:1605server # [ 143.655139] postgres[1261]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1606server # [ 143.664405] postgres[1261]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1607server # [ 143.674003] postgres[1261]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1608server # [ 143.681624] postgres[1261]:1609server # [ 143.682768] postgres[1261]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1610server # [ 143.685589] postgres[1261]: DROP FUNCTION IF EXISTS graphql_public.graphql;1611server # [ 143.691871] postgres[1261]: create or replace function graphql_public.graphql(1612server # [ 143.698470] postgres[1261]: "operationName" text default null,1613server # [ 143.701727] postgres[1261]: query text default null,1614server # [ 143.702596] postgres[1261]: variables jsonb default null,1615server # [ 143.703809] postgres[1261]: extensions jsonb default null1616server # [ 143.709318] postgres[1261]: )1617server # [ 143.710734] postgres[1261]: returns jsonb1618server # [ 143.711519] postgres[1261]: language sql1619server # [ 143.712773] postgres[1261]: as $$1620server # [ 143.714413] postgres[1261]: -- This changed1621server # [ 143.717924] postgres[1261]: select graphql.resolve(1622server # [ 143.725454] postgres[1261]: query := query,1623server # [ 143.726534] postgres[1261]: variables := coalesce(variables, '{}'),1624server # [ 143.727398] postgres[1261]: "operationName" := "operationName",1625server # [ 143.728695] postgres[1261]: extensions := extensions1626server # [ 143.730791] postgres[1261]: );1627server # [ 143.733731] postgres[1261]: $$;1628server # [ 143.735379] postgres[1261]:1629server # [ 143.741778] postgres[1261]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1630server # [ 143.742972] postgres[1261]: END IF;1631server # [ 143.743666] postgres[1261]:1632server # [ 143.744794] postgres[1261]: END;1633server # [ 143.747225] postgres[1261]: $func$;1634server # [ 143.753717] postgres[1261]: ::1 2026-10-07 00:00:38.470 UTC [1261] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1635server # [ 143.755045] postgres[1261]: RETURNS event_trigger1636server # [ 143.755783] postgres[1261]: LANGUAGE plpgsql1637server # [ 143.762323] postgres[1261]: AS $func$1638server # [ 143.764069] postgres[1261]: DECLARE1639server # [ 143.770190] postgres[1261]: graphql_is_dropped bool;1640server # [ 143.773258] postgres[1261]: BEGIN1641server # [ 143.782233] postgres[1261]: graphql_is_dropped = (1642server # [ 143.783449] postgres[1261]: SELECT ev.schema_name = 'graphql_public'1643server # [ 143.789349] postgres[1261]: FROM pg_event_trigger_dropped_objects() AS ev1644server # [ 143.791634] postgres[1261]: WHERE ev.schema_name = 'graphql_public'1645server # [ 143.800277] postgres[1261]: );1646server # [ 143.817365] postgres[1261]:1647server # [ 143.822433] postgres[1261]: IF graphql_is_dropped1648server # [ 143.833206] postgres[1261]: THEN1649server # [ 143.834401] postgres[1261]: create or replace function graphql_public.graphql(1650server # [ 143.836666] postgres[1261]: "operationName" text default null,1651server # [ 143.839426] postgres[1261]: query text default null,1652server # [ 143.843148] postgres[1261]: variables jsonb default null,1653server # [ 143.850692] postgres[1261]: extensions jsonb default null1654server # [ 143.851942] postgres[1261]: )1655server # [ 143.857688] postgres[1261]: returns jsonb1656server # [ 143.859273] postgres[1261]: language plpgsql1657server # [ 143.863700] postgres[1261]: as $$1658server # [ 143.866272] postgres[1261]: DECLARE1659server # [ 143.871415] postgres[1261]: server_version float;1660server # [ 143.875906] postgres[1261]: BEGIN1661server # [ 143.883159] postgres[1261]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1662server # [ 143.886447] postgres[1261]:1663server # [ 143.892997] postgres[1261]: IF server_version >= 14 THEN1664server # [ 143.897016] postgres[1261]: RETURN jsonb_build_object(1665server # [ 143.902773] postgres[1261]: 'errors', jsonb_build_array(1666server # [ 143.910663] postgres[1261]: jsonb_build_object(1667server # [ 143.914853] postgres[1261]: 'message', 'pg_graphql extension is not enabled.'1668server # [ 143.918763] postgres[1261]: )1669server # [ 143.925522] postgres[1261]: )1670server # [ 143.927218] postgres[1261]: );1671server # [ 143.932428] postgres[1261]: ELSE1672server # [ 143.934206] postgres[1261]: RETURN jsonb_build_object(1673server # [ 143.937214] postgres[1261]: 'errors', jsonb_build_array(1674server # [ 143.940209] postgres[1261]: jsonb_build_object(1675server # [ 143.943552] postgres[1261]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1676server # [ 143.953558] postgres[1261]: )1677server # [ 143.957402] postgres[1261]: )1678server # [ 143.959384] postgres[1261]: );1679server # [ 143.963118] postgres[1261]: END IF;1680server # [ 143.970349] postgres[1261]: END;1681server # [ 143.974455] postgres[1261]: $$;1682server # [ 143.978550] postgres[1261]: END IF;1683server # [ 143.982399] postgres[1261]:1684server # [ 143.984658] postgres[1261]: END;1685server # [ 143.990769] postgres[1261]: $func$;1686server # [ 143.994060] postgres[1261]: ::1 2026-10-07 00:00:38.517 UTC [1261] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1687server # [ 143.997961] postgres[1261]: "operationName" text default null,1688server # [ 143.999778] postgres[1261]: query text default null,1689server # [ 144.003123] postgres[1261]: variables jsonb default null,1690server # [ 144.015157] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1253]: CREATE FUNCTION1691server # [ 144.018275] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1253]: CREATE FUNCTION1692server # [ 144.022168] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1253]: CREATE FUNCTION1693server # [ 144.024398] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1253]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping1694server # [ 144.026295] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1253]: DROP EXTENSION1695server # [ 144.031114] postgres[1261]: extensions jsonb default null1696server # [ 144.032592] postgres[1261]: )1697server # [ 144.034143] postgres[1261]: returns jsonb1698server # [ 144.037378] postgres[1261]: language plpgsql1699server # [ 144.039440] postgres[1261]: as $$1700server # [ 144.042232] postgres[1261]: DECLARE1701server # [ 144.046082] postgres[1261]: server_version float;1702server # [ 144.048981] postgres[1261]: BEGIN1703server # [ 144.050781] postgres[1261]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1704server # [ 144.055418] postgres[1261]:1705server # [ 144.058567] postgres[1261]: IF server_version >= 14 THEN1706server # [ 144.061787] postgres[1261]: RETURN jsonb_build_object(1707server # [ 144.065415] postgres[1261]: 'errors', jsonb_build_array(1708server # [ 144.067871] postgres[1261]: jsonb_build_object(1709server # [ 144.072115] postgres[1261]: 'message', 'pg_graphql extension is not enabled.'1710server # [ 144.076037] postgres[1261]: )1711server # [ 144.078327] postgres[1261]: )1712server # [ 144.079692] postgres[1261]: );1713server # [ 144.081524] postgres[1261]: ELSE1714server # [ 144.086243] postgres[1261]: RETURN jsonb_build_object(1715server # [ 144.087863] postgres[1261]: 'errors', jsonb_build_array(1716server # [ 144.094032] postgres[1261]: jsonb_build_object(1717server # [ 144.096842] postgres[1261]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1718server # [ 144.099095] postgres[1261]: )1719server # [ 144.104776] postgres[1261]: )1720server # [ 144.107924] postgres[1261]: );1721server # [ 144.111733] postgres[1261]: END IF;1722server # [ 144.117784] postgres[1261]: END;1723server # [ 144.121285] postgres[1261]: $$;1724server # [ 144.124300] postgres[1261]: ::1 2026-10-07 00:00:38.557 UTC [1261] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1725server # [ 145.605508] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1253]: DO1726server # [ 145.659890] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql1727server # [ 145.930977] postgres[1276]: ::1 2026-10-07 00:00:40.698 UTC [1276] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres;1728server # [ 145.963545] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1275]: GRANT ROLE1729server # [ 145.983317] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql1730server # [ 146.269955] postgres[1278]: ::1 2026-10-07 00:00:41.033 UTC [1278] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1731server # [ 146.278212] postgres[1278]: returns event_trigger1732server # [ 146.285424] postgres[1278]: language plpgsql1733server # [ 146.294059] postgres[1278]: AS $func$1734server # [ 146.295640] postgres[1278]: DECLARE1735server # [ 146.298032] postgres[1278]: func_is_graphql_resolve bool;1736server # [ 146.303052] postgres[1278]: BEGIN1737server # [ 146.309927] postgres[1278]: func_is_graphql_resolve = (1738server # [ 146.317613] postgres[1278]: SELECT n.proname = 'resolve'1739server # [ 146.318866] postgres[1278]: FROM pg_event_trigger_ddl_commands() AS ev1740server # [ 146.322504] postgres[1278]: LEFT JOIN pg_catalog.pg_proc AS n1741server # [ 146.329315] postgres[1278]: ON ev.objid = n.oid1742server # [ 146.331027] postgres[1278]: );1743server # [ 146.342429] postgres[1278]:1744server # [ 146.349802] postgres[1278]: IF func_is_graphql_resolve1745server # [ 146.351818] postgres[1278]: THEN1746server # [ 146.357168] postgres[1278]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1747server # [ 146.362068] postgres[1278]: DROP FUNCTION IF EXISTS graphql_public.graphql;1748server # [ 146.363749] postgres[1278]: create or replace function graphql_public.graphql(1749server # [ 146.370440] postgres[1278]: "operationName" text default null,1750server # [ 146.372801] postgres[1278]: query text default null,1751server # [ 146.373963] postgres[1278]: variables jsonb default null,1752server # [ 146.377615] postgres[1278]: extensions jsonb default null1753server # [ 146.385718] postgres[1278]: )1754server # [ 146.393441] postgres[1278]: returns jsonb1755server # [ 146.395875] postgres[1278]: language sql1756server # [ 146.401413] postgres[1278]: as $$1757server # [ 146.402584] postgres[1278]: select graphql.resolve(1758server # [ 146.403735] postgres[1278]: query := query,1759server # [ 146.406242] postgres[1278]: variables := coalesce(variables, '{}'),1760server # [ 146.409407] postgres[1278]: "operationName" := "operationName",1761server # [ 146.413296] postgres[1278]: extensions := extensions1762server # [ 146.414356] postgres[1278]: );1763server # [ 146.415510] postgres[1278]: $$;1764server # [ 146.417406] postgres[1278]:1765server # [ 146.418301] postgres[1278]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1766server # [ 146.421219] postgres[1278]: -- function in the extension so we need to grant permissions on existing entities AND1767server # [ 146.422747] postgres[1278]: -- update default permissions to any others that are created after `graphql.resolve`1768server # [ 146.426479] postgres[1278]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1769server # [ 146.430349] postgres[1278]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1770server # [ 146.431945] postgres[1278]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1771server # [ 146.437892] postgres[1278]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1772server # [ 146.438698] postgres[1278]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1773server # [ 146.446217] postgres[1278]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1774server # [ 146.449224] postgres[1278]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1775server # [ 146.453443] postgres[1278]: END IF;1776server # [ 146.454892] postgres[1278]:1777server # [ 146.458196] postgres[1278]: END;1778server # [ 146.468034] postgres[1278]: $func$;1779server # [ 146.470077] postgres[1278]: ::1 2026-10-07 00:00:41.172 UTC [1278] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1780server # [ 146.484363] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1277]: CREATE FUNCTION1781server # [ 146.489733] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1277]: DROP EXTENSION1782server # [ 148.134971] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1277]: DO1783server # [ 148.174966] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql1784server # [ 149.091703] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1299]: DO1785server: Guest root shell did not produce any data yet...1786server: To debug, enter the VM and run 'systemctl status backdoor.service'.1787server # [ 149.711008] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1299]: DO1788server # [ 149.778936] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql1789server # [ 150.138676] postgres[1311]: ::1 2026-10-07 00:00:44.901 UTC [1311] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s';1790server # [ 150.187080] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1305]: ALTER ROLE1791server # [ 150.226645] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221103090837_revoke_admin.sql1792server # [ 150.568958] postgres[1319]: ::1 2026-10-07 00:00:45.323 UTC [1319] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator;1793server # [ 150.586710] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1316]: REVOKE ROLE1794server # [ 150.629316] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql1795server # [ 150.786574] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31796server # [ 152.707743] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1323]: DO1797server # [ 152.751962] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql1798server # [ 153.048819] postgres[1329]: ::1 2026-10-07 00:00:47.806 UTC [1329] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres;1799server # [ 153.078096] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1328]: GRANT ROLE1800server # [ 153.118052] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql1801server # [ 153.492984] postgres[1332]: ::1 2026-10-07 00:00:48.242 UTC [1332] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option;1802server # [ 153.563108] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1330]: GRANT1803server # [ 153.582112] postgres[1332]: ::1 2026-10-07 00:00:48.317 UTC [1332] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option;1804server # [ 153.651260] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1330]: GRANT1805server # [ 153.656870] postgres[1332]: ::1 2026-10-07 00:00:48.430 UTC [1332] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option;1806server # [ 153.673153] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1330]: GRANT1807server # [ 153.677504] postgres[1332]: ::1 2026-10-07 00:00:48.448 UTC [1332] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;1808server # [ 153.693787] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1330]: ALTER DEFAULT PRIVILEGES1809server # [ 153.697370] postgres[1332]: ::1 2026-10-07 00:00:48.469 UTC [1332] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;1810server # [ 153.705022] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1330]: ALTER DEFAULT PRIVILEGES1811server # [ 153.710705] postgres[1332]: ::1 2026-10-07 00:00:48.480 UTC [1332] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;1812server # [ 153.719307] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1330]: ALTER DEFAULT PRIVILEGES1813server # [ 153.787694] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql1814server # [ 154.199943] postgres[1346]: ::1 2026-10-07 00:00:48.969 UTC [1346] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres;1815server # [ 154.271540] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1341]: GRANT ROLE1816server # [ 154.311774] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql1817server # [ 154.706092] postgres[1353]: ::1 2026-10-07 00:00:49.467 UTC [1353] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin;1818server # [ 154.782803] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1350]: GRANT ROLE1819server # [ 154.805126] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql1820server # [ 155.079296] postgres[1357]: ::1 2026-10-07 00:00:49.839 UTC [1357] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit;1821server # [ 155.091031] postgres[1357]: ::1 2026-10-07 00:00:49.852 UTC [1357] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit;1822server # [ 155.097814] postgres[1357]: ::1 2026-10-07 00:00:49.861 UTC [1357] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit;1823server # [ 155.108165] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1354]: ALTER ROLE1824server # [ 155.113901] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1354]: ALTER ROLE1825server # [ 155.118573] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1354]: ALTER ROLE1826server # [ 155.132784] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1354]: DO1827server # [ 155.188799] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql1828server # [ 155.491457] postgres[1359]: ::1 2026-10-07 00:00:50.262 UTC [1359] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin;1829server # [ 155.502364] postgres[1359]: ::1 2026-10-07 00:00:50.275 UTC [1359] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin;1830server # [ 155.513572] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1358]: GRANT ROLE1831server # [ 155.529709] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1358]: REVOKE ROLE1832server # [ 155.559434] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql1833server # [ 155.811048] postgres[1361]: ::1 2026-10-07 00:00:50.578 UTC [1361] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1834server # [ 155.818082] postgres[1361]: returns event_trigger1835server # [ 155.820084] postgres[1361]: language plpgsql1836server # [ 155.825355] postgres[1361]: AS $func$1837server # [ 155.829842] postgres[1361]: DECLARE1838server # [ 155.831033] postgres[1361]: func_is_graphql_resolve bool;1839server # [ 155.834918] postgres[1361]: BEGIN1840server # [ 155.836770] postgres[1361]: func_is_graphql_resolve = (1841server # [ 155.841775] postgres[1361]: SELECT n.proname = 'resolve'1842server # [ 155.843100] postgres[1361]: FROM pg_event_trigger_ddl_commands() AS ev1843server # [ 155.848957] postgres[1361]: LEFT JOIN pg_catalog.pg_proc AS n1844server # [ 155.850645] postgres[1361]: ON ev.objid = n.oid1845server # [ 155.851504] postgres[1361]: );1846server # [ 155.857287] postgres[1361]:1847server # [ 155.858623] postgres[1361]: IF func_is_graphql_resolve1848server # [ 155.859410] postgres[1361]: THEN1849server # [ 155.866362] postgres[1361]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1850server # [ 155.868293] postgres[1361]: DROP FUNCTION IF EXISTS graphql_public.graphql;1851server # [ 155.874747] postgres[1361]: create or replace function graphql_public.graphql(1852server # [ 155.876951] postgres[1361]: "operationName" text default null,1853server # [ 155.882893] postgres[1361]: query text default null,1854server # [ 155.897707] postgres[1361]: variables jsonb default null,1855server # [ 155.899008] postgres[1361]: extensions jsonb default null1856server # [ 155.901819] postgres[1361]: )1857server # [ 155.905785] postgres[1361]: returns jsonb1858server # [ 155.906746] postgres[1361]: language sql1859server # [ 155.913434] postgres[1361]: as $$1860server # [ 155.914731] postgres[1361]: select graphql.resolve(1861server # [ 155.915823] postgres[1361]: query := query,1862server # [ 155.921343] postgres[1361]: variables := coalesce(variables, '{}'),1863server # [ 155.922504] postgres[1361]: "operationName" := "operationName",1864server # [ 155.923789] postgres[1361]: extensions := extensions1865server # [ 155.930676] postgres[1361]: );1866server # [ 155.933448] postgres[1361]: $$;1867server # [ 155.934786] postgres[1361]:1868server # [ 155.935981] postgres[1361]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1869server # [ 155.937774] postgres[1361]: -- function in the extension so we need to grant permissions on existing entities AND1870server # [ 155.939781] postgres[1361]: -- update default permissions to any others that are created after `graphql.resolve`1871server # [ 155.942159] postgres[1361]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1872server # [ 155.943170] postgres[1361]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1873server # [ 155.946968] postgres[1361]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1874server # [ 155.949851] postgres[1361]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1875server # [ 155.951421] postgres[1361]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1876server # [ 155.954238] postgres[1361]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1877server # [ 155.955718] postgres[1361]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1878server # [ 155.959499] postgres[1361]:1879server # [ 155.961418] postgres[1361]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles1880server # [ 155.962485] postgres[1361]: grant usage on schema graphql_public to postgres with grant option;1881server # [ 155.963666] postgres[1361]: grant usage on schema graphql to postgres with grant option;1882server # [ 155.965895] postgres[1361]: END IF;1883server # [ 155.967317] postgres[1361]:1884server # [ 155.969333] postgres[1361]: END;1885server # [ 155.972585] postgres[1361]: $func$;1886server # [ 155.975097] postgres[1361]: ::1 2026-10-07 00:00:50.676 UTC [1361] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1887server # [ 155.983453] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1360]: CREATE FUNCTION1888server # [ 155.987342] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1360]: DROP EXTENSION1889server # [ 157.578771] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1360]: DO1890server # [ 157.646991] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql1891server # [ 158.018486] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1374]: DO1892server # [ 158.030752] postgres[1378]: ::1 2026-10-07 00:00:52.779 UTC [1378] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger1893server # [ 158.043171] postgres[1378]: LANGUAGE plpgsql1894server # [ 158.049805] postgres[1378]: AS $$1895server # [ 158.051955] postgres[1378]: BEGIN1896server # [ 158.057898] postgres[1378]: IF EXISTS (1897server # [ 158.061673] postgres[1378]: SELECT1898server # [ 158.066579] postgres[1378]: FROM pg_event_trigger_ddl_commands() AS ev1899server # [ 158.068153] postgres[1378]: JOIN pg_extension AS ext1900server # [ 158.073782] postgres[1378]: ON ev.objid = ext.oid1901server # [ 158.081605] postgres[1378]: WHERE ext.extname = 'pg_cron'1902server # [ 158.083613] postgres[1378]: )1903server # [ 158.089370] postgres[1378]: THEN1904server # [ 158.091375] postgres[1378]: grant usage on schema cron to postgres with grant option;1905server # [ 158.097629] postgres[1378]:1906server # [ 158.098690] postgres[1378]: alter default privileges in schema cron grant all on tables to postgres with grant option;1907server # [ 158.099703] postgres[1378]: alter default privileges in schema cron grant all on functions to postgres with grant option;1908server # [ 158.101669] postgres[1378]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1909server # [ 158.109230] postgres[1378]:1910server # [ 158.112969] postgres[1378]: alter default privileges for user supabase_admin in schema cron grant all1911server # [ 158.117465] postgres[1378]: on sequences to postgres with grant option;1912server # [ 158.121416] postgres[1378]: alter default privileges for user supabase_admin in schema cron grant all1913server # [ 158.126289] postgres[1378]: on tables to postgres with grant option;1914server # [ 158.127996] postgres[1378]: alter default privileges for user supabase_admin in schema cron grant all1915server # [ 158.133010] postgres[1378]: on functions to postgres with grant option;1916server # [ 158.134179] postgres[1378]:1917server # [ 158.141420] postgres[1378]: grant all privileges on all tables in schema cron to postgres with grant option;1918server # [ 158.142808] postgres[1378]: revoke all on table cron.job from postgres;1919server # [ 158.143646] postgres[1378]: grant select on table cron.job to postgres with grant option;1920server # [ 158.145394] postgres[1378]: END IF;1921server # [ 158.150455] postgres[1378]: END;1922server # [ 158.151894] postgres[1378]: $$;1923server # [ 158.158032] postgres[1378]: ::1 2026-10-07 00:00:52.883 UTC [1378] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access;1924server # [ 158.159587] postgres[1378]: ::1 2026-10-07 00:00:52.902 UTC [1378] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;1925server # [ 158.165595] postgres[1378]: ::1 2026-10-07 00:00:52.927 UTC [1378] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end1926server # [ 158.170776] postgres[1378]: WHEN TAG IN ('CREATE EXTENSION')1927server # [ 158.178018] postgres[1378]: EXECUTE FUNCTION extensions.grant_pg_cron_access();1928server # [ 158.190987] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1374]: CREATE FUNCTION1929server # [ 158.209205] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1374]: DROP EVENT TRIGGER1930server # [ 158.229795] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1374]: ALTER FUNCTION1931server # [ 158.230977] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1374]: CREATE EVENT TRIGGER1932server # [ 158.237592] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql1933server # [ 158.727171] postgres[1385]: ::1 2026-10-07 00:00:53.498 UTC [1385] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s';1934server # [ 158.763935] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1383]: ALTER ROLE1935server # [ 158.820046] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql1936server # [ 159.115423] postgres[1387]: ::1 2026-10-07 00:00:53.877 UTC [1387] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin;1937server # [ 159.129898] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1386]: ALTER FUNCTION1938server # [ 159.147684] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1386]: ALTER FUNCTION1939server # [ 159.158685] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1386]: ALTER FUNCTION1940server # [ 159.164016] postgres[1387]: ::1 2026-10-07 00:00:53.901 UTC [1387] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;1941server # [ 159.179647] postgres[1387]: ::1 2026-10-07 00:00:53.910 UTC [1387] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;1942server # [ 159.213580] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql1943server # [ 159.498008] postgres[1389]: ::1 2026-10-07 00:00:54.269 UTC [1389] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres;1944server # [ 159.515815] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1388]: GRANT ROLE1945server # [ 159.548480] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241031003909_create_orioledb.sql1946server # [ 160.462977] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1390]: DO1947server # [ 160.517535] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql1948server # [ 160.927649] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1392]: DO1949server # [ 160.941965] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1392]: DO1950server # [ 160.996772] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql1951server # [ 161.391363] postgres[1403]: ::1 2026-10-07 00:00:56.156 UTC [1403] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none;1952server # [ 161.399207] postgres[1403]: ::1 2026-10-07 00:00:56.168 UTC [1403] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none;1953server # [ 161.414675] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1399]: ALTER ROLE1954server # [ 161.416995] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1399]: ALTER ROLE1955server # [ 161.418622] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1399]: ALTER ROLE1956server # [ 161.453703] postgres[1403]: ::1 2026-10-07 00:00:56.181 UTC [1403] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none;1957server # [ 161.469578] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql1958server # [ 161.914334] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1405]: DO1959server # [ 161.962886] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql1960server # [ 162.352587] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1412]: DO1961server # [ 162.392760] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql1962server # [ 162.907198] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1420]: CREATE FUNCTION1963server # [ 162.922923] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1420]: DO1964server # [ 162.978730] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql1965server # [ 163.343539] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1422]: ALTER FUNCTION1966server # [ 163.350784] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1422]: GRANT1967server # [ 163.399187] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql1968server # [ 163.679256] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1424]: DROP EVENT TRIGGER1969server # [ 163.710077] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1424]: ALTER FUNCTION1970server # [ 163.725001] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1424]: CREATE EVENT TRIGGER1971server # [ 163.773906] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql1972server # [ 164.055199] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1426]: DO1973server # [ 164.099163] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql1974server # [ 164.501361] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1428]: CREATE FUNCTION1975server # [ 164.511100] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1428]: GRANT1976server # [ 164.570864] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql1977server # [ 164.982643] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1436]: REVOKE ROLE1978server # [ 165.072914] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1436]: DO1979server # [ 165.094330] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1436]: DO1980server # [ 165.102323] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1436]: REVOKE ROLE1981server # [ 165.121321] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1436]: REVOKE1982server # [ 165.188031] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1436]: DO1983server # [ 165.263147] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql1984server # [ 165.632492] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1449]: DO1985server # [ 165.668629] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql1986server # [ 165.994065] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1454]: DO1987server # [ 166.039736] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql1988server # [ 166.355612] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1456]: DO1989server # [ 166.402953] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql1990server # [ 166.697994] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1458]: ALTER ROLE1991server # [ 166.738279] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251001204436_predefined_role_grants.sql1992server # [ 167.062890] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1460]: GRANT ROLE1993server # [ 167.065086] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1460]: DO1994server # [ 167.110570] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql1995server # [ 167.691462] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1462]: GRANT1996server # [ 167.787755] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql1997server # [ 168.199229] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1477]: CREATE FUNCTION1998server # [ 168.205698] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1477]: REVOKE1999server # [ 168.218043] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1477]: REVOKE2000server # [ 168.230491] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1477]: GRANT2001server # [ 168.266492] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260211120934_supabase_privileged_role.sql2002server # [ 168.605543] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1486]: DO2003server # [ 168.659542] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql2004server # [ 169.009280] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1491]: ALTER ROLE2005server # [ 169.052568] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql2006server # [ 169.339769] systemd[1]: Starting Virtual Console Setup...2007server # [ 169.555027] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1493]: DROP EXTENSION2008server # [ 169.612725] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql2009server # [ 169.687069] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2010server # [ 169.722665] systemd[1]: Stopped Virtual Console Setup.2011server # [ 169.929484] systemd[1]: Starting Virtual Console Setup...2012server # [ 170.103612] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1496]: CREATE FUNCTION2013server # [ 170.115622] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1496]: DROP EVENT TRIGGER2014server # [ 170.126849] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1496]: CREATE EVENT TRIGGER2015server # [ 170.196006] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql2016server # [ 170.695862] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1500]: DO2017server # [ 170.813670] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1500]: CREATE FUNCTION2018server # [ 170.863568] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql2019server # [ 171.317427] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1503]: CREATE FUNCTION2020server # [ 171.335882] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1503]: CREATE FUNCTION2021server # [ 171.412915] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Running postgresql schema...2022server # [ 172.141281] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER DATABASE2023server # [ 172.157743] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER DATABASE2024server # [ 172.297333] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER ROLE2025server # [ 172.410153] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER ROLE2026server # [ 172.524569] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER ROLE2027server # [ 172.599203] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER ROLE2028server # [ 172.680530] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER ROLE2029server # [ 172.747115] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER ROLE2030server # [ 172.852186] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER ROLE2031server # [ 172.940848] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER ROLE2032server # [ 173.028725] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER ROLE2033server # [ 173.053168] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1505]: ALTER ROLE2034server # [ 173.119626] c60wv9harjpiddsm4g57adza670p5qlc-supabase-db-init[1087]: Database initialization complete2035server # [ 173.246769] systemd[1]: Finished Supabase Database Initialization.2036server # [ 174.847385] systemd-vconsole-setup[1499]: Configuration of first virtual console was skipped, ignoring remaining ones.2037server # [ 174.880114] systemd[1]: Finished Virtual Console Setup.2038server # [ 176.163342] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2039server # [ 178.520960] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2040server # [ 179.171078] 8021q: 802.1Q VLAN Support v1.82041server: Guest root shell did not produce any data yet...2042server: To debug, enter the VM and run 'systemctl status backdoor.service'.2043server # [ 179.411206] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2044server # [ 179.473644] systemd[1]: Started backdoor.service.2045server # [ 179.493190] systemd[1]: Reached target Multi-User System.2046server # [ 179.504841] systemd[1]: Startup finished in 2.317s (kernel) + 28.521s (initrd) + 2min 28.653s (userspace) = 2min 59.493s.2047server # [ 179.811480] cfg80211: Loading compiled-in X.509 certificates for regulatory database2048server # [ 179.800145] (udev-worker)[1566]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.2049server # [ 179.887521] (udev-worker)[1566]: Network interface NamePolicy= disabled on kernel command line.2050server # [ 180.214622] (udev-worker)[1560]: Network interface NamePolicy= disabled on kernel command line.2051server # [ 180.379448] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2052server # [ 180.380229] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2053server # [ 180.441926] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22054server # [ 180.442427] cfg80211: failed to load regulatory.db2055server # connecting to host...2056server # [ 181.046339] systemd[1]: Condition check resulted in Virtio network device being skipped.2057server: Guest shell says: b'Spawning backdoor root shell...\n'2058server: connected to guest root shell2059server: (connecting took 182.10 seconds)2060server: (finished: waiting for the VM to finish booting, in 182.10 seconds)2061server # [ 181.116393] systemd[1]: Starting Address configuration of eth1...2062server # [ 182.500020] 8021q: adding VLAN 0 to HW filter on device eth12063server # [ 182.631953] 8021q: adding VLAN 0 to HW filter on device eth02064server # [ 182.550617] dhcpcd[776]: eth0: waiting for carrier2065server # [ 182.564511] dhcpcd[776]: eth0: carrier acquired2066server # [ 182.709190] network-addresses-eth1-start[1584]: adding address 192.168.1.1/24... done2067server: (finished: waiting for unit supabase-db-init.service, in 183.77 seconds)2068subtest: Verify PostgreSQL 15 is our custom build2069server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT version();"2070server # [ 182.857276] dhcpcd[776]: DUID 00:01:00:01:32:58:48:4d:52:54:00:12:34:562071server # [ 182.862223] dhcpcd[776]: eth0: IAID 00:12:34:562072server # [ 182.867187] dhcpcd[776]: eth0: adding address fe80::5054:ff:fe12:34562073server # [ 183.014946] network-addresses-eth1-start[1584]: adding address 2001:db8:1::1/64... done2074server # [ 183.379380] systemd[1]: Finished Address configuration of eth1.2075server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT version();", in 0.97 seconds)2076server: must succeed: readlink -f $(which postgres)2077server: (finished: must succeed: readlink -f $(which postgres), in 0.52 seconds)2078(finished: subtest: Verify PostgreSQL 15 is our custom build, in 1.49 seconds)2079subtest: Verify ansible config loaded2080server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW shared_preload_libraries;"2081server # [ 184.659543] dhcpcd[776]: eth0: soliciting a DHCP lease2082server # [ 184.695706] dhcpcd[776]: eth0: offered 10.0.2.15 from 10.0.2.22083server # [ 184.711598] dhcpcd[776]: eth0: probing address 10.0.2.15/242084server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW shared_preload_libraries;", in 0.58 seconds)2085server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW session_preload_libraries;"2086server # [ 185.035796] dhcpcd[776]: eth0: soliciting an IPv6 router2087server # [ 185.051558] dhcpcd[776]: eth0: Router Advertisement from fe80::22088server # [ 185.071913] dhcpcd[776]: eth0: adding address fec0::5054:ff:fe12:3456/642089server # [ 185.101219] dhcpcd[776]: eth0: adding route to fec0::/642090server # [ 185.110950] dhcpcd[776]: eth0: adding default route via fe80::22091server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SHOW session_preload_libraries;", in 0.85 seconds)2092(finished: subtest: Verify ansible config loaded, in 1.43 seconds)2093subtest: Verify init scripts and migrations ran2094server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT rolname FROM pg_roles ORDER BY rolname;"2095server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT rolname FROM pg_roles ORDER BY rolname;", in 0.86 seconds)2096server: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT schema_name FROM information_schema.schemata ORDER BY schema_name;"2097server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -c "SELECT schema_name FROM information_schema.schemata ORDER BY schema_name;", in 1.06 seconds)2098(finished: subtest: Verify init scripts and migrations ran, in 1.92 seconds)2099subtest: Check upgrade path with postgresql 152100server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" 2101server # NOTICE: extension "plv8" does not exist, skipping2102server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.55 seconds)2103server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.4' CASCADE;" 2104server # [ 190.786170] dhcpcd[776]: eth0: leased 10.0.2.15 for 86400 seconds2105server # [ 190.812000] dhcpcd[776]: eth0: adding route to 10.0.2.0/242106server # [ 190.832025] dhcpcd[776]: eth0: adding default route via 10.0.2.22107server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.4' CASCADE;" , in 7.98 seconds)2108server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" 2109server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.88 seconds)2110server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" 2111server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 1.11 seconds)2112server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.5' CASCADE;" 2113server # [ 201.802969] systemd-logind[612]: Watching system buttons on /dev/input/event0 (gpio-keys)2114server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.5' CASCADE;" , in 8.73 seconds)2115server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" 2116server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.99 seconds)2117server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" 2118server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 1.15 seconds)2119server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" 2120server # [ 215.228561] systemd-logind[612]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2121server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 6.45 seconds)2122server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" 2123server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.77 seconds)2124(finished: subtest: Check upgrade path with postgresql 15, in 28.61 seconds)2125subtest: Check the install of the last version of the extension2126server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" 2127server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.74 seconds)2128server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" 2129server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 3.12 seconds)2130server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" 2131server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 1.06 seconds)2132(finished: subtest: Check the install of the last version of the extension, in 4.93 seconds)2133(finished: run the VM test script, in 222.53 seconds)2134test script finished in 223.52s2135cleanup2136kill QemuMachine (pid 13)2137server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/76jq0mngg7m8zv5yjz1qgg0xspzi8x2w-python3-3.13.15/bin/python3.13)2138(finished: cleanup, in 0.08 seconds)