Machine state will be reset. To keep it, pass --keep-machine-state
start all VLans
(finished: start all VLans, in 0.00 seconds)
Test will time out and terminate in 3600 seconds
run the VM test script
additionally exposed symbols:
    server,
    vlan1,
    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_ssh
start all VMs
server: starting vm
server: QEMU running (pid 13)
server # Disk image does not exist, creating the virtualisation disk image...
server # Formatting '/build/vm-state-server/tmp.3XbHdZmwLW', fmt=raw size=1073741824
server # mke2fs 1.47.4 (6-Mar-2025)
server # Discarding device blocks:      0/262144             done
server # Creating filesystem with 262144 4k blocks and 65536 inodes
server # Filesystem UUID: cee67440-90cc-43a0-befc-18cfcb0a8943
server # Superblock backups stored on blocks:
server # 	32768, 98304, 163840, 229376
server # 
server # Allocating group tables: 0/8   done
server # Writing inode tables: 0/8   done
server # Creating journal (8192 blocks): done
server # Writing superblocks and filesystem accounting information: 0/8   done
server # 
server # Virtualisation disk image created.
server # qemu-system-aarch64: Could not access KVM kernel module: No such file or directory
server # qemu-system-aarch64: failed to initialize kvm: No such file or directory
server # qemu-system-aarch64: falling back to tcg
(finished: start all VMs, in 0.22 seconds)
server: waiting for unit supabase-db-init.service
server: waiting for the VM to finish booting
server # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]
server # [    0.000000] Linux version 6.18.59 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Oct 26 15:09:28 UTC 2026
server # [    0.000000] KASLR enabled
server # [    0.000000] random: crng init done
server # [    0.000000] Machine model: linux,dummy-virt
server # [    0.000000] efi: UEFI not found.
server # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
server # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]
server # [    0.000000] NODE_DATA(0) allocated [mem 0x13f6031c0-0x13f60693f]
server # [    0.000000] Zone ranges:
server # [    0.000000]   DMA      [mem 0x0000000040000000-0x00000000ffffffff]
server # [    0.000000]   DMA32    empty
server # [    0.000000]   Normal   [mem 0x0000000100000000-0x000000013fffffff]
server # [    0.000000]   Device   empty
server # [    0.000000] Movable zone start for each node
server # [    0.000000] Early memory node ranges
server # [    0.000000]   node   0: [mem 0x0000000040000000-0x000000013fffffff]
server # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]
server # [    0.000000] cma: Reserved 32 MiB at 0x00000000fe000000
server # [    0.000000] psci: probing for conduit method from DT.
server # [    0.000000] psci: PSCIv1.1 detected in firmware.
server # [    0.000000] psci: Using standard PSCI v0.2 function IDs
server # [    0.000000] psci: Trusted OS migration not required
server # [    0.000000] psci: SMC Calling Convention v1.0
server # [    0.000000] percpu: Embedded 76 pages/cpu s186968 r8192 d116136 u311296
server # [    0.000000] Detected PIPT I-cache on CPU0
server # [    0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)
server # [    0.000000] CPU features: detected: GICv3 CPU interface
server # [    0.000000] CPU features: detected: HCRX_EL2 register
server # [    0.000000] CPU features: detected: Stage-1 Permission Indirection Extension (S1PIE)
server # [    0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2)
server # [    0.000000] CPU features: detected: Spectre-v4
server # [    0.000000] alternatives: applying boot alternatives
server # [    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/2wcx9j5y8qaq1948nxc7r50visnfzf24-nixos-system-server-test/init regInfo=/nix/store/bpawy7wv3pq043ykspjqdvdnwis5yypl-closure-info/registration console=ttyAMA0,115200n8 console=tty0
server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/store/bpawy7wv3pq043ykspjqdvdnwis5yypl-closure-info/registration", will be passed to user space.
server # [    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
server # [    0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
server # [    0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
server # [    0.000000] software IO TLB: area num 2.
server # [    0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)
server # [    0.000000] Fallback order for Node 0: 0
server # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1048576
server # [    0.000000] Policy zone: Normal
server # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
server # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
server # [    0.000000] allocated 8388608 bytes of page_ext
server # [    0.000000] ftrace: allocating 74992 entries in 294 pages
server # [    0.000000] ftrace: allocated 294 pages with 4 groups
server # [    0.000000] rcu: Hierarchical RCU implementation.
server # [    0.000000] rcu: 	RCU event tracing is enabled.
server # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2.
server # [    0.000000] 	Trampoline variant of Tasks RCU enabled.
server # [    0.000000] 	Rude variant of Tasks RCU enabled.
server # [    0.000000] 	Tracing variant of Tasks RCU enabled.
server # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
server # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
server # [    0.000000] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
server # [    0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
server # [    0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.
server # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
server # [    0.000000] GICv3: 256 SPIs implemented
server # [    0.000000] GICv3: 0 Extended SPIs implemented
server # [    0.000000] Root IRQ handler: gic_handle_irq
server # [    0.000000] GICv3: GICv3 features: 16 PPIs
server # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
server # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
server # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b00000 (indirect, esz 8, psz 64K, shr 1)
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b10000 (flat, esz 8, psz 64K, shr 1)
server # [    0.000000] GICv3: using LPI property table @0x0000000100b20000
server # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b30000
server # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
server # [    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
server # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
server # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
server # [    0.000050] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
server # [    0.004505] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.017012] Console: colour dummy device 80x25
server # [    0.018428] printk: legacy console [tty0] enabled
server # [    0.024975] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.025440] pid_max: default: 32768 minimum: 301
server # [    0.028705] LSM: initializing lsm=capability,landlock,yama,bpf,ima
server # [    0.031611] landlock: Up and running.
server # [    0.031693] Yama: becoming mindful.
server # [    0.034934] LSM support for eBPF active
server # [    0.038711] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
server # [    0.038896] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
server # [    0.083379] rcu: Hierarchical SRCU implementation.
server # [    0.083515] rcu: 	Max phase no-delay instances is 1000.
server # [    0.085184] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
server # [    0.093759] fsl-mc MSI: its@8080000 domain created
server # [    0.095726] EFI services will not be available.
server # [    0.097644] smp: Bringing up secondary CPUs ...
server # [    0.103085] Detected PIPT I-cache on CPU1
server # [    0.104785] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000
server # [    0.106041] GICv3: CPU1: using allocated LPI pending table @0x0000000100b40000
server # [    0.107579] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]
server # [    0.110985] smp: Brought up 1 node, 2 CPUs
server # [    0.111165] SMP: Total of 2 processors activated.
server # [    0.111217] CPU: All CPU(s) started at EL1
server # [    0.111416] CPU features: detected: Branch Target Identification
server # [    0.111466] CPU features: detected: 32-bit EL0 Support
server # [    0.111496] CPU features: detected: 32-bit EL1 Support
server # [    0.111522] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.111555] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.111599] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.111652] CPU features: detected: Common not Private translations
server # [    0.111679] CPU features: detected: CRC32 instructions
server # [    0.111703] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.111732] CPU features: detected: Data cache clean to Point of Persistence
server # [    0.111759] CPU features: detected: Data independent timing control (DIT)
server # [    0.111785] CPU features: detected: E0PD
server # [    0.111806] CPU features: detected: Enhanced Counter Virtualization
server # [    0.111831] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
server # [    0.111858] CPU features: detected: Enhanced Privileged Access Never
server # [    0.111883] CPU features: detected: Enhanced Virtualization Traps
server # [    0.111908] CPU features: detected: Fine Grained Traps
server # [    0.111932] CPU features: detected: Guarded Control Stack (GCS)
server # [    0.111989] CPU features: detected: Generic authentication (IMP DEF algorithm)
server # [    0.112070] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.112129] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)
server # [    0.112166] CPU features: detected: LSE atomic instructions
server # [    0.112196] CPU features: detected: Memory Copy and Memory Set instructions
server # [    0.112229] CPU features: detected: Privileged Access Never
server # [    0.112279] CPU features: detected: PMUv3
server # [    0.112304] CPU features: detected: SCTLR2
server # [    0.112328] CPU features: detected: RAS Extension Support
server # [    0.112391] CPU features: detected: RASv1p1 Extension Support
server # [    0.112418] CPU features: detected: Random Number Generator
server # [    0.112448] CPU features: detected: Speculation barrier (SB)
server # [    0.112483] CPU features: detected: Stage-2 Force Write-Back
server # [    0.112519] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality
server # [    0.112559] CPU features: detected: TLB range maintenance instructions
server # [    0.112595] CPU features: detected: WFx with timeout
server # [    0.112693] CPU features: detected: Scalable Matrix Extension
server # [    0.112724] CPU features: detected: FA64
server # [    0.112750] CPU features: detected: SME2
server # [    0.112775] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.112807] CPU features: detected: Scalable Vector Extension
server # [    0.120671] alternatives: applying system-wide alternatives
server # [    0.136216] CPU features: detected: Hardware dirty bit management on CPU0-1
server # [    0.136930] SVE: maximum available vector length 256 bytes per vector
server # [    0.137014] SVE: default vector length 64 bytes per vector
server # [    0.138219] SME: minimum available vector length 16 bytes per vector
server # [    0.138271] SME: maximum available vector length 256 bytes per vector
server # [    0.138310] SME: default vector length 32 bytes per vector
server # [    0.157912] Memory: 3904132K/4194304K available (24384K kernel code, 7094K rwdata, 26604K rodata, 4736K init, 1103K bss, 241760K reserved, 32768K cma-reserved)
server # [    0.184753] devtmpfs: initialized
server # [    0.221713] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear)
server # [    0.222100] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear).
server # [    0.225442] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
server # [    0.225532] 0 pages in range for non-PLT usage
server # [    0.225586] 508240 pages in range for PLT usage
server # [    0.228956] pinctrl core: initialized pinctrl subsystem
server # [    0.242151] DMI not present or invalid.
server # [    0.264135] NET: Registered PF_NETLINK/PF_ROUTE protocol family
server # [    0.277376] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
server # [    0.278396] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.279614] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
server # [    0.279932] audit: initializing netlink subsys (disabled)
server # [    0.282533] audit: type=2000 audit(0.204:1): state=initialized audit_enabled=0 res=1
server # [    0.288972] thermal_sys: Registered thermal governor 'fair_share'
server # [    0.289039] thermal_sys: Registered thermal governor 'bang_bang'
server # [    0.289106] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.289137] thermal_sys: Registered thermal governor 'user_space'
server # [    0.289169] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.289911] cpuidle: using governor ladder
server # [    0.290334] cpuidle: using governor menu
server # [    0.292405] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
server # [    0.293470] ASID allocator initialised with 65536 entries
server # [    0.300959] Serial: AMBA PL011 UART driver
server # [    0.360648] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
server # [    0.362821] printk: console [ttyAMA0] enabled
server # [    0.403894] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.404136] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
server # [    0.404192] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
server # [    0.404232] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
server # [    0.404368] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
server # [    0.404414] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
server # [    0.404451] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
server # [    0.404486] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
server # [    0.426843] fbcon: Taking over console
server # [    0.427144] ACPI: Interpreter disabled.
server # [    0.435403] iommu: Default domain type: Translated
server # [    0.435492] iommu: DMA domain TLB invalidation policy: strict mode
server # [    0.442379] SCSI subsystem initialized
server # [    0.448114] usbcore: registered new interface driver usbfs
server # [    0.448428] usbcore: registered new interface driver hub
server # [    0.448592] usbcore: registered new device driver usb
server # [    0.453151] pps_core: LinuxPPS API ver. 1 registered
server # [    0.453228] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    0.453336] PTP clock support registered
server # [    0.453679] EDAC MC: Ver: 3.0.0
server # [    0.458507] scmi_core: SCMI protocol bus registered
server # [    0.462160] FPGA manager framework
server # [    0.472770] vgaarb: loaded
server # [    0.476654] clocksource: Switched to clocksource arch_sys_counter
server # [    0.518531] VFS: Disk quotas dquot_6.6.0
server # [    0.518742] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    0.523108] netfs: FS-Cache loaded
server # [    0.524360] pnp: PnP ACPI: disabled
server # [    0.552702] NET: Registered PF_INET protocol family
server # [    0.555274] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
server # [    0.665747] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
server # [    0.666085] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
server # [    0.666244] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
server # [    0.666687] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
server # [    0.667035] TCP: Hash tables configured (established 32768 bind 32768)
server # [    0.668317] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)
server # [    0.668691] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)
server # [    0.668940] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)
server # [    0.671929] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    0.672382] NET: Registered PF_XDP protocol family
server # [    0.672822] PCI: CLS 0 bytes, default 64
server # [    0.677388] kvm [1]: HYP mode not available
server # [    0.677710] Trying to unpack rootfs image as initramfs...
server # [    0.908682] Initialise system trusted keyrings
server # [    0.911578] workingset: timestamp_bits=42 max_order=20 bucket_order=0
server # [    0.922961] squashfs: version 4.0 (2009/01/31) Phillip Lougher
server # [    0.923685] 9p: Installing v9fs 9p2000 file system support
server # [    1.006805] Key type asymmetric registered
server # [    1.006968] Asymmetric key parser 'x509' registered
server # [    1.007362] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
server # [    1.010396] io scheduler mq-deadline registered
server # [    1.010517] io scheduler kyber registered
server # [    1.056181] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
server # [    1.065453] ledtrig-cpu: registered to indicate activity on CPUs
server # [    1.071116] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    1.071724] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    1.072435] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    1.072556] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    1.074125] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [    1.075168] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
server # [    1.079089] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
server # [    1.079448] pci_bus 0000:00: root bus resource [bus 00-ff]
server # [    1.079581] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
server # [    1.079646] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    1.079688] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
server # [    1.080873] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [    1.087248] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    1.087507] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    1.087581] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.087641] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.087733] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    1.088250] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    1.088344] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
server # [    1.088384] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.088425] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.089373] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    1.090100] pci 0000:00:03.0: BAR 0 [io  0x0000-0x003f]
server # [    1.090247] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.090923] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.093625] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    1.093739] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
server # [    1.093907] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.094225] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.097780] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    1.098057] pci 0000:00:05.0: BAR 0 [io  0x0000-0x001f]
server # [    1.098105] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.098147] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.098655] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
server # [    1.098748] pci 0000:00:06.0: BAR 0 [io  0x0000-0x007f]
server # [    1.098795] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.098844] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.099335] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    1.099432] pci 0000:00:07.0: BAR 0 [io  0x0000-0x001f]
server # [    1.099470] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.099511] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.099551] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    1.100015] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
server # [    1.100100] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.100141] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.100581] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
server # [    1.100676] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.100724] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.102893] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
server # [    1.103526] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]
server # [    1.105404] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
server # [    1.106365] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
server # [    1.106425] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.106470] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.107021] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    1.107134] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
server # [    1.107181] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.107234] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.111712] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    1.111946] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    1.112085] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    1.112506] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    1.113500] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    1.113572] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    1.113635] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    1.113690] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    1.113744] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    1.113899] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
server # [    1.113965] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    1.114023] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    1.114308] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    1.114754] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    1.115460] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
server # [    1.115525] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
server # [    1.115590] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
server # [    1.115643] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    1.115688] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    1.115734] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned
server # [    1.115783] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
server # [    1.115825] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
server # [    1.115871] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned
server # [    1.115922] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    1.115975] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    1.116405] pci 0000:00:06.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    1.119233] pci 0000:00:03.0: BAR 0 [io  0x1080-0x10bf]: assigned
server # [    1.119309] pci 0000:00:0b.0: BAR 0 [io  0x10c0-0x10ff]: assigned
server # [    1.119356] pci 0000:00:01.0: BAR 0 [io  0x1100-0x111f]: assigned
server # [    1.119962] pci 0000:00:02.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    1.120041] pci 0000:00:04.0: BAR 0 [io  0x1140-0x115f]: assigned
server # [    1.120089] pci 0000:00:05.0: BAR 0 [io  0x1160-0x117f]: assigned
server # [    1.120143] pci 0000:00:07.0: BAR 0 [io  0x1180-0x119f]: assigned
server # [    1.120193] pci 0000:00:0c.0: BAR 0 [io  0x11a0-0x11bf]: assigned
server # [    1.121392] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
server # [    1.121480] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
server # [    1.121520] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
server # [    1.125423] pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    1.225745] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
server # [    1.230727] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [    1.233744] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [    1.236315] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
server # [    1.243267] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)
server # [    1.247456] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)
server # [    1.253940] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)
server # [    1.258587] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
server # [    1.263896] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [    1.268331] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
server # [    1.271160] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [    1.292652] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
server # [    1.305251] msm_serial: driver initialized
server # [    1.307425] SuperH (H)SCI(F) driver initialized
server # [    1.307905] STM32 USART driver initialized
server # [    1.387710] loop: module loaded
server # [    1.388349] virtio_blk virtio5: 2/0/0 default/read/poll queues
server # [    1.393425] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [    1.407742] megasas: 07.734.00.00-rc1
server # [    1.414398] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
server # [    1.417316] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    1.417735] Intel/Sharp Extended Query Table at 0x0031
server # [    1.419765] Using buffer write method
server # [    1.420410] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
server # [    1.421516] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    1.422459] Intel/Sharp Extended Query Table at 0x0031
server # [    1.424685] Using buffer write method
server # [    1.425642] Concatenating MTD devices:
server # [    1.425769] (0): "0.flash"
server # [    1.425966] (1): "0.flash"
server # [    1.426122] into device "0.flash"
server # [    1.778158] Freeing initrd memory: 25348K
server # [    1.900465] tun: Universal TUN/TAP device driver, 1.6
server # [    1.915511] thunder_xcv, ver 1.0
server # [    1.915735] thunder_bgx, ver 1.0
server # [    1.915865] nicpf, ver 1.0
server # [    1.920136] e1000: Intel(R) PRO/1000 Network Driver
server # [    1.920207] e1000: Copyright (c) 1999-2006 Intel Corporation.
server # [    1.920363] e1000e: Intel(R) PRO/1000 Network Driver
server # [    1.920400] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
server # [    1.920558] igb: Intel(R) Gigabit Ethernet Network Driver
server # [    1.920597] igb: Copyright (c) 2007-2014 Intel Corporation.
server # [    1.920732] igbvf: Intel(R) Gigabit Virtual Function Network Driver
server # [    1.920770] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
server # [    1.923047] sky2: driver version 1.30
server # [    1.932637] ehci-pci 0000:00:0a.0: EHCI Host Controller
server # [    1.934212] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1
server # [    1.935200] usbcore: registered new interface driver usb-storage
server # [    1.935756] usbcore: registered new interface driver usbserial_generic
server # [    1.935956] usbserial: USB Serial support registered for generic
server # [    1.936253] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000
server # [    1.940665] hv_vmbus: registering driver hyperv_keyboard
server # [    1.945461] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00
server # [    1.947651] rtc-pl031 9010000.pl031: registered as rtc0
server # [    1.948174] rtc-pl031 9010000.pl031: setting system clock to 2026-10-31T19:36:54 UTC (1793475414)
server # [    1.950096] i2c_dev: i2c /dev entries driver
server # [    1.961311] hub 1-0:1.0: USB hub found
server # [    1.961968] hub 1-0:1.0: 6 ports detected
server # [    1.971009] sdhci: Secure Digital Host Controller Interface driver
server # [    1.971081] sdhci: Copyright(c) Pierre Ossman
server # [    1.972625] Synopsys Designware Multimedia Card Interface Driver
server # [    1.975102] sdhci-pltfm: SDHCI platform and OF driver helper
server # [    1.985057] hid: raw HID events driver (C) Jiri Kosina
server # [    1.986808] usbcore: registered new interface driver usbhid
server # [    1.986871] usbhid: USB HID core driver
server # [    1.998038] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available
server # [    2.009004] drop_monitor: Initializing network drop monitor service
server # [    2.010581] NET: Registered PF_INET6 protocol family
server # [    2.019664] Segment Routing with IPv6
server # [    2.019906] In-situ OAM (IOAM) with IPv6
server # [    2.020436] NET: Registered PF_PACKET protocol family
server # [    2.021441] 9pnet: Installing 9P2000 support
server # [    2.028064] Key type dns_resolver registered
server # [    2.072775] registered taskstats version 1
server # [    2.076380] Loading compiled-in X.509 certificates
server # [    2.144747] Demotion targets for Node 0: null
server # [    2.145954] Key type .fscrypt registered
server # [    2.146009] Key type fscrypt-provisioning registered
server # [    2.148450] ima: No TPM chip found, activating TPM-bypass!
server # [    2.148549] ima: Allocated hash algorithm: sha1
server # [    2.150270] ima: No architecture policies found
server # [    2.159780] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [    2.219840] usb 1-1: new high-speed USB device number 2 using ehci-pci
server # [    2.238027] clk: Disabling unused clocks
server # [    2.238295] PM: genpd: Disabling unused power domains
server # [    2.444589] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1
server # [    2.514428] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0
server # [    2.574848] Freeing unused kernel memory: 4736K
server # [    2.576037] Run /init as init process
server # [    2.640875] usb 1-2: new high-speed USB device number 3 using ehci-pci
server # [    2.727724] systemd[1]: Successfully made /usr/ read-only.
server # [    2.829400] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2
server # [    2.830271] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0
server # [    3.079747] systemd[1]: systemd 260.5 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
server # [    3.079996] systemd[1]: Detected virtualization qemu.
server # [    3.080403] systemd[1]: Detected architecture arm64.
server # [    3.080475] systemd[1]: Running in initrd.
server # [    3.090585] systemd[1]: Initializing machine ID from random generator.
server # [    3.093377] systemd[1]: Hostname set to <server>.
server # [    3.748660] systemd[1]: Queued start job for default target Initrd Default Target.
server # [    3.798197] systemd[1]: Created slice Slice /system/modprobe.
server # [    3.801461] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    3.802194] systemd[1]: Expecting device /dev/disk/by-label/nixos...
server # [    3.802550] systemd[1]: Reached target Path Units.
server # [    3.802702] systemd[1]: Reached target Slice Units.
server # [    3.802822] systemd[1]: Reached target Swaps.
server # [    3.802955] systemd[1]: Reached target Timer Units.
server # [    3.805685] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [    3.808135] systemd[1]: Listening on Journal Socket (/dev/log).
server # [    3.812038] systemd[1]: Listening on Journal Sockets.
server # [    3.813309] systemd[1]: Listening on udev Control Socket.
server # [    3.814021] systemd[1]: Listening on udev Kernel Socket.
server # [    3.814233] systemd[1]: Reached target Socket Units.
server # [    3.834479] systemd[1]: Starting Create List of Static Device Nodes...
server # [    3.848879] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [    3.849838] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [    3.882688] systemd[1]: Mounting Kernel Configuration File System...
server # [    3.962141] systemd[1]: Starting Journal Service...
server # [    3.983224] systemd[1]: Starting Load Kernel Modules...
server # [    3.984632] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
server # [    4.017241] systemd[1]: Starting Coldplug All udev Devices...
server # [    4.090406] systemd[1]: Finished Create List of Static Device Nodes.
server # [    4.110642] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [    4.113552] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [    4.125023] systemd[1]: Mounted Kernel Configuration File System.
server # [    4.162603] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    4.267947] systemd-journald[81]: Collecting audit messages is disabled.
server # [    4.404555] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
server # [    4.430861] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
server # [    4.484626] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0
server # [    4.487349] [drm] features: -virgl +edid -resource_blob -host_visible
server # [    4.487493] [drm] features: -context_init
server # [    4.566303] [drm] number of scanouts: 1
server # [    4.566627] [drm] number of cap sets: 0
server # [    4.586618] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    4.607987] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic
server # [    4.608180] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0
server # [    4.690491] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    4.741055] Console: switching to colour frame buffer device 160x50
server # [    4.764010] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device
server # [    4.827584] systemd[1]: Finished Load Kernel Modules.
server # [    4.885924] systemd[1]: Starting Apply Kernel Variables...
server # [    4.979177] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [    4.983685] systemd[1]: Reached target Preparation for Local File Systems.
server # [    4.991746] systemd[1]: Reached target Local File Systems.
server # [    5.055590] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    5.199521] systemd[1]: Finished Apply Kernel Variables.
server # [    5.424206] systemd[1]: Started Journal Service.
server # [    5.315922] systemd-modules-load[82]: Using 2 probe threads
server # [    5.339491] systemd-modules-load[82]: Module 'virtio_balloon' is built in
server # [    5.372473] systemd-modules-load[82]: Module 'virtio_console' is built in
server # [    5.380499] systemd-modules-load[82]: Inserted module 'dm_mod'
server # [    5.388089] systemd-modules-load[82]: Module 'virtio_rng' is built in
server # [    5.395852] systemd-modules-load[82]: Inserted module 'virtio_gpu'
server # [    5.417933] systemd-udevd[89]: Using default interface naming scheme 'v260'.
server # [    5.434638] systemd[1]: Starting Create System Files and Directories...
server # [    5.619884] systemd[1]: Finished Create System Files and Directories.
server # [    5.784440] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    6.253951] systemd[1]: Starting Virtual Console Setup...
server # [    6.551887] systemd-vconsole-setup[111]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    6.583987] systemd[1]: Finished Virtual Console Setup.
server # [   10.237336] systemd[1]: Finished Coldplug All udev Devices.
server # [   10.246826] systemd[1]: Reached target System Initialization.
server # [   10.254882] systemd[1]: Reached target Basic System.
server # [   12.540083] (udev-worker)[118]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [   12.554393] (udev-worker)[118]: Network interface NamePolicy= disabled on kernel command line.
server # [   12.609774] (udev-worker)[119]: Network interface NamePolicy= disabled on kernel command line.
server # [   12.967135] systemd[1]: Found device /dev/disk/by-label/nixos.
server # [   13.024166] systemd[1]: Reached target Initrd Root Device.
server # [   13.041551] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [   13.315274] systemd-fsck[139]: nixos: clean, 12/65536 files, 13019/262144 blocks
server # [   13.361468] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
server # [   13.407039] systemd[1]: Mounting /sysroot...
server # [   13.773035] EXT4-fs (vda): mounted filesystem cee67440-90cc-43a0-befc-18cfcb0a8943 r/w with ordered data mode. Quota mode: none.
server # [   13.713160] systemd[1]: Mounted /sysroot.
server # [   13.728165] systemd[1]: Reached target Initrd Root File System.
server # [   13.754573] systemd[1]: Starting Mountpoints Configured in the Real Root...
server # [   13.907648] systemd-sysroot-fstab-check[147]: /sysroot should be mounted in the initrd, will request daemon-reload.
server # [   13.938646] systemd[1]: Reload requested from client PID 147 ('systemd-sysroot') (unit initrd-parse-etc.service)...
server # [   13.946614] systemd[1]: Reloading...
server # [   15.103061] systemd[1]: Reloading finished in 1150 ms.
server # [   15.155457] systemd-sysroot-fstab-check[147]: Requesting initrd-fs.target/start/replace...
server # [   15.167998] systemd-sysroot-fstab-check[147]: Requesting swap.target/start/replace...
server # [   15.199690] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [   15.225565] systemd[1]: Mounting /sysroot/run...
server # [   15.258311] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [   15.278101] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
server # [   15.284197] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [   15.287401] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [   15.339579] systemd[1]: Mounted /sysroot/nix/.rw-store.
server # [   15.383816] systemd[1]: Mounted /sysroot/run.
server # [   15.387804] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [   15.391410] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [   15.432005] systemd[1]: Mounting /sysroot/nix/.ro-store...
server # [   15.455312] systemd[1]: Mounting /sysroot/tmp/shared...
server # [   15.493445] systemd[1]: Mounting /sysroot/tmp/xchg...
server # [   15.520800] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [   15.649789] systemd[1]: Mounted /sysroot/nix/.ro-store.
server # [   15.725969] systemd[1]: Mounted /sysroot/tmp/shared.
server # [   15.728975] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [   15.732543] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [   15.734763] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   16.227588] systemd[1]: Mounting /sysroot/nix/store...
server # [   16.601936] systemd[1]: Mounted /sysroot/nix/store.
server # [   16.618015] systemd[1]: Reached target Initrd File Systems.
server # [   16.641944] systemd[1]: Starting Find NixOS closure...
server # [   16.672841] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
server # [   16.962931] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
server # [   16.995782] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
server # [   17.199404] systemd[1]: Finished Find NixOS closure.
server # [   17.225905] systemd[1]: Reached target Initrd Default Target.
server # [   17.247635] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [   17.471779] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [   17.474658] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [   17.491699] systemd[1]: Stopped target Initrd Default Target.
server # [   17.497705] systemd[1]: Stopped target Basic System.
server # [   17.503651] systemd[1]: Stopped target Initrd Root Device.
server # [   17.510906] systemd[1]: Stopped target Path Units.
server # [   17.517863] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
server # [   17.521565] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
server # [   17.525554] systemd[1]: Stopped target Slice Units.
server # [   17.527639] systemd[1]: Stopped target Socket Units.
server # [   17.529880] systemd[1]: Stopped target System Initialization.
server # [   17.531577] systemd[1]: Stopped target Swaps.
server # [   17.533633] systemd[1]: Stopped target Timer Units.
server # [   17.535246] systemd[1]: dbus.socket: Deactivated successfully.
server # [   17.539740] systemd[1]: Closed D-Bus System Message Bus Socket.
server # [   17.543150] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
server # [   17.545697] systemd[1]: Stopped Find NixOS closure.
server # [   17.548286] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [   17.568998] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [   17.573944] systemd[1]: systemd-sysctl.service: Deactivated successfully.
server # [   17.574953] systemd[1]: Stopped Apply Kernel Variables.
server # [   17.577517] systemd[1]: systemd-modules-load.service: Deactivated successfully.
server # [   17.579133] systemd[1]: Stopped Load Kernel Modules.
server # [   17.588021] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
server # [   17.591639] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
server # [   17.595657] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
server # [   17.599693] systemd[1]: Stopped Create System Files and Directories.
server # [   17.602406] systemd[1]: Stopped target Local File Systems.
server # [   17.603751] systemd[1]: Stopped target Preparation for Local File Systems.
server # [   17.607454] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
server # [   17.610172] systemd[1]: Stopped Coldplug All udev Devices.
server # [   17.615343] systemd[1]: systemd-udev-trigger.service: Consumed 5.173s CPU time over 13.702s wall clock time, 9.5M memory peak.
server # [   17.618842] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   17.622928] systemd[1]: Stopped Virtual Console Setup.
server # [   17.733946] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [   17.737846] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   17.767465] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [   17.777047] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [   18.043055] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [   18.048634] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
server # [   18.051604] systemd[1]: systemd-udevd.service: Consumed 9.242s CPU time over 13.112s wall clock time, 23.2M memory peak.
server # [   18.061875] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
server # [   18.066477] systemd[1]: Closed udev Control Socket.
server # [   18.084933] systemd[1]: Starting Cleanup udev Database...
server # [   18.086614] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
server # [   18.088043] systemd[1]: Stopped Create Static Device Nodes in /dev.
server # [   18.093108] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [   18.095021] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
server # [   18.099318] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
server # [   18.102581] systemd[1]: Stopped Create List of Static Device Nodes.
server # [   18.259347] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
server # [   18.262851] systemd[1]: Finished Cleanup udev Database.
server # [   18.273817] systemd[1]: Reached target Switch Root.
server # [   18.289147] systemd[1]: Starting NixOS Activation...
server # [   20.107673] initrd-nixos-activation-start[219]: booting system configuration /nix/store/2wcx9j5y8qaq1948nxc7r50visnfzf24-nixos-system-server-test
server # [   20.765989] initrd-nixos-activation-start[219]: running activation script...
server # [   25.062304] initrd-nixos-activation-start[242]: setting up /etc...
server # [   27.507091] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
server # [   27.510693] systemd[1]: Finished NixOS Activation.
server # [   27.512810] systemd[1]: initrd-nixos-activation.service: Consumed 4.694s CPU time over 9.215s wall clock time, 22.6M memory peak.
server # [   27.525070] systemd[1]: Starting Switch Root...
server # [   27.656759] systemd[1]: Switching root.
server # [   27.953924] systemd-journald[81]: Received SIGTERM from PID 1 (systemd).
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [   30.178627] systemd[1]: systemd 260.5 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
server # [   30.179069] systemd[1]: Detected virtualization qemu.
server # [   30.179412] systemd[1]: Detected architecture arm64.
server # [   30.180085] systemd[1]: Detected first boot.
server # [   30.211452] systemd[1]: Initializing machine ID from random generator.
server # [   31.428904] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [   32.803400] systemd[1]: Applying preset policy.
server # [   37.207780] systemd[1]: Populated /etc with preset unit settings.
server # [   42.107001] systemd[1]: initrd-switch-root.service: Deactivated successfully.
server # [   42.115123] systemd[1]: Stopped initrd-switch-root.service.
server # [   42.139667] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
server # [   42.156120] systemd[1]: Created slice Slice /system/getty.
server # [   42.171376] systemd[1]: Created slice User and Session Slice.
server # [   42.178343] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [   42.183771] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
server # [   42.188867] systemd[1]: Expecting device /dev/hvc0...
server # [   42.191943] systemd[1]: Expecting device /dev/ttyAMA0...
server # [   42.196850] systemd[1]: Reached target Local Encrypted Volumes.
server # [   42.200360] systemd[1]: Stopped target initrd-fs.target.
server # [   42.204678] systemd[1]: Stopped target initrd-root-fs.target.
server # [   42.209303] systemd[1]: Stopped target initrd-switch-root.target.
server # [   42.212968] systemd[1]: Reached target Virtual Machines and Containers.
server # [   42.216958] systemd[1]: Reached target Path Units.
server # [   42.219920] systemd[1]: Reached target Remote File Systems.
server # [   42.225741] systemd[1]: Reached target Slice Units.
server # [   42.228783] systemd[1]: Reached target Swaps.
server # [   42.261955] systemd[1]: Listening on Process Core Dump Socket.
server # [   42.290442] systemd[1]: Listening on Credential Encryption/Decryption.
server # [   42.335903] systemd[1]: Starting Journal Log Access Socket...
server # [   42.351615] systemd[1]: Listening on Journal Audit Socket.
server # [   42.366205] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
server # [   42.373622] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [   42.382192] systemd[1]: Listening on udev Control Socket.
server # [   42.418392] systemd[1]: Mounting Huge Pages File System...
server # [   42.473202] systemd[1]: Mounting POSIX Message Queue File System...
server # [   42.542211] systemd[1]: Mounting Kernel Debug File System...
server # [   42.671422] systemd[1]: Mounting Kernel Trace File System...
server # [   42.739700] systemd[1]: Starting Create List of Static Device Nodes...
server # [   42.802950] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [   42.847232] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   43.038604] systemd[1]: Mounting Kernel Configuration File System...
server # [   43.099875] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
server # [   43.121992] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [   43.363864] systemd[1]: Starting Load Kernel Module fuse...
server # [   43.373447] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [   43.504495] systemd[1]: Starting Journal Service...
server # [   43.671565] systemd[1]: Starting Load Kernel Modules...
server # [   43.881272] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
server # [   44.103453] systemd[1]: Starting Remount Root and Kernel File Systems...
server # [   44.138607] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
server # [   44.408282] systemd[1]: Starting Coldplug All udev Devices...
server # [   44.647394] fuse: init (API version 7.45)
server # [   44.712211] systemd-journald[313]: Collecting audit messages is enabled.
server # [   44.803781] systemd[1]: Listening on Journal Log Access Socket.
server # [   44.854911] systemd[1]: Mounted Huge Pages File System.
server # [   44.874114] systemd[1]: Mounted POSIX Message Queue File System.
server # [   44.887406] systemd[1]: Mounted Kernel Debug File System.
server # [   44.922185] systemd[1]: Mounted Kernel Trace File System.
server # [   44.986817] systemd[1]: Finished Create List of Static Device Nodes.
server # [   45.051363] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [   44.910085] systemd[1]: Queued start job for default target Multi-User System.
server # [   44.939485] systemd[1]: systemd-journald.service: Deactivated successfully.
server # [   45.066815] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [   44.945763] systemd[1]: systemd-journald.service: Consumed 1.274s CPU time over 38.065s wall clock time, 9.9M memory peak.
server # [   45.076085] systemd[1]: Started Journal Service.
server # [   44.959126] systemd-modules-load[314]: Using 2 probe threads
server # [   44.967407] systemd-modules-load[314]: Module 'atkbd' is built in
server # [   44.976378] systemd-modules-load[314]: Module 'loop' is built in
server # [   45.065789] systemd[1]: Mounted Kernel Configuration File System.
server # [   45.080982] systemd[1]: modprobe@fuse.service: Deactivated successfully.
server # [   45.086761] systemd[1]: Finished Load Kernel Module fuse.
server # [   45.102198] systemd[1]: Finished Load Kernel Modules.
server # [   45.349293] EXT4-fs (vda): re-mounted cee67440-90cc-43a0-befc-18cfcb0a8943.
server # [   45.316032] systemd[1]: Finished Remount Root and Kernel File Systems.
server # [   45.521293] systemd[1]: Mounting FUSE Control File System...
server # [   45.609051] systemd[1]: Starting Firewall...
server # [   45.727616] systemd[1]: Starting Flush Journal to Persistent Storage...
server # [   45.736070] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
server # [   45.794606] systemd-oomd[316]: No swap; memory pressure usage will be degraded
server # [   45.904764] systemd[1]: Starting Load/Save OS Random Seed...
server # [   46.085244] systemd[1]: Starting Apply Kernel Variables...
server # [   46.321481] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [   46.332053] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
server # [   46.457276] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [   46.632551] systemd-journald[313]: Received client request to flush runtime journal.
server # [   47.445561] systemd[1]: Mounted FUSE Control File System.
server # [   47.486952] systemd[1]: Finished Load/Save OS Random Seed.
server # [   47.512369] systemd[1]: Reached target First Boot Complete.
server # [   47.544064] systemd[1]: Finished Flush Journal to Persistent Storage.
server # [   48.027349] systemd[1]: Finished Apply Kernel Variables.
server # [   48.511968] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [   48.605700] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [   49.514341] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [   49.529184] systemd[1]: Reached target Preparation for Local File Systems.
server # [   49.584039] systemd[1]: Mounting /run/wrappers...
server # [   49.669021] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [   50.236977] systemd[1]: Mounted /run/wrappers.
server # [   50.288331] systemd[1]: Reached target Local File Systems.
server # [   50.361945] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [   50.439732] systemd[1]: Starting register-nix-paths.service...
server # [   50.545088] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [   50.550921] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [   50.742415] systemd[1]: Starting Save Transient machine-id to Disk...
server # [   51.001911] systemd[1]: Starting Create System Files and Directories...
server # [   52.318765] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [   52.373852] systemd[1]: Finished Save Transient machine-id to Disk.
server # [   54.378705] systemd[1]: Finished Create System Files and Directories.
server # [   54.610606] systemd[1]: Starting Rebuild Journal Catalog...
server # [   54.863456] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [   56.385768] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [   57.983932] systemd[1]: Finished Rebuild Journal Catalog.
server # [   58.142268] systemd[1]: Starting Update is Completed...
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [   59.087982] systemd[1]: Finished Update is Completed.
server # [   63.411385] systemd-udevd[363]: Using default interface naming scheme 'v260'.
server # [   64.029957] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [   64.065005] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [   64.085408] systemd[1]: suid-sgid-wrappers.service: Consumed 3.290s CPU time over 13.509s wall clock time, 5.3M memory peak.
server # [   65.624021] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [   67.490706] systemd[1]: Finished Firewall.
server # [   67.941048] systemd[1]: Finished register-nix-paths.service.
server # [   70.634274] systemd[1]: Finished Coldplug All udev Devices.
server # [   70.641086] systemd[1]: Reached target System Initialization.
server # [   70.653251] systemd[1]: Started Discard unused filesystem blocks once a week.
server # [   70.657689] systemd[1]: Started Daily Cleanup of Temporary Directories.
server # [   70.662076] systemd[1]: Reached target Timer Units.
server # [   70.669965] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [   70.673930] systemd[1]: Listening on Nix Daemon Socket.
server # [   70.683193] systemd[1]: Listening on Hostname Service Socket.
server # [   70.691123] systemd[1]: Reached target Socket Units.
server # [   70.698479] systemd[1]: Reached target Basic System.
server # [   70.711063] systemd[1]: Starting Import lastlog data into lastlog2 database...
server # [   70.791994] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   70.892527] systemd[1]: Starting Post-Boot Actions...
server # [   71.133947] systemd[1]: Started Reset console on configuration changes.
server # [   71.351261] systemd[1]: Starting resolvconf update...
server # [   72.002884] systemd[1]: Finished Post-Boot Actions.
server # [   72.005838] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   72.060145] nsncd[570]: Oct 31 19:38:04.668 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   72.169756] systemd[1]: Reached target Host and Network Name Lookups.
server # [   72.193876] systemd[1]: Reached target User and Group Name Lookups.
server # [   72.383229] systemd[1]: Starting D-Bus System Message Bus...
server # [   72.685652] systemd[1]: Starting User Login Management...
server # [   72.836089] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # [   74.170221] dbus-broker-launch[588]: Looking up NSS user entry for 'systemd-timesync'...
server # [   74.537948] dbus-broker-launch[588]: NSS returned no entry for 'systemd-timesync'
server # [   74.553265] dbus-broker-launch[588]: Invalid user-name in /nix/store/vwdpn7pp7wk0r49xcqdysw2qqzsvv94q-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [   74.703858] systemd-logind[590]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
server # [   74.731373] systemd-logind[590]: New seat seat0.
server # [   74.809826] systemd[1]: Started User Login Management.
server # [   74.866315] systemd[1]: Starting linger-users.service...
server # [   74.966109] systemd[1]: Started D-Bus System Message Bus.
server # [   75.717123] systemd[1]: linger-users.service: Deactivated successfully.
server # [   75.772974] dbus-broker-launch[588]: Ready
server # [   75.781983] systemd[1]: Finished linger-users.service.
server # [   76.047018] systemd[1]: Stopped target Host and Network Name Lookups.
server # [   76.073005] systemd[1]: Stopping Host and Network Name Lookups...
server # [   76.081990] systemd[1]: Stopped target User and Group Name Lookups.
server # [   76.092751] systemd[1]: Stopping User and Group Name Lookups...
server # [   76.108226] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
server # [   76.134858] systemd[1]: nscd.service: Deactivated successfully.
server # [   76.159318] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
server # [   76.392259] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   77.206319] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   77.218892] nsncd[651]: Oct 31 19:38:09.862 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   77.239200] systemd[1]: Reached target Host and Network Name Lookups.
server # [   77.259739] systemd[1]: Reached target User and Group Name Lookups.
server # [   77.611695] systemd[1]: Finished resolvconf update.
server # [   77.668094] systemd[1]: Reached target Preparation for Network.
server # [   77.754822] systemd[1]: Starting DHCP Client...
server # [   77.821054] systemd[1]: Starting Extra networking commands....
server # [   80.545082] dhcpcd[695]: dhcpcd-10.3.1 starting
server # [   80.785354] dhcpcd[748]: dev: loaded udev
server # [   80.927236] dhcpcd[748]: no valid interfaces found
server # [   80.935414] dhcpcd[748]: no valid interfaces found
server # [   80.939157] dhcpcd[748]: libudev: received NULL device
server # [   80.942787] dhcpcd[748]: libudev: received NULL device
server # [   81.351447] systemd[1]: Finished Extra networking commands..
server # [   81.363880] systemd[1]: Reached target Network.
server # [   81.393578] systemd[1]: Starting PostgreSQL Database Server...
server # [   81.438353] systemd[1]: Starting Permit User Sessions...
server # [   81.971512] systemd[1]: Finished Permit User Sessions.
server # [   82.028849] systemd[1]: Started Getty on tty1.
server # [   82.044328] systemd[1]: Reached target Login Prompts.
server # [   82.842949] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[771]: Initializing database at /var/lib/postgresql/data
server # [   84.385795] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: The files belonging to this database system will be owned by user "postgres".
server # [   84.394581] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: This user must also own the server process.
server # [   84.467904] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: The database cluster will be initialized with locale "en_US.UTF-8".
server # [   84.472792] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: The default database encoding has accordingly been set to "UTF8".
server # [   84.482087] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: The default text search configuration will be set to "english".
server # [   84.486517] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: Data page checksums are enabled.
server # [   84.497171] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: fixing permissions on existing directory /var/lib/postgresql/data ... ok
server # [   84.502654] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: creating subdirectories ... ok
server # [   84.511787] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: selecting dynamic shared memory implementation ... posix
server # [   85.774984] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: selecting default max_connections ... 100
server # [   86.393139] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: selecting default shared_buffers ... 128MB
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [   97.180187] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: selecting default time zone ... UTC
server # [   97.245703] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: creating configuration files ... ok
server # [  101.226951] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: running bootstrap script ... ok
server # [  110.979385] dhcpcd[748]: timed out
server # [  110.991710] dhcpcd[748]: timed out
server # [  111.057853] systemd[1]: Started DHCP Client.
server # [  111.075010] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: performing post-bootstrap initialization ... ok
server # [  114.178619] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: syncing data to disk ... ok
server # [  114.191127] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: initdb: warning: enabling "trust" authentication for local connections
server # [  114.195431] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: initdb: hint: You can change this by editing pg_hba.conf or using the option -A, or --auth-local and --auth-host, the next time you run initdb.
server # [  114.204312] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]: Success. You can now start the database server using:
server # [  114.209256] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[787]:     /nix/store/as2nds8lpb4qfzhl3yshr0z6dkjwy99z-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start
server # [  115.614248] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[771]: Validating PostgreSQL configuration...
server # [  116.250635] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[1019]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault
server # [  117.260507] postgres[1030]:  2026-10-31 19:38:49.924 UTC [1030] LOG:  pgaudit extension initialized
server # [  117.872079] postgres[1030]:  2026-10-31 19:38:50.547 UTC [1030] LOG:  pgsodium primary server secret key loaded
server # [  118.410164] postgres[1030]:  2026-10-31 19:38:51.078 UTC [1030] LOG:  vault primary server secret key loaded
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  118.996667] postgres[1030]:  2026-10-31 19:38:51.668 UTC [1030] LOG:  starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.3.0, 64-bit
server # [  119.017045] postgres[1030]:  2026-10-31 19:38:51.690 UTC [1030] LOG:  listening on IPv4 address "0.0.0.0", port 5432
server # [  119.022022] postgres[1030]:  2026-10-31 19:38:51.691 UTC [1030] LOG:  listening on IPv6 address "::", port 5432
server # [  119.043584] postgres[1030]:  2026-10-31 19:38:51.719 UTC [1030] LOG:  listening on Unix socket "/run/postgresql/.s.PGSQL.5432"
server # [  119.167425] postgres[1058]:  2026-10-31 19:38:51.832 UTC [1058] LOG:  database system was shut down at 2026-10-31 19:38:43 UTC
server # [  119.448869] postgres[1061]:  2026-10-31 19:38:52.098 UTC [1061] LOG:  TimescaleDB background worker launcher connected to shared catalogs
server # [  119.489653] postgres[1030]:  2026-10-31 19:38:52.100 UTC [1030] LOG:  database system is ready to accept connections
server # [  119.523103] postgres[1062]:  2026-10-31 19:38:52.119 UTC [1062] FATAL:  role "postgres" does not exist
server # [  119.543368] systemd[1]: Started PostgreSQL Database Server.
server # [  119.555932] postgres[1030]:  2026-10-31 19:38:52.226 UTC [1030] LOG:  background worker "pg_net 0.20.4 worker" (PID 1062) exited with exit code 1
server # [  119.629571] systemd[1]: Starting Supabase Database Initialization...
server # [  119.669202] postgres[1063]:  2026-10-31 19:38:52.334 UTC [1063] LOG:  pg_cron scheduler started
server # [  120.027757] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Waiting for PostgreSQL to be ready...
server # [  120.606077] postgres[1069]: ::1 2026-10-31 19:38:53.253 UTC [1069] root@root FATAL:  role "root" does not exist
server # [  120.616117] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: PostgreSQL is ready
server # [  120.638058] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Creating postgres role...
server # [  120.685627] postgres[1070]:  2026-10-31 19:38:53.303 UTC [1070] FATAL:  role "postgres" does not exist
server # [  120.710502] postgres[1030]:  2026-10-31 19:38:53.381 UTC [1030] LOG:  background worker "pg_net 0.20.4 worker" (PID 1070) exited with exit code 1
server # [  121.085275] postgres[1072]: ::1 2026-10-31 19:38:53.739 UTC [1072] supabase_admin@postgres LOG:  statement: CREATE ROLE postgres SUPERUSER LOGIN;
server # [  121.110210] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1071]: CREATE ROLE
server # [  121.505974] postgres[1074]: ::1 2026-10-31 19:38:54.145 UTC [1074] supabase_admin@postgres LOG:  statement: ALTER DATABASE postgres OWNER TO postgres;
server # [  121.544486] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1073]: ALTER DATABASE
server # [  121.629877] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql
server # [  122.079236] postgres[1086]: ::1 2026-10-31 19:38:54.746 UTC [1086] postgres@postgres LOG:  statement: create publication supabase_realtime;
server # [  122.112119] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: CREATE PUBLICATION
server # [  122.121834] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: ALTER ROLE
server # [  122.123242] postgres[1086]: ::1 2026-10-31 19:38:54.786 UTC [1086] postgres@postgres LOG:  statement: alter user  supabase_admin with superuser createdb createrole replication bypassrls;
server # [  122.130701] postgres[1086]: ::1 2026-10-31 19:38:54.798 UTC [1086] postgres@postgres LOG:  statement: create user supabase_replication_admin with login replication;
server # [  122.138324] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: CREATE ROLE
server # [  122.151950] postgres[1086]: ::1 2026-10-31 19:38:54.817 UTC [1086] postgres@postgres LOG:  statement: create user supabase_etl_admin with login replication bypassrls;
server # [  122.182584] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: CREATE ROLE
server # [  122.193120] postgres[1086]: ::1 2026-10-31 19:38:54.868 UTC [1086] postgres@postgres LOG:  statement: grant pg_read_all_data to supabase_etl_admin;
server # [  122.209998] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: GRANT ROLE
server # [  122.214823] postgres[1086]: ::1 2026-10-31 19:38:54.890 UTC [1086] postgres@postgres LOG:  statement: grant create on database postgres to supabase_etl_admin;
server # [  122.225355] postgres[1086]: ::1 2026-10-31 19:38:54.901 UTC [1086] postgres@postgres LOG:  statement: create role supabase_read_only_user with login bypassrls;
server # [  122.227796] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: GRANT
server # [  122.239897] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: CREATE ROLE
server # [  122.245885] postgres[1086]: ::1 2026-10-31 19:38:54.916 UTC [1086] postgres@postgres LOG:  statement: grant pg_read_all_data to supabase_read_only_user;
server # [  122.256872] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: GRANT ROLE
server # [  122.266306] postgres[1086]: ::1 2026-10-31 19:38:54.938 UTC [1086] postgres@postgres LOG:  statement: create schema if not exists extensions;
server # [  122.283449] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: CREATE SCHEMA
server # [  122.293184] postgres[1086]: ::1 2026-10-31 19:38:54.968 UTC [1086] postgres@postgres LOG:  statement: create extension if not exists "uuid-ossp"      with schema extensions;
server # [  124.987631] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: CREATE EXTENSION
server # [  125.003602] postgres[1086]: ::1 2026-10-31 19:38:57.659 UTC [1086] postgres@postgres LOG:  statement: create extension if not exists pgcrypto         with schema extensions;
server # [  126.161585] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: CREATE EXTENSION
server # [  126.174958] postgres[1086]: ::1 2026-10-31 19:38:58.818 UTC [1086] postgres@postgres LOG:  statement: create role anon                nologin noinherit;
server # [  126.185588] postgres[1086]: ::1 2026-10-31 19:38:58.827 UTC [1086] postgres@postgres LOG:  statement: create role authenticated       nologin noinherit;
server # [  126.190486] postgres[1086]: ::1 2026-10-31 19:38:58.837 UTC [1086] postgres@postgres LOG:  statement: create role service_role        nologin noinherit bypassrls;
server # [  126.197010] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: CREATE ROLE
server # [  126.199785] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: CREATE ROLE
server # [  126.201756] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: CREATE ROLE
server # [  126.202894] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: CREATE ROLE
server # [  126.205156] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: GRANT ROLE
server # [  126.207415] postgres[1086]: ::1 2026-10-31 19:38:58.848 UTC [1086] postgres@postgres LOG:  statement: create user authenticator noinherit;
server # [  126.210273] postgres[1086]: ::1 2026-10-31 19:38:58.859 UTC [1086] postgres@postgres LOG:  statement: grant anon              to authenticator;
server # [  126.212236] postgres[1086]: ::1 2026-10-31 19:38:58.867 UTC [1086] postgres@postgres LOG:  statement: grant authenticated     to authenticator;
server # [  126.214560] postgres[1086]: ::1 2026-10-31 19:38:58.876 UTC [1086] postgres@postgres LOG:  statement: grant service_role      to authenticator;
server # [  126.216174] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: GRANT ROLE
server # [  126.217818] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: GRANT ROLE
server # [  126.219846] postgres[1086]: ::1 2026-10-31 19:38:58.888 UTC [1086] postgres@postgres LOG:  statement: grant supabase_admin    to authenticator;
server # [  126.224259] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: GRANT ROLE
server # [  126.226501] postgres[1086]: ::1 2026-10-31 19:38:58.900 UTC [1086] postgres@postgres LOG:  statement: grant usage                     on schema public to postgres, anon, authenticated, service_role;
server # [  126.234977] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: GRANT
server # [  126.243532] postgres[1086]: ::1 2026-10-31 19:38:58.913 UTC [1086] postgres@postgres LOG:  statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;
server # [  126.258774] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: ALTER DEFAULT PRIVILEGES
server # [  126.267115] postgres[1086]: ::1 2026-10-31 19:38:58.939 UTC [1086] postgres@postgres LOG:  statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;
server # [  126.275792] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: ALTER DEFAULT PRIVILEGES
server # [  126.282064] postgres[1086]: ::1 2026-10-31 19:38:58.955 UTC [1086] postgres@postgres LOG:  statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;
server # [  126.294074] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: ALTER DEFAULT PRIVILEGES
server # [  126.299289] postgres[1086]: ::1 2026-10-31 19:38:58.968 UTC [1086] postgres@postgres LOG:  statement: grant usage                     on schema extensions to postgres, anon, authenticated, service_role;
server # [  126.304798] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: GRANT
server # [  126.314422] postgres[1086]: ::1 2026-10-31 19:38:58.985 UTC [1086] postgres@postgres LOG:  statement: alter user supabase_admin SET search_path TO public, extensions;
server # [  126.320852] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: ALTER ROLE
server # [  126.322297] postgres[1086]: ::1 2026-10-31 19:38:58.996 UTC [1086] postgres@postgres LOG:  statement: alter default privileges for user supabase_admin in schema public grant all
server # [  126.326760] postgres[1086]: 	    on sequences to postgres, anon, authenticated, service_role;
server # [  126.334699] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: ALTER DEFAULT PRIVILEGES
server # [  126.336340] postgres[1086]: ::1 2026-10-31 19:38:59.011 UTC [1086] postgres@postgres LOG:  statement: alter default privileges for user supabase_admin in schema public grant all
server # [  126.339421] postgres[1086]: 	    on tables to postgres, anon, authenticated, service_role;
server # [  126.345207] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: ALTER DEFAULT PRIVILEGES
server # [  126.347688] postgres[1086]: ::1 2026-10-31 19:38:59.023 UTC [1086] postgres@postgres LOG:  statement: alter default privileges for user supabase_admin in schema public grant all
server # [  126.350431] postgres[1086]: 	    on functions to postgres, anon, authenticated, service_role;
server # [  126.355382] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: ALTER DEFAULT PRIVILEGES
server # [  126.361582] postgres[1086]: ::1 2026-10-31 19:38:59.035 UTC [1086] postgres@postgres LOG:  statement: alter role anon set statement_timeout = '3s';
server # [  126.367499] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: ALTER ROLE
server # [  126.373033] postgres[1086]: ::1 2026-10-31 19:38:59.045 UTC [1086] postgres@postgres LOG:  statement: alter role authenticated set statement_timeout = '8s';
server # [  126.378882] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: ALTER ROLE
server # [  126.440056] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql
server # [  126.709953] postgres[1119]: ::1 2026-10-31 19:38:59.375 UTC [1119] postgres@postgres LOG:  statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;
server # [  126.727935] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE SCHEMA
server # [  126.734005] postgres[1119]: ::1 2026-10-31 19:38:59.401 UTC [1119] postgres@postgres LOG:  statement: CREATE TABLE auth.users (
server # [  126.735991] postgres[1119]: 	    instance_id uuid NULL,
server # [  126.739376] postgres[1119]: 	    id uuid NOT NULL UNIQUE,
server # [  126.742115] postgres[1119]: 	    aud varchar(255) NULL,
server # [  126.743269] postgres[1119]: 	    "role" varchar(255) NULL,
server # [  126.745334] postgres[1119]: 	    email varchar(255) NULL UNIQUE,
server # [  126.747521] postgres[1119]: 	    encrypted_password varchar(255) NULL,
server # [  126.750817] postgres[1119]: 	    confirmed_at timestamptz NULL,
server # [  126.753978] postgres[1119]: 	    invited_at timestamptz NULL,
server # [  126.759306] postgres[1119]: 	    confirmation_token varchar(255) NULL,
server # [  126.761877] postgres[1119]: 	    confirmation_sent_at timestamptz NULL,
server # [  126.764945] postgres[1119]: 	    recovery_token varchar(255) NULL,
server # [  126.766699] postgres[1119]: 	    recovery_sent_at timestamptz NULL,
server # [  126.770189] postgres[1119]: 	    email_change_token varchar(255) NULL,
server # [  126.773852] postgres[1119]: 	    email_change varchar(255) NULL,
server # [  126.775037] postgres[1119]: 	    email_change_sent_at timestamptz NULL,
server # [  126.775918] postgres[1119]: 	    last_sign_in_at timestamptz NULL,
server # [  126.777913] postgres[1119]: 	    raw_app_meta_data jsonb NULL,
server # [  126.779769] postgres[1119]: 	    raw_user_meta_data jsonb NULL,
server # [  126.782041] postgres[1119]: 	    is_super_admin bool NULL,
server # [  126.782969] postgres[1119]: 	    created_at timestamptz NULL,
server # [  126.783832] postgres[1119]: 	    updated_at timestamptz NULL,
server # [  126.785948] postgres[1119]: 	    CONSTRAINT users_pkey PRIMARY KEY (id)
server # [  126.787292] postgres[1119]: 	);
server # [  126.887415] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE TABLE
server # [  126.894783] postgres[1119]: ::1 2026-10-31 19:38:59.565 UTC [1119] postgres@postgres LOG:  statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);
server # [  126.921093] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE INDEX
server # [  126.926042] postgres[1119]: ::1 2026-10-31 19:38:59.597 UTC [1119] postgres@postgres LOG:  statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);
server # [  126.946787] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE INDEX
server # [  126.953630] postgres[1119]: ::1 2026-10-31 19:38:59.623 UTC [1119] postgres@postgres LOG:  statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';
server # [  126.966304] postgres[1119]: ::1 2026-10-31 19:38:59.637 UTC [1119] postgres@postgres LOG:  statement: CREATE TABLE auth.refresh_tokens (
server # [  126.969573] postgres[1119]: 	    instance_id uuid NULL,
server # [  126.970914] postgres[1119]: 	    id bigserial NOT NULL,
server # [  126.971753] postgres[1119]: 	    "token" varchar(255) NULL,
server # [  126.974054] postgres[1119]: 	    user_id varchar(255) NULL,
server # [  126.976011] postgres[1119]: 	    revoked bool NULL,
server # [  126.978216] postgres[1119]: 	    created_at timestamptz NULL,
server # [  126.979643] postgres[1119]: 	    updated_at timestamptz NULL,
server # [  126.981949] postgres[1119]: 	    CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)
server # [  126.983962] postgres[1119]: 	);
server # [  126.986215] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: COMMENT
server # [  127.083188] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE TABLE
server # [  127.090006] postgres[1119]: ::1 2026-10-31 19:38:59.760 UTC [1119] postgres@postgres LOG:  statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);
server # [  127.112921] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE INDEX
server # [  127.129743] postgres[1119]: ::1 2026-10-31 19:38:59.792 UTC [1119] postgres@postgres LOG:  statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id);
server # [  127.161562] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE INDEX
server # [  127.163547] postgres[1119]: ::1 2026-10-31 19:38:59.839 UTC [1119] postgres@postgres LOG:  statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);
server # [  127.217728] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE INDEX
server # [  127.219895] postgres[1119]: ::1 2026-10-31 19:38:59.893 UTC [1119] postgres@postgres LOG:  statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.';
server # [  127.227996] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: COMMENT
server # [  127.230184] postgres[1119]: ::1 2026-10-31 19:38:59.905 UTC [1119] postgres@postgres LOG:  statement: CREATE TABLE auth.instances (
server # [  127.237344] postgres[1119]: 	    id uuid NOT NULL,
server # [  127.238852] postgres[1119]: 	    uuid uuid NULL,
server # [  127.239638] postgres[1119]: 	    raw_base_config text NULL,
server # [  127.240550] postgres[1119]: 	    created_at timestamptz NULL,
server # [  127.246511] postgres[1119]: 	    updated_at timestamptz NULL,
server # [  127.254226] postgres[1119]: 	    CONSTRAINT instances_pkey PRIMARY KEY (id)
server # [  127.261686] postgres[1119]: 	);
server # [  127.315047] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE TABLE
server # [  127.329696] postgres[1119]: ::1 2026-10-31 19:39:00.003 UTC [1119] postgres@postgres LOG:  statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';
server # [  127.365354] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: COMMENT
server # [  127.377716] postgres[1119]: ::1 2026-10-31 19:39:00.039 UTC [1119] postgres@postgres LOG:  statement: CREATE TABLE auth.audit_log_entries (
server # [  127.378967] postgres[1119]: 	    instance_id uuid NULL,
server # [  127.384722] postgres[1119]: 	    id uuid NOT NULL,
server # [  127.387303] postgres[1119]: 	    payload json NULL,
server # [  127.393383] postgres[1119]: 	    created_at timestamptz NULL,
server # [  127.401251] postgres[1119]: 	    CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)
server # [  127.402884] postgres[1119]: 	);
server # [  127.498872] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE TABLE
server # [  127.506932] postgres[1119]: ::1 2026-10-31 19:39:00.170 UTC [1119] postgres@postgres LOG:  statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);
server # [  127.549075] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE INDEX
server # [  127.568961] postgres[1119]: ::1 2026-10-31 19:39:00.239 UTC [1119] postgres@postgres LOG:  statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';
server # [  127.592679] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: COMMENT
server # [  127.601575] postgres[1119]: ::1 2026-10-31 19:39:00.275 UTC [1119] postgres@postgres LOG:  statement: CREATE TABLE auth.schema_migrations (
server # [  127.613327] postgres[1119]: 	    "version" varchar(255) NOT NULL,
server # [  127.624082] postgres[1119]: 	    CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")
server # [  127.639908] postgres[1119]: 	);
server # [  127.695034] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE TABLE
server # [  127.714244] postgres[1119]: ::1 2026-10-31 19:39:00.376 UTC [1119] postgres@postgres LOG:  statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';
server # [  127.749012] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: COMMENT
server # [  127.772887] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: INSERT 0 7
server # [  127.785002] postgres[1119]: ::1 2026-10-31 19:39:00.457 UTC [1119] postgres@postgres LOG:  statement: create or replace function auth.uid() returns uuid as $$
server # [  127.789371] postgres[1119]: 	  select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;
server # [  127.793381] postgres[1119]: 	$$ language sql stable;
server # [  127.794949] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE FUNCTION
server # [  127.796368] postgres[1119]: ::1 2026-10-31 19:39:00.472 UTC [1119] postgres@postgres LOG:  statement: create or replace function auth.role() returns text as $$
server # [  127.797970] postgres[1119]: 	  select nullif(current_setting('request.jwt.claim.role', true), '')::text;
server # [  127.798810] postgres[1119]: 	$$ language sql stable;
server # [  127.818455] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE FUNCTION
server # [  127.820806] postgres[1119]: ::1 2026-10-31 19:39:00.492 UTC [1119] postgres@postgres LOG:  statement: create or replace function auth.email() returns text as $$
server # [  127.822427] postgres[1119]: 	  select nullif(current_setting('request.jwt.claim.email', true), '')::text;
server # [  127.829121] postgres[1119]: 	$$ language sql stable;
server # [  127.830500] postgres[1119]: ::1 2026-10-31 19:39:00.506 UTC [1119] postgres@postgres LOG:  statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;
server # [  127.833785] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE FUNCTION
server # [  127.838767] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: GRANT
server # [  127.840356] postgres[1119]: ::1 2026-10-31 19:39:00.515 UTC [1119] postgres@postgres LOG:  statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;
server # [  127.847188] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: CREATE ROLE
server # [  127.848005] postgres[1119]: ::1 2026-10-31 19:39:00.524 UTC [1119] postgres@postgres LOG:  statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;
server # [  127.859163] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: GRANT
server # [  127.866027] postgres[1119]: ::1 2026-10-31 19:39:00.535 UTC [1119] postgres@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;
server # [  127.873277] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: GRANT
server # [  127.881094] postgres[1119]: ::1 2026-10-31 19:39:00.548 UTC [1119] postgres@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;
server # [  127.883197] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: GRANT
server # [  127.887842] postgres[1119]: ::1 2026-10-31 19:39:00.557 UTC [1119] postgres@postgres LOG:  statement: ALTER USER supabase_auth_admin SET search_path = "auth";
server # [  127.898745] postgres[1119]: ::1 2026-10-31 19:39:00.569 UTC [1119] postgres@postgres LOG:  statement: ALTER table "auth".users OWNER TO supabase_auth_admin;
server # [  127.901693] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: ALTER ROLE
server # [  127.918792] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: ALTER TABLE
server # [  127.920048] postgres[1119]: ::1 2026-10-31 19:39:00.593 UTC [1119] postgres@postgres LOG:  statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;
server # [  127.939751] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: ALTER TABLE
server # [  127.946849] postgres[1119]: ::1 2026-10-31 19:39:00.622 UTC [1119] postgres@postgres LOG:  statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;
server # [  127.960696] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: ALTER TABLE
server # [  127.962733] postgres[1119]: ::1 2026-10-31 19:39:00.634 UTC [1119] postgres@postgres LOG:  statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;
server # [  127.970142] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: ALTER TABLE
server # [  127.977893] postgres[1119]: ::1 2026-10-31 19:39:00.650 UTC [1119] postgres@postgres LOG:  statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;
server # [  128.005964] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1118]: ALTER TABLE
server # [  128.078325] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql
server # [  128.421930] postgres[1141]: ::1 2026-10-31 19:39:01.088 UTC [1141] postgres@postgres LOG:  statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;
server # [  128.441518] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1140]: CREATE SCHEMA
server # [  128.443100] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1140]: CREATE ROLE
server # [  128.445631] postgres[1141]: ::1 2026-10-31 19:39:01.105 UTC [1141] postgres@postgres LOG:  statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;
server # [  128.450594] postgres[1141]: ::1 2026-10-31 19:39:01.114 UTC [1141] postgres@postgres LOG:  statement: ALTER USER supabase_storage_admin SET search_path = "storage";
server # [  128.456407] postgres[1141]: ::1 2026-10-31 19:39:01.124 UTC [1141] postgres@postgres LOG:  statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;
server # [  128.462692] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1140]: ALTER ROLE
server # [  128.467221] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1140]: GRANT
server # [  128.498622] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1140]: DO
server # [  128.545500] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql
server # [  128.827545] postgres[1143]: ::1 2026-10-31 19:39:01.493 UTC [1143] postgres@postgres LOG:  statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;
server # [  128.844217] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: ALTER ROLE
server # [  128.854616] postgres[1143]: ::1 2026-10-31 19:39:01.522 UTC [1143] postgres@postgres LOG:  statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;
server # [  128.861786] postgres[1143]: ::1 2026-10-31 19:39:01.537 UTC [1143] postgres@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()
server # [  128.863144] postgres[1143]: 	RETURNS event_trigger
server # [  128.868714] postgres[1143]: 	LANGUAGE plpgsql
server # [  128.870970] postgres[1143]: 	AS $$
server # [  128.871913] postgres[1143]: 	DECLARE
server # [  128.878407] postgres[1143]: 	  schema_is_cron bool;
server # [  128.881567] postgres[1143]: 	BEGIN
server # [  128.885899] postgres[1143]: 	  schema_is_cron = (
server # [  128.889483] postgres[1143]: 	    SELECT n.nspname = 'cron'
server # [  128.893964] postgres[1143]: 	    FROM pg_event_trigger_ddl_commands() AS ev
server # [  128.899160] postgres[1143]: 	    LEFT JOIN pg_catalog.pg_namespace AS n
server # [  128.904233] postgres[1143]: 	      ON ev.objid = n.oid
server # [  128.910035] postgres[1143]: 	  );
server # [  128.917851] postgres[1143]:
server # [  128.921789] postgres[1143]: 	  IF schema_is_cron
server # [  128.923069] postgres[1143]: 	  THEN
server # [  128.930949] postgres[1143]: 	    grant usage on schema cron to postgres with grant option;
server # [  128.934605] postgres[1143]:
server # [  128.938933] postgres[1143]: 	    alter default privileges in schema cron grant all on tables to postgres with grant option;
server # [  128.944608] postgres[1143]: 	    alter default privileges in schema cron grant all on functions to postgres with grant option;
server # [  128.950973] postgres[1143]: 	    alter default privileges in schema cron grant all on sequences to postgres with grant option;
server # [  128.957185] postgres[1143]:
server # [  128.958410] postgres[1143]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  128.959995] postgres[1143]: 	        on sequences to postgres with grant option;
server # [  128.965920] postgres[1143]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  128.966953] postgres[1143]: 	        on tables to postgres with grant option;
server # [  128.967911] postgres[1143]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  128.969821] postgres[1143]: 	        on functions to postgres with grant option;
server # [  128.974222] postgres[1143]:
server # [  128.978623] postgres[1143]: 	    grant all privileges on all tables in schema cron to postgres with grant option;
server # [  128.981646] postgres[1143]:
server # [  128.985320] postgres[1143]: 	  END IF;
server # [  128.986523] postgres[1143]:
server # [  128.990313] postgres[1143]: 	END;
server # [  128.996830] postgres[1143]: 	$$;
server # [  128.998967] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: ALTER ROLE
server # [  128.999933] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: CREATE FUNCTION
server # [  129.002007] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: CREATE EVENT TRIGGER
server # [  129.010658] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: COMMENT
server # [  129.012121] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: CREATE FUNCTION
server # [  129.013368] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: COMMENT
server # [  129.014849] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: DO
server # [  129.020676] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: CREATE ROLE
server # [  129.022423] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: GRANT
server # [  129.023555] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: GRANT
server # [  129.025843] postgres[1143]: ::1 2026-10-31 19:39:01.563 UTC [1143] postgres@postgres LOG:  statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')
server # [  129.029389] postgres[1143]: 	EXECUTE PROCEDURE extensions.grant_pg_cron_access();
server # [  129.035212] postgres[1143]: ::1 2026-10-31 19:39:01.579 UTC [1143] postgres@postgres LOG:  statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';
server # [  129.040981] postgres[1143]: ::1 2026-10-31 19:39:01.597 UTC [1143] postgres@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()
server # [  129.042368] postgres[1143]: 	RETURNS event_trigger
server # [  129.045007] postgres[1143]: 	LANGUAGE plpgsql
server # [  129.050748] postgres[1143]: 	AS $$
server # [  129.058520] postgres[1143]: 	BEGIN
server # [  129.060134] postgres[1143]: 	  IF EXISTS (
server # [  129.062419] postgres[1143]: 	    SELECT 1
server # [  129.063787] postgres[1143]: 	    FROM pg_event_trigger_ddl_commands() AS ev
server # [  129.068763] postgres[1143]: 	    JOIN pg_extension AS ext
server # [  129.073167] postgres[1143]: 	    ON ev.objid = ext.oid
server # [  129.077175] postgres[1143]: 	    WHERE ext.extname = 'pg_net'
server # [  129.081586] postgres[1143]: 	  )
server # [  129.086448] postgres[1143]: 	  THEN
server # [  129.093745] postgres[1143]: 	    IF NOT EXISTS (
server # [  129.095309] postgres[1143]: 	      SELECT 1
server # [  129.096019] postgres[1143]: 	      FROM pg_roles
server # [  129.099380] postgres[1143]: 	      WHERE rolname = 'supabase_functions_admin'
server # [  129.107044] postgres[1143]: 	    )
server # [  129.110117] postgres[1143]: 	    THEN
server # [  129.114193] postgres[1143]: 	      CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;
server # [  129.118749] postgres[1143]: 	    END IF;
server # [  129.120662] postgres[1143]:
server # [  129.126242] postgres[1143]: 	    GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;
server # [  129.128418] postgres[1143]:
server # [  129.137872] postgres[1143]: 	    ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;
server # [  129.145607] postgres[1143]: 	    ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;
server # [  129.153936] postgres[1143]:
server # [  129.163983] postgres[1143]: 	    ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;
server # [  129.171211] postgres[1143]: 	    ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;
server # [  129.186661] postgres[1143]:
server # [  129.194404] postgres[1143]: 	    REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;
server # [  129.202406] postgres[1143]: 	    REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;
server # [  129.203573] postgres[1143]:
server # [  129.204280] postgres[1143]: 	    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;
server # [  129.210661] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: GRANT
server # [  129.217628] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: GRANT
server # [  129.220037] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: GRANT
server # [  129.222359] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: GRANT
server # [  129.229729] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: GRANT
server # [  129.231084] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: GRANT
server # [  129.233880] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: GRANT
server # [  129.237263] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1142]: DO
server # [  129.238708] postgres[1143]: 	    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;
server # [  129.246038] postgres[1143]: 	  END IF;
server # [  129.248947] postgres[1143]: 	END;
server # [  129.250458] postgres[1143]: 	$$;
server # [  129.257743] postgres[1143]: ::1 2026-10-31 19:39:01.610 UTC [1143] postgres@postgres LOG:  statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';
server # [  129.259633] postgres[1143]: ::1 2026-10-31 19:39:01.643 UTC [1143] postgres@postgres LOG:  statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;
server # [  129.270408] postgres[1143]: ::1 2026-10-31 19:39:01.653 UTC [1143] postgres@postgres LOG:  statement: GRANT ALL ON DATABASE postgres TO dashboard_user;
server # [  129.273635] postgres[1143]: ::1 2026-10-31 19:39:01.662 UTC [1143] postgres@postgres LOG:  statement: GRANT ALL ON SCHEMA auth TO dashboard_user;
server # [  129.275249] postgres[1143]: ::1 2026-10-31 19:39:01.670 UTC [1143] postgres@postgres LOG:  statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;
server # [  129.278050] postgres[1143]: ::1 2026-10-31 19:39:01.687 UTC [1143] postgres@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;
server # [  129.286578] postgres[1143]: ::1 2026-10-31 19:39:01.703 UTC [1143] postgres@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;
server # [  129.290164] postgres[1143]: ::1 2026-10-31 19:39:01.707 UTC [1143] postgres@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;
server # [  129.298930] postgres[1143]: ::1 2026-10-31 19:39:01.717 UTC [1143] postgres@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;
server # [  129.301720] postgres[1143]: ::1 2026-10-31 19:39:01.721 UTC [1143] postgres@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;
server # [  129.303645] postgres[1143]: ::1 2026-10-31 19:39:01.745 UTC [1143] postgres@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;
server # [  129.317269] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running pgbouncer auth schema...
server # [  129.530019] postgres[1145]: ::1 2026-10-31 19:39:02.180 UTC [1145] postgres@postgres LOG:  statement: CREATE USER pgbouncer;
server # [  129.539461] postgres[1145]: ::1 2026-10-31 19:39:02.203 UTC [1145] postgres@postgres LOG:  statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;
server # [  129.547812] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1144]: CREATE ROLE
server # [  129.557679] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1144]: REVOKE
server # [  129.561557] postgres[1145]: ::1 2026-10-31 19:39:02.230 UTC [1145] postgres@postgres LOG:  statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;
server # [  129.602291] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1144]: CREATE SCHEMA
server # [  129.609037] postgres[1145]: ::1 2026-10-31 19:39:02.282 UTC [1145] postgres@postgres LOG:  statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)
server # [  129.611127] postgres[1145]: 	RETURNS TABLE(username TEXT, password TEXT) AS
server # [  129.617202] postgres[1145]: 	$$
server # [  129.619032] postgres[1145]: 	BEGIN
server # [  129.625396] postgres[1145]: 	    RAISE WARNING 'PgBouncer auth request: %', p_usename;
server # [  129.627507] postgres[1145]:
server # [  129.632001] postgres[1145]: 	    RETURN QUERY
server # [  129.635200] postgres[1145]: 	    SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow
server # [  129.642253] postgres[1145]: 	    WHERE usename = p_usename;
server # [  129.643885] postgres[1145]: 	END;
server # [  129.649884] postgres[1145]: 	$$ LANGUAGE plpgsql
server # [  129.655371] postgres[1145]: 	SET search_path = ''
server # [  129.658116] postgres[1145]: 	SECURITY DEFINER;
server # [  129.659316] postgres[1145]: ::1 2026-10-31 19:39:02.315 UTC [1145] postgres@postgres LOG:  statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;
server # [  129.660936] postgres[1145]: ::1 2026-10-31 19:39:02.334 UTC [1145] postgres@postgres LOG:  statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;
server # [  129.663740] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1144]: CREATE FUNCTION
server # [  129.666859] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1144]: REVOKE
server # [  129.674298] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1144]: GRANT
server # [  129.724808] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running stat extension...
server # [  130.043279] postgres[1149]: ::1 2026-10-31 19:39:02.715 UTC [1149] postgres@postgres LOG:  statement: CREATE SCHEMA IF NOT exists extensions;
server # [  130.063867] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1148]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE:  schema "extensions" already exists, skipping
server # [  130.104987] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1148]: CREATE SCHEMA
server # [  130.118712] postgres[1149]: ::1 2026-10-31 19:39:02.785 UTC [1149] postgres@postgres LOG:  statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;
server # [  131.203496] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1148]: CREATE EXTENSION
server # [  131.295670] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql
server # [  131.635877] postgres[1151]: ::1 2026-10-31 19:39:04.296 UTC [1151] supabase_admin@postgres LOG:  statement: GRANT ALL ON DATABASE postgres TO postgres;
server # [  131.651580] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1150]: GRANT
server # [  131.658135] postgres[1151]: ::1 2026-10-31 19:39:04.324 UTC [1151] supabase_admin@postgres LOG:  statement: GRANT ALL ON SCHEMA auth TO postgres;
server # [  131.667469] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1150]: GRANT
server # [  131.674036] postgres[1151]: ::1 2026-10-31 19:39:04.348 UTC [1151] supabase_admin@postgres LOG:  statement: GRANT ALL ON SCHEMA extensions TO postgres;
server # [  131.686909] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1150]: GRANT
server # [  131.699559] postgres[1151]: ::1 2026-10-31 19:39:04.370 UTC [1151] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;
server # [  131.723321] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1150]: GRANT
server # [  131.725762] postgres[1151]: ::1 2026-10-31 19:39:04.399 UTC [1151] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;
server # [  131.733987] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1150]: GRANT
server # [  131.735849] postgres[1151]: ::1 2026-10-31 19:39:04.411 UTC [1151] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;
server # [  131.743952] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1150]: GRANT
server # [  131.745876] postgres[1151]: ::1 2026-10-31 19:39:04.420 UTC [1151] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;
server # [  131.751679] postgres[1151]: ::1 2026-10-31 19:39:04.424 UTC [1151] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;
server # [  131.755387] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1150]: GRANT
server # [  131.769177] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1150]: GRANT
server # [  131.770497] postgres[1151]: ::1 2026-10-31 19:39:04.445 UTC [1151] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;
server # [  131.841991] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1150]: GRANT
server # [  131.915649] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1150]: DO
server # [  131.917698] postgres[1151]: ::1 2026-10-31 19:39:04.591 UTC [1151] supabase_admin@postgres LOG:  statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;
server # [  131.927821] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1150]: ALTER ROLE
server # [  131.985165] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql
server # [  132.483998] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3
server # [  132.486466] postgres[1166]: ::1 2026-10-31 19:39:05.135 UTC [1166] supabase_admin@postgres LOG:  statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;
server # [  132.502344] postgres[1166]: ::1 2026-10-31 19:39:05.174 UTC [1166] supabase_admin@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;
server # [  132.521539] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: GRANT
server # [  132.533787] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: GRANT
server # [  132.538579] postgres[1166]: ::1 2026-10-31 19:39:05.211 UTC [1166] supabase_admin@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;
server # [  132.552487] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: GRANT
server # [  132.558005] postgres[1166]: ::1 2026-10-31 19:39:05.232 UTC [1166] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;
server # [  132.573975] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: ALTER TABLE
server # [  132.582805] postgres[1166]: ::1 2026-10-31 19:39:05.254 UTC [1166] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;
server # [  132.597206] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: ALTER TABLE
server # [  132.606348] postgres[1166]: ::1 2026-10-31 19:39:05.271 UTC [1166] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;
server # [  132.610104] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: ALTER TABLE
server # [  132.617811] postgres[1166]: ::1 2026-10-31 19:39:05.287 UTC [1166] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;
server # [  132.620987] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: ALTER TABLE
server # [  132.625643] postgres[1166]: ::1 2026-10-31 19:39:05.297 UTC [1166] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;
server # [  132.632767] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: ALTER TABLE
server # [  132.634331] postgres[1166]: ::1 2026-10-31 19:39:05.310 UTC [1166] supabase_admin@postgres LOG:  statement: GRANT USAGE ON SCHEMA auth TO postgres;
server # [  132.649257] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: GRANT
server # [  132.658583] postgres[1166]: ::1 2026-10-31 19:39:05.323 UTC [1166] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;
server # [  132.665599] postgres[1166]: ::1 2026-10-31 19:39:05.340 UTC [1166] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;
server # [  132.675996] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: GRANT
server # [  132.694943] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: GRANT
server # [  132.696007] postgres[1166]: ::1 2026-10-31 19:39:05.365 UTC [1166] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;
server # [  132.721317] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: GRANT
server # [  132.723005] postgres[1166]: ::1 2026-10-31 19:39:05.397 UTC [1166] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user;
server # [  132.740614] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: ALTER DEFAULT PRIVILEGES
server # [  132.749279] postgres[1166]: ::1 2026-10-31 19:39:05.420 UTC [1166] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user;
server # [  132.766366] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: ALTER DEFAULT PRIVILEGES
server # [  132.774129] postgres[1166]: ::1 2026-10-31 19:39:05.449 UTC [1166] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user;
server # [  132.796562] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1161]: ALTER DEFAULT PRIVILEGES
server # [  132.888680] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql
server # [  133.227286] postgres[1175]: ::1 2026-10-31 19:39:05.896 UTC [1175] supabase_admin@postgres LOG:  statement: CREATE SCHEMA IF NOT EXISTS realtime;
server # [  133.246884] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1174]: CREATE SCHEMA
server # [  133.297495] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql
server # [  133.617333] postgres[1177]: ::1 2026-10-31 19:39:06.285 UTC [1177] supabase_admin@postgres LOG:  statement: GRANT USAGE ON SCHEMA realtime TO postgres;
server # [  133.639709] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1176]: GRANT
server # [  133.645526] postgres[1177]: ::1 2026-10-31 19:39:06.312 UTC [1177] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;
server # [  133.652951] postgres[1177]: ::1 2026-10-31 19:39:06.317 UTC [1177] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;
server # [  133.655397] postgres[1177]: ::1 2026-10-31 19:39:06.319 UTC [1177] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;
server # [  133.670026] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1176]: GRANT
server # [  133.671630] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1176]: GRANT
server # [  133.677834] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1176]: GRANT
server # [  133.700897] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql
server # [  134.062863] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1178]: DO
server # [  134.080769] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1178]: DO
server # [  134.087329] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1178]: DO
server # [  134.110706] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql
server # [  134.362086] postgres[1181]: ::1 2026-10-31 19:39:07.024 UTC [1181] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user;
server # [  134.377725] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1180]: ALTER DEFAULT PRIVILEGES
server # [  134.382264] postgres[1181]: ::1 2026-10-31 19:39:07.043 UTC [1181] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user;
server # [  134.385908] postgres[1181]: ::1 2026-10-31 19:39:07.053 UTC [1181] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user;
server # [  134.389966] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1180]: ALTER DEFAULT PRIVILEGES
server # [  134.391188] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1180]: ALTER DEFAULT PRIVILEGES
server # [  134.428846] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql
server # [  134.715667] postgres[1183]: ::1 2026-10-31 19:39:07.379 UTC [1183] supabase_admin@postgres LOG:  statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';
server # [  134.734212] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1182]: ALTER ROLE
server # [  134.775627] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql
server # [  135.097321] postgres[1185]: ::1 2026-10-31 19:39:07.764 UTC [1185] supabase_admin@postgres LOG:  statement: drop event trigger if exists api_restart;
server # [  135.105611] postgres[1185]: ::1 2026-10-31 19:39:07.781 UTC [1185] supabase_admin@postgres LOG:  statement: drop function if exists extensions.notify_api_restart();
server # [  135.115135] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE:  event trigger "api_restart" does not exist, skipping
server # [  135.122128] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: DROP EVENT TRIGGER
server # [  135.129764] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE:  function extensions.notify_api_restart() does not exist, skipping
server # [  135.132260] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: DROP FUNCTION
server # [  135.138065] postgres[1185]: ::1 2026-10-31 19:39:07.792 UTC [1185] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$
server # [  135.146526] postgres[1185]: 	DECLARE
server # [  135.153676] postgres[1185]: 	  cmd record;
server # [  135.156011] postgres[1185]: 	BEGIN
server # [  135.162073] postgres[1185]: 	  FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()
server # [  135.163650] postgres[1185]: 	  LOOP
server # [  135.169754] postgres[1185]: 	    IF cmd.command_tag IN (
server # [  135.171586] postgres[1185]: 	      'CREATE SCHEMA', 'ALTER SCHEMA'
server # [  135.174199] postgres[1185]: 	    , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'
server # [  135.177330] postgres[1185]: 	    , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'
server # [  135.182686] postgres[1185]: 	    , 'CREATE VIEW', 'ALTER VIEW'
server # [  135.185764] postgres[1185]: 	    , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'
server # [  135.193018] postgres[1185]: 	    , 'CREATE FUNCTION', 'ALTER FUNCTION'
server # [  135.197570] postgres[1185]: 	    , 'CREATE TRIGGER'
server # [  135.198679] postgres[1185]: 	    , 'CREATE TYPE'
server # [  135.205547] postgres[1185]: 	    , 'CREATE RULE'
server # [  135.210125] postgres[1185]: 	    , 'COMMENT'
server # [  135.214005] postgres[1185]: 	    )
server # [  135.215588] postgres[1185]: 	    -- don't notify in case of CREATE TEMP table or other objects created on pg_temp
server # [  135.230569] postgres[1185]: 	    AND cmd.schema_name is distinct from 'pg_temp'
server # [  135.238881] postgres[1185]: 	    THEN
server # [  135.242810] postgres[1185]: 	      NOTIFY pgrst, 'reload schema';
server # [  135.258246] postgres[1185]: 	    END IF;
server # [  135.263190] postgres[1185]: 	  END LOOP;
server # [  135.271791] postgres[1185]: 	END; $$ LANGUAGE plpgsql;
server # [  135.280805] postgres[1185]: ::1 2026-10-31 19:39:07.825 UTC [1185] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$
server # [  135.286238] postgres[1185]: 	DECLARE
server # [  135.287417] postgres[1185]: 	  obj record;
server # [  135.289027] postgres[1185]: 	BEGIN
server # [  135.297154] postgres[1185]: 	  FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()
server # [  135.305864] postgres[1185]: 	  LOOP
server # [  135.314092] postgres[1185]: 	    IF obj.object_type IN (
server # [  135.317035] postgres[1185]: 	      'schema'
server # [  135.325380] postgres[1185]: 	    , 'table'
server # [  135.333183] postgres[1185]: 	    , 'foreign table'
server # [  135.335053] postgres[1185]: 	    , 'view'
server # [  135.337216] postgres[1185]: 	    , 'materialized view'
server # [  135.340892] postgres[1185]: 	    , 'function'
server # [  135.343938] postgres[1185]: 	    , 'trigger'
server # [  135.350261] postgres[1185]: 	    , 'type'
server # [  135.357039] postgres[1185]: 	    , 'rule'
server # [  135.359738] postgres[1185]: 	    )
server # [  135.362462] postgres[1185]: 	    AND obj.is_temporary IS false -- no pg_temp objects
server # [  135.365391] postgres[1185]: 	    THEN
server # [  135.375742] postgres[1185]: 	      NOTIFY pgrst, 'reload schema';
server # [  135.380762] postgres[1185]: 	    END IF;
server # [  135.385632] postgres[1185]: 	  END LOOP;
server # [  135.390345] postgres[1185]: 	END; $$ LANGUAGE plpgsql;
server # [  135.398813] postgres[1185]: ::1 2026-10-31 19:39:07.840 UTC [1185] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;
server # [  135.401825] postgres[1185]: ::1 2026-10-31 19:39:07.850 UTC [1185] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_ddl_watch
server # [  135.404150] postgres[1185]: 	  ON ddl_command_end
server # [  135.413470] postgres[1185]: 	  EXECUTE PROCEDURE extensions.pgrst_ddl_watch();
server # [  135.416167] postgres[1185]: ::1 2026-10-31 19:39:07.867 UTC [1185] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;
server # [  135.418320] postgres[1185]: ::1 2026-10-31 19:39:07.872 UTC [1185] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_drop_watch
server # [  135.421049] postgres[1185]: 	  ON sql_drop
server # [  135.423347] postgres[1185]: 	  EXECUTE PROCEDURE extensions.pgrst_drop_watch();
server # [  135.426852] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: CREATE FUNCTION
server # [  135.433955] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: CREATE FUNCTION
server # [  135.435216] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE:  event trigger "pgrst_ddl_watch" does not exist, skipping
server # [  135.437530] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: DROP EVENT TRIGGER
server # [  135.438816] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: CREATE EVENT TRIGGER
server # [  135.442663] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE:  event trigger "pgrst_drop_watch" does not exist, skipping
server # [  135.444857] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: DROP EVENT TRIGGER
server # [  135.447199] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1184]: CREATE EVENT TRIGGER
server # [  135.457888] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql
server # [  136.418759] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1192]: DO
server # [  136.449151] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql
server # [  136.797013] postgres[1209]: ::1 2026-10-31 19:39:09.463 UTC [1209] supabase_admin@postgres LOG:  statement: create schema if not exists graphql_public;
server # [  136.844871] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: CREATE SCHEMA
server # [  136.849747] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE:  function graphql_public.graphql(text,text,jsonb) does not exist, skipping
server # [  136.852095] postgres[1209]: ::1 2026-10-31 19:39:09.517 UTC [1209] supabase_admin@postgres LOG:  statement: drop function if exists graphql_public.graphql(text, text, jsonb);
server # [  136.857367] postgres[1209]: ::1 2026-10-31 19:39:09.531 UTC [1209] supabase_admin@postgres LOG:  statement: create or replace function graphql_public.graphql(
server # [  136.865301] postgres[1209]: 	    "operationName" text default null,
server # [  136.869971] postgres[1209]: 	    query text default null,
server # [  136.874225] postgres[1209]: 	    variables jsonb default null,
server # [  136.881731] postgres[1209]: 	    extensions jsonb default null
server # [  136.883334] postgres[1209]: 	)
server # [  136.886169] postgres[1209]: 	    returns jsonb
server # [  136.886947] postgres[1209]: 	    language plpgsql
server # [  136.887377] postgres[1209]: 	as $$
server # [  136.887964] postgres[1209]: 	    DECLARE
server # [  136.888319] postgres[1209]: 	        server_version float;
server # [  136.893220] postgres[1209]: 	    BEGIN
server # [  136.897304] postgres[1209]: 	        server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);
server # [  136.898439] postgres[1209]:
server # [  136.901907] postgres[1209]: 	        IF server_version >= 14 THEN
server # [  136.910011] postgres[1209]: 	            RETURN jsonb_build_object(
server # [  136.911881] postgres[1209]: 	                'data', null::jsonb,
server # [  136.915083] postgres[1209]: 	                'errors', array['pg_graphql extension is not enabled.']
server # [  136.923572] postgres[1209]: 	            );
server # [  136.925027] postgres[1209]: 	        ELSE
server # [  136.927159] postgres[1209]: 	            RETURN jsonb_build_object(
server # [  136.934783] postgres[1209]: 	                'data', null::jsonb,
server # [  136.938178] postgres[1209]: 	                'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']
server # [  136.940706] postgres[1209]: 	            );
server # [  136.941782] postgres[1209]: 	        END IF;
server # [  136.942947] postgres[1209]: 	    END;
server # [  136.943794] postgres[1209]: 	$$;
server # [  136.945236] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: DROP FUNCTION
server # [  136.947043] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: CREATE FUNCTION
server # [  136.948960] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: GRANT
server # [  136.949946] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: ALTER DEFAULT PRIVILEGES
server # [  136.952303] postgres[1209]: ::1 2026-10-31 19:39:09.570 UTC [1209] supabase_admin@postgres LOG:  statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;
server # [  136.954249] postgres[1209]: ::1 2026-10-31 19:39:09.594 UTC [1209] supabase_admin@postgres LOG:  statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;
server # [  136.955142] postgres[1209]: ::1 2026-10-31 19:39:09.621 UTC [1209] supabase_admin@postgres LOG:  statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;
server # [  136.959044] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: ALTER DEFAULT PRIVILEGES
server # [  136.960307] postgres[1209]: ::1 2026-10-31 19:39:09.635 UTC [1209] supabase_admin@postgres LOG:  statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;
server # [  136.977195] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: ALTER DEFAULT PRIVILEGES
server # [  136.978484] postgres[1209]: ::1 2026-10-31 19:39:09.650 UTC [1209] supabase_admin@postgres LOG:  statement: alter default privileges for user supabase_admin in schema graphql_public grant all
server # [  136.979110] postgres[1209]: 	    on sequences to postgres, anon, authenticated, service_role;
server # [  136.993097] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: ALTER DEFAULT PRIVILEGES
server # [  136.995958] postgres[1209]: ::1 2026-10-31 19:39:09.668 UTC [1209] supabase_admin@postgres LOG:  statement: alter default privileges for user supabase_admin in schema graphql_public grant all
server # [  136.999188] postgres[1209]: 	    on tables to postgres, anon, authenticated, service_role;
server # [  137.007269] postgres[1209]: ::1 2026-10-31 19:39:09.677 UTC [1209] supabase_admin@postgres LOG:  statement: alter default privileges for user supabase_admin in schema graphql_public grant all
server # [  137.010265] postgres[1209]: 	    on functions to postgres, anon, authenticated, service_role;
server # [  137.011685] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: ALTER DEFAULT PRIVILEGES
server # [  137.014737] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: ALTER DEFAULT PRIVILEGES
server # [  137.019846] postgres[1209]: ::1 2026-10-31 19:39:09.693 UTC [1209] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()
server # [  137.021969] postgres[1209]: 	RETURNS event_trigger
server # [  137.025275] postgres[1209]: 	LANGUAGE plpgsql
server # [  137.027412] postgres[1209]: 	AS $func$
server # [  137.034049] postgres[1209]: 	    DECLARE
server # [  137.035200] postgres[1209]: 	    func_is_graphql_resolve bool;
server # [  137.035967] postgres[1209]: 	    BEGIN
server # [  137.042429] postgres[1209]: 	    func_is_graphql_resolve = (
server # [  137.043376] postgres[1209]: 	        SELECT n.proname = 'resolve'
server # [  137.045912] postgres[1209]: 	        FROM pg_event_trigger_ddl_commands() AS ev
server # [  137.049215] postgres[1209]: 	        LEFT JOIN pg_catalog.pg_proc AS n
server # [  137.050577] postgres[1209]: 	        ON ev.objid = n.oid
server # [  137.054374] postgres[1209]: 	    );
server # [  137.059007] postgres[1209]:
server # [  137.060039] postgres[1209]: 	    IF func_is_graphql_resolve
server # [  137.062116] postgres[1209]: 	    THEN
server # [  137.064824] postgres[1209]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;
server # [  137.066260] postgres[1209]: 	        grant all on function graphql.resolve to postgres, anon, authenticated, service_role;
server # [  137.067014] postgres[1209]:
server # [  137.073059] postgres[1209]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;
server # [  137.074696] postgres[1209]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;
server # [  137.075368] postgres[1209]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;
server # [  137.077736] postgres[1209]:
server # [  137.079105] postgres[1209]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;
server # [  137.085594] postgres[1209]: 	        create or replace function graphql_public.graphql(
server # [  137.087779] postgres[1209]: 	            "operationName" text default null,
server # [  137.089792] postgres[1209]: 	            query text default null,
server # [  137.093475] postgres[1209]: 	            variables jsonb default null,
server # [  137.094840] postgres[1209]: 	            extensions jsonb default null
server # [  137.095668] postgres[1209]: 	        )
server # [  137.100918] postgres[1209]: 	            returns jsonb
server # [  137.102226] postgres[1209]: 	            language sql
server # [  137.104863] postgres[1209]: 	        as $$
server # [  137.109169] postgres[1209]: 	            SELECT graphql.resolve(query, coalesce(variables, '{}'));
server # [  137.110330] postgres[1209]: 	        $$;
server # [  137.111074] postgres[1209]:
server # [  137.113781] postgres[1209]: 	        grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;
server # [  137.115261] postgres[1209]: 	    END IF;
server # [  137.121333] postgres[1209]:
server # [  137.122809] postgres[1209]: 	    END;
server # [  137.125300] postgres[1209]: 	$func$;
server # [  137.127272] postgres[1209]: ::1 2026-10-31 19:39:09.708 UTC [1209] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;
server # [  137.135515] postgres[1209]: ::1 2026-10-31 19:39:09.713 UTC [1209] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')
server # [  137.142183] postgres[1209]: 	EXECUTE PROCEDURE extensions.grant_pg_graphql_access();
server # [  137.142996] postgres[1209]: ::1 2026-10-31 19:39:09.724 UTC [1209] supabase_admin@postgres LOG:  statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';
server # [  137.143792] postgres[1209]: ::1 2026-10-31 19:39:09.738 UTC [1209] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()
server # [  137.150445] postgres[1209]: 	RETURNS event_trigger
server # [  137.161703] postgres[1209]: 	LANGUAGE plpgsql
server # [  137.163259] postgres[1209]: 	AS $func$
server # [  137.171826] postgres[1209]: 	    DECLARE
server # [  137.177860] postgres[1209]: 	    graphql_is_dropped bool;
server # [  137.178783] postgres[1209]: 	    BEGIN
server # [  137.179312] postgres[1209]: 	    graphql_is_dropped = (
server # [  137.179992] postgres[1209]: 	        SELECT ev.schema_name = 'graphql_public'
server # [  137.184434] postgres[1209]: 	        FROM pg_event_trigger_dropped_objects() AS ev
server # [  137.199232] postgres[1209]: 	        WHERE ev.schema_name = 'graphql_public'
server # [  137.202106] postgres[1209]: 	    );
server # [  137.205382] postgres[1209]:
server # [  137.206450] postgres[1209]: 	    IF graphql_is_dropped
server # [  137.207349] postgres[1209]: 	    THEN
server # [  137.208009] postgres[1209]: 	        create or replace function graphql_public.graphql(
server # [  137.209628] postgres[1209]: 	            "operationName" text default null,
server # [  137.211815] postgres[1209]: 	            query text default null,
server # [  137.213247] postgres[1209]: 	            variables jsonb default null,
server # [  137.214669] postgres[1209]: 	            extensions jsonb default null
server # [  137.216050] postgres[1209]: 	        )
server # [  137.218789] postgres[1209]: 	            returns jsonb
server # [  137.219810] postgres[1209]: 	            language plpgsql
server # [  137.222614] postgres[1209]: 	        as $$
server # [  137.232841] postgres[1209]: 	            DECLARE
server # [  137.245884] postgres[1209]: 	                server_version float;
server # [  137.256754] postgres[1209]: 	            BEGIN
server # [  137.261756] postgres[1209]: 	                server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);
server # [  137.273789] postgres[1209]:
server # [  137.276357] postgres[1209]: 	                IF server_version >= 14 THEN
server # [  137.280786] postgres[1209]: 	                    RETURN jsonb_build_object(
server # [  137.283629] postgres[1209]: 	                        'data', null::jsonb,
server # [  137.286460] postgres[1209]: 	                        'errors', array['pg_graphql extension is not enabled.']
server # [  137.288490] postgres[1209]: 	                    );
server # [  137.290580] postgres[1209]: 	                ELSE
server # [  137.293218] postgres[1209]: 	                    RETURN jsonb_build_object(
server # [  137.296194] postgres[1209]: 	                        'data', null::jsonb,
server # [  137.298586] postgres[1209]: 	                        'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']
server # [  137.301267] postgres[1209]: 	                    );
server # [  137.304384] postgres[1209]: 	                END IF;
server # [  137.306948] postgres[1209]: 	            END;
server # [  137.311086] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: CREATE FUNCTION
server # [  137.312588] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE:  event trigger "issue_pg_graphql_access" does not exist, skipping
server # [  137.314586] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: DROP EVENT TRIGGER
server # [  137.317283] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: CREATE EVENT TRIGGER
server # [  137.320006] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: COMMENT
server # [  137.322612] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: CREATE FUNCTION
server # [  137.323598] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE:  event trigger "issue_graphql_placeholder" does not exist, skipping
server # [  137.326994] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: DROP EVENT TRIGGER
server # [  137.330095] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: CREATE EVENT TRIGGER
server # [  137.332987] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1207]: COMMENT
server # [  137.334259] postgres[1209]: 	        $$;
server # [  137.336310] postgres[1209]: 	    END IF;
server # [  137.338373] postgres[1209]:
server # [  137.341523] postgres[1209]: 	    END;
server # [  137.344011] postgres[1209]: 	$func$;
server # [  137.346696] postgres[1209]: ::1 2026-10-31 19:39:09.786 UTC [1209] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;
server # [  137.350603] postgres[1209]: ::1 2026-10-31 19:39:09.789 UTC [1209] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')
server # [  137.355251] postgres[1209]: 	EXECUTE PROCEDURE extensions.set_graphql_placeholder();
server # [  137.357369] postgres[1209]: ::1 2026-10-31 19:39:09.801 UTC [1209] supabase_admin@postgres LOG:  statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';
server # [  137.366232] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql
server # [  137.526640] postgres[1211]: ::1 2026-10-31 19:39:10.194 UTC [1211] supabase_admin@postgres LOG:  statement: drop event trigger if exists api_restart;
server # [  137.533725] postgres[1211]: ::1 2026-10-31 19:39:10.207 UTC [1211] supabase_admin@postgres LOG:  statement: drop function if exists extensions.notify_api_restart();
server # [  137.554780] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1210]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE:  event trigger "api_restart" does not exist, skipping
server # [  137.562448] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1210]: DROP EVENT TRIGGER
server # [  137.571993] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1210]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:4: NOTICE:  function extensions.notify_api_restart() does not exist, skipping
server # [  137.581749] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1210]: DROP FUNCTION
server # [  137.583956] postgres[1211]: ::1 2026-10-31 19:39:10.253 UTC [1211] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$
server # [  137.593290] postgres[1211]: 	DECLARE
server # [  137.594767] postgres[1211]: 	  cmd record;
server # [  137.595944] postgres[1211]: 	BEGIN
server # [  137.602022] postgres[1211]: 	  FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()
server # [  137.603833] postgres[1211]: 	  LOOP
server # [  137.611616] postgres[1211]: 	    IF cmd.command_tag IN (
server # [  137.618030] postgres[1211]: 	      'CREATE SCHEMA', 'ALTER SCHEMA'
server # [  137.622589] postgres[1211]: 	    , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'
server # [  137.627796] postgres[1211]: 	    , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'
server # [  137.631406] postgres[1211]: 	    , 'CREATE VIEW', 'ALTER VIEW'
server # [  137.636039] postgres[1211]: 	    , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'
server # [  137.642879] postgres[1211]: 	    , 'CREATE FUNCTION', 'ALTER FUNCTION'
server # [  137.654711] postgres[1211]: 	    , 'CREATE TRIGGER'
server # [  137.660951] postgres[1211]: 	    , 'CREATE TYPE', 'ALTER TYPE'
server # [  137.664057] postgres[1211]: 	    , 'CREATE RULE'
server # [  137.671494] postgres[1211]: 	    , 'COMMENT'
server # [  137.674670] postgres[1211]: 	    )
server # [  137.676871] postgres[1211]: 	    -- don't notify in case of CREATE TEMP table or other objects created on pg_temp
server # [  137.678580] postgres[1211]: 	    AND cmd.schema_name is distinct from 'pg_temp'
server # [  137.680934] postgres[1211]: 	    THEN
server # [  137.683696] postgres[1211]: 	      NOTIFY pgrst, 'reload schema';
server # [  137.686478] postgres[1211]: 	    END IF;
server # [  137.688446] postgres[1211]: 	  END LOOP;
server # [  137.689795] postgres[1211]: 	END; $$ LANGUAGE plpgsql;
server # [  137.691035] postgres[1211]: ::1 2026-10-31 19:39:10.314 UTC [1211] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$
server # [  137.693563] postgres[1211]: 	DECLARE
server # [  137.698030] postgres[1211]: 	  obj record;
server # [  137.699570] postgres[1211]: 	BEGIN
server # [  137.709987] postgres[1211]: 	  FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()
server # [  137.713914] postgres[1211]: 	  LOOP
server # [  137.731241] postgres[1211]: 	    IF obj.object_type IN (
server # [  137.747580] postgres[1211]: 	      'schema'
server # [  137.763755] postgres[1211]: 	    , 'table'
server # [  137.782094] postgres[1211]: 	    , 'foreign table'
server # [  137.786916] postgres[1211]: 	    , 'view'
server # [  137.799454] postgres[1211]: 	    , 'materialized view'
server # [  137.803922] postgres[1211]: 	    , 'function'
server # [  137.806884] postgres[1211]: 	    , 'trigger'
server # [  137.813672] postgres[1211]: 	    , 'type'
server # [  137.815121] postgres[1211]: 	    , 'rule'
server # [  137.817459] postgres[1211]: 	    )
server # [  137.823492] postgres[1211]: 	    AND obj.is_temporary IS false -- no pg_temp objects
server # [  137.825911] postgres[1211]: 	    THEN
server # [  137.827800] postgres[1211]: 	      NOTIFY pgrst, 'reload schema';
server # [  137.834158] postgres[1211]: 	    END IF;
server # [  137.838927] postgres[1211]: 	  END LOOP;
server # [  137.846978] postgres[1211]: 	END; $$ LANGUAGE plpgsql;
server # [  137.857266] postgres[1211]: ::1 2026-10-31 19:39:10.339 UTC [1211] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;
server # [  137.861020] postgres[1211]: ::1 2026-10-31 19:39:10.352 UTC [1211] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_ddl_watch
server # [  137.867673] postgres[1211]: 	  ON ddl_command_end
server # [  137.878544] postgres[1211]: 	  EXECUTE PROCEDURE extensions.pgrst_ddl_watch();
server # [  137.880246] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1210]: CREATE FUNCTION
server # [  137.889816] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1210]: CREATE FUNCTION
server # [  137.890793] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1210]: DROP EVENT TRIGGER
server # [  137.900142] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1210]: CREATE EVENT TRIGGER
server # [  137.907429] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1210]: DROP EVENT TRIGGER
server # [  137.914374] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1210]: CREATE EVENT TRIGGER
server # [  137.922067] postgres[1211]: ::1 2026-10-31 19:39:10.368 UTC [1211] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;
server # [  137.930305] postgres[1211]: ::1 2026-10-31 19:39:10.383 UTC [1211] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_drop_watch
server # [  137.931306] postgres[1211]: 	  ON sql_drop
server # [  137.931740] postgres[1211]: 	  EXECUTE PROCEDURE extensions.pgrst_drop_watch();
server # [  137.934325] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql
server # [  138.075623] postgres[1213]: ::1 2026-10-31 19:39:10.747 UTC [1213] supabase_admin@postgres LOG:  statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;
server # [  138.105176] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1212]: ALTER ROLE
server # [  138.145321] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql
server # [  138.446496] postgres[1215]: ::1 2026-10-31 19:39:11.104 UTC [1215] supabase_admin@postgres LOG:  statement: create or replace function extensions.grant_pg_graphql_access()
server # [  138.453463] postgres[1215]: 	    returns event_trigger
server # [  138.457593] postgres[1215]: 	    language plpgsql
server # [  138.458671] postgres[1215]: 	AS $func$
server # [  138.461730] postgres[1215]: 	DECLARE
server # [  138.465177] postgres[1215]: 	    func_is_graphql_resolve bool;
server # [  138.468958] postgres[1215]: 	BEGIN
server # [  138.474946] postgres[1215]: 	    func_is_graphql_resolve = (
server # [  138.479101] postgres[1215]: 	        SELECT n.proname = 'resolve'
server # [  138.485057] postgres[1215]: 	        FROM pg_event_trigger_ddl_commands() AS ev
server # [  138.494674] postgres[1215]: 	        LEFT JOIN pg_catalog.pg_proc AS n
server # [  138.498508] postgres[1215]: 	        ON ev.objid = n.oid
server # [  138.503382] postgres[1215]: 	    );
server # [  138.505816] postgres[1215]:
server # [  138.508928] postgres[1215]: 	    IF func_is_graphql_resolve
server # [  138.510328] postgres[1215]: 	    THEN
server # [  138.511534] postgres[1215]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;
server # [  138.513939] postgres[1215]: 	        grant all on function graphql.resolve to postgres, anon, authenticated, service_role;
server # [  138.514964] postgres[1215]:
server # [  138.515647] postgres[1215]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;
server # [  138.518204] postgres[1215]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;
server # [  138.519649] postgres[1215]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;
server # [  138.522206] postgres[1215]:
server # [  138.523740] postgres[1215]: 	        -- Update public wrapper to pass all arguments through to the pg_graphql resolve func
server # [  138.525961] postgres[1215]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;
server # [  138.528833] postgres[1215]: 	        create or replace function graphql_public.graphql(
server # [  138.530952] postgres[1215]: 	            "operationName" text default null,
server # [  138.533870] postgres[1215]: 	            query text default null,
server # [  138.537151] postgres[1215]: 	            variables jsonb default null,
server # [  138.538458] postgres[1215]: 	            extensions jsonb default null
server # [  138.539436] postgres[1215]: 	        )
server # [  138.541491] postgres[1215]: 	            returns jsonb
server # [  138.542669] postgres[1215]: 	            language sql
server # [  138.543395] postgres[1215]: 	        as $$
server # [  138.545057] postgres[1215]: 	            -- This changed
server # [  138.547336] postgres[1215]: 	            select graphql.resolve(
server # [  138.550478] postgres[1215]: 	                query := query,
server # [  138.553910] postgres[1215]: 	                variables := coalesce(variables, '{}'),
server # [  138.555864] postgres[1215]: 	                "operationName" := "operationName",
server # [  138.559062] postgres[1215]: 	                extensions := extensions
server # [  138.563027] postgres[1215]: 	            );
server # [  138.564144] postgres[1215]: 	        $$;
server # [  138.565391] postgres[1215]:
server # [  138.567305] postgres[1215]: 	        grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;
server # [  138.569618] postgres[1215]: 	    END IF;
server # [  138.571476] postgres[1215]:
server # [  138.574631] postgres[1215]: 	END;
server # [  138.577058] postgres[1215]: 	$func$;
server # [  138.581917] postgres[1215]: ::1 2026-10-31 19:39:11.183 UTC [1215] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()
server # [  138.589074] postgres[1215]: 	RETURNS event_trigger
server # [  138.590525] postgres[1215]: 	LANGUAGE plpgsql
server # [  138.593695] postgres[1215]: 	AS $func$
server # [  138.597969] postgres[1215]: 	    DECLARE
server # [  138.605549] postgres[1215]: 	    graphql_is_dropped bool;
server # [  138.607780] postgres[1215]: 	    BEGIN
server # [  138.613707] postgres[1215]: 	    graphql_is_dropped = (
server # [  138.618373] postgres[1215]: 	        SELECT ev.schema_name = 'graphql_public'
server # [  138.623383] postgres[1215]: 	        FROM pg_event_trigger_dropped_objects() AS ev
server # [  138.627572] postgres[1215]: 	        WHERE ev.schema_name = 'graphql_public'
server # [  138.631823] postgres[1215]: 	    );
server # [  138.636180] postgres[1215]:
server # [  138.637867] postgres[1215]: 	    IF graphql_is_dropped
server # [  138.641804] postgres[1215]: 	    THEN
server # [  138.646926] postgres[1215]: 	        create or replace function graphql_public.graphql(
server # [  138.649919] postgres[1215]: 	            "operationName" text default null,
server # [  138.654100] postgres[1215]: 	            query text default null,
server # [  138.656040] postgres[1215]: 	            variables jsonb default null,
server # [  138.658104] postgres[1215]: 	            extensions jsonb default null
server # [  138.659762] postgres[1215]: 	        )
server # [  138.662287] postgres[1215]: 	            returns jsonb
server # [  138.665174] postgres[1215]: 	            language plpgsql
server # [  138.667149] postgres[1215]: 	        as $$
server # [  138.669161] postgres[1215]: 	            DECLARE
server # [  138.671223] postgres[1215]: 	                server_version float;
server # [  138.674984] postgres[1215]: 	            BEGIN
server # [  138.678491] postgres[1215]: 	                server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);
server # [  138.681240] postgres[1215]:
server # [  138.683574] postgres[1215]: 	                IF server_version >= 14 THEN
server # [  138.688858] postgres[1215]: 	                    RETURN jsonb_build_object(
server # [  138.690209] postgres[1215]: 	                        'errors', jsonb_build_array(
server # [  138.695618] postgres[1215]: 	                            jsonb_build_object(
server # [  138.698382] postgres[1215]: 	                                'message', 'pg_graphql extension is not enabled.'
server # [  138.701680] postgres[1215]: 	                            )
server # [  138.706256] postgres[1215]: 	                        )
server # [  138.711154] postgres[1215]: 	                    );
server # [  138.715174] postgres[1215]: 	                ELSE
server # [  138.719000] postgres[1215]: 	                    RETURN jsonb_build_object(
server # [  138.724532] postgres[1215]: 	                        'errors', jsonb_build_array(
server # [  138.728961] postgres[1215]: 	                            jsonb_build_object(
server # [  138.730877] postgres[1215]: 	                                'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'
server # [  138.734845] postgres[1215]: 	                            )
server # [  138.738582] postgres[1215]: 	                        )
server # [  138.743397] postgres[1215]: 	                    );
server # [  138.747888] postgres[1215]: 	                END IF;
server # [  138.749651] postgres[1215]: 	            END;
server # [  138.751301] postgres[1215]: 	        $$;
server # [  138.754646] postgres[1215]: 	    END IF;
server # [  138.756944] postgres[1215]:
server # [  138.760013] postgres[1215]: 	    END;
server # [  138.766656] postgres[1215]: 	$func$;
server # [  138.770749] postgres[1215]: ::1 2026-10-31 19:39:11.218 UTC [1215] supabase_admin@postgres LOG:  statement: create or replace function graphql_public.graphql(
server # [  138.773866] postgres[1215]: 	    "operationName" text default null,
server # [  138.778575] postgres[1215]: 	    query text default null,
server # [  138.781270] postgres[1215]: 	    variables jsonb default null,
server # [  138.799418] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1214]: CREATE FUNCTION
server # [  138.803142] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1214]: CREATE FUNCTION
server # [  138.806364] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1214]: CREATE FUNCTION
server # [  138.810392] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1214]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE:  extension "pg_graphql" does not exist, skipping
server # [  138.813115] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1214]: DROP EXTENSION
server # [  138.815423] postgres[1215]: 	    extensions jsonb default null
server # [  138.818668] postgres[1215]: 	)
server # [  138.819932] postgres[1215]: 	    returns jsonb
server # [  138.822371] postgres[1215]: 	    language plpgsql
server # [  138.826039] postgres[1215]: 	as $$
server # [  138.827453] postgres[1215]: 	    DECLARE
server # [  138.830538] postgres[1215]: 	        server_version float;
server # [  138.832806] postgres[1215]: 	    BEGIN
server # [  138.835659] postgres[1215]: 	        server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);
server # [  138.845482] postgres[1215]:
server # [  138.847952] postgres[1215]: 	        IF server_version >= 14 THEN
server # [  138.861648] postgres[1215]: 	            RETURN jsonb_build_object(
server # [  138.866811] postgres[1215]: 	                'errors', jsonb_build_array(
server # [  138.879948] postgres[1215]: 	                    jsonb_build_object(
server # [  138.891672] postgres[1215]: 	                        'message', 'pg_graphql extension is not enabled.'
server # [  138.898592] postgres[1215]: 	                    )
server # [  138.908170] postgres[1215]: 	                )
server # [  138.913585] postgres[1215]: 	            );
server # [  138.926981] postgres[1215]: 	        ELSE
server # [  138.940043] postgres[1215]: 	            RETURN jsonb_build_object(
server # [  138.950803] postgres[1215]: 	                'errors', jsonb_build_array(
server # [  138.961927] postgres[1215]: 	                    jsonb_build_object(
server # [  138.973575] postgres[1215]: 	                        'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'
server # [  138.984934] postgres[1215]: 	                    )
server # [  138.995876] postgres[1215]: 	                )
server # [  139.003344] postgres[1215]: 	            );
server # [  139.019143] postgres[1215]: 	        END IF;
server # [  139.030406] postgres[1215]: 	    END;
server # [  139.040077] postgres[1215]: 	$$;
server # [  139.055580] postgres[1215]: ::1 2026-10-31 19:39:11.265 UTC [1215] supabase_admin@postgres LOG:  statement: drop extension if exists pg_graphql;
server # [  140.660093] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1214]: DO
server # [  140.747444] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql
server # [  140.992075] postgres[1237]: ::1 2026-10-31 19:39:13.659 UTC [1237] supabase_admin@postgres LOG:  statement: grant supabase_auth_admin, supabase_storage_admin to postgres;
server # [  141.017189] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1236]: GRANT ROLE
server # [  141.049242] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql
server # [  141.353973] postgres[1239]: ::1 2026-10-31 19:39:14.020 UTC [1239] supabase_admin@postgres LOG:  statement: create or replace function extensions.grant_pg_graphql_access()
server # [  141.357810] postgres[1239]: 	    returns event_trigger
server # [  141.358975] postgres[1239]: 	    language plpgsql
server # [  141.362715] postgres[1239]: 	AS $func$
server # [  141.363820] postgres[1239]: 	DECLARE
server # [  141.367867] postgres[1239]: 	    func_is_graphql_resolve bool;
server # [  141.372959] postgres[1239]: 	BEGIN
server # [  141.382206] postgres[1239]: 	    func_is_graphql_resolve = (
server # [  141.383631] postgres[1239]: 	        SELECT n.proname = 'resolve'
server # [  141.387510] postgres[1239]: 	        FROM pg_event_trigger_ddl_commands() AS ev
server # [  141.390270] postgres[1239]: 	        LEFT JOIN pg_catalog.pg_proc AS n
server # [  141.392741] postgres[1239]: 	        ON ev.objid = n.oid
server # [  141.394448] postgres[1239]: 	    );
server # [  141.395333] postgres[1239]:
server # [  141.398486] postgres[1239]: 	    IF func_is_graphql_resolve
server # [  141.402190] postgres[1239]: 	    THEN
server # [  141.403379] postgres[1239]: 	        -- Update public wrapper to pass all arguments through to the pg_graphql resolve func
server # [  141.406045] postgres[1239]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;
server # [  141.408038] postgres[1239]: 	        create or replace function graphql_public.graphql(
server # [  141.409922] postgres[1239]: 	            "operationName" text default null,
server # [  141.413995] postgres[1239]: 	            query text default null,
server # [  141.416402] postgres[1239]: 	            variables jsonb default null,
server # [  141.421925] postgres[1239]: 	            extensions jsonb default null
server # [  141.424121] postgres[1239]: 	        )
server # [  141.426760] postgres[1239]: 	            returns jsonb
server # [  141.430369] postgres[1239]: 	            language sql
server # [  141.431318] postgres[1239]: 	        as $$
server # [  141.433888] postgres[1239]: 	            select graphql.resolve(
server # [  141.435509] postgres[1239]: 	                query := query,
server # [  141.436625] postgres[1239]: 	                variables := coalesce(variables, '{}'),
server # [  141.439873] postgres[1239]: 	                "operationName" := "operationName",
server # [  141.444176] postgres[1239]: 	                extensions := extensions
server # [  141.447169] postgres[1239]: 	            );
server # [  141.449376] postgres[1239]: 	        $$;
server # [  141.450889] postgres[1239]:
server # [  141.451754] postgres[1239]: 	        -- This hook executes when `graphql.resolve` is created. That is not necessarily the last
server # [  141.454590] postgres[1239]: 	        -- function in the extension so we need to grant permissions on existing entities AND
server # [  141.457171] postgres[1239]: 	        -- update default permissions to any others that are created after `graphql.resolve`
server # [  141.459322] postgres[1239]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;
server # [  141.461229] postgres[1239]: 	        grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;
server # [  141.462596] postgres[1239]: 	        grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;
server # [  141.465659] postgres[1239]: 	        grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;
server # [  141.467524] postgres[1239]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;
server # [  141.473370] postgres[1239]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;
server # [  141.475892] postgres[1239]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;
server # [  141.480106] postgres[1239]: 	    END IF;
server # [  141.483225] postgres[1239]:
server # [  141.484418] postgres[1239]: 	END;
server # [  141.485993] postgres[1239]: 	$func$;
server # [  141.494102] postgres[1239]: ::1 2026-10-31 19:39:14.107 UTC [1239] supabase_admin@postgres LOG:  statement: drop extension if exists pg_graphql;
server # [  141.507930] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1238]: CREATE FUNCTION
server # [  141.513824] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1238]: DROP EXTENSION
server # [  143.272041] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1238]: DO
server # [  143.356258] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql
server # [  144.508579] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1256]: DO
server # [  145.161779] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1256]: DO
server # [  145.220393] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql
server # [  145.522539] postgres[1263]: ::1 2026-10-31 19:39:18.183 UTC [1263] supabase_admin@postgres LOG:  statement: alter role authenticator set statement_timeout = '8s';
server # [  145.549687] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1262]: ALTER ROLE
server # [  145.589625] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql
server # [  146.067459] postgres[1273]: ::1 2026-10-31 19:39:18.710 UTC [1273] supabase_admin@postgres LOG:  statement: revoke supabase_admin from authenticator;
server # [  146.095928] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1267]: REVOKE ROLE
server # [  146.107593] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql
server # [  148.214040] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1277]: DO
server # [  148.276767] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql
server # [  148.691072] postgres[1294]: ::1 2026-10-31 19:39:21.342 UTC [1294] supabase_admin@postgres LOG:  statement: grant anon, authenticated, service_role to postgres;
server # [  148.739800] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1288]: GRANT ROLE
server # [  148.758483] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  149.240012] postgres[1307]: ::1 2026-10-31 19:39:21.905 UTC [1307] supabase_admin@postgres LOG:  statement: grant all privileges on all tables in schema extensions to postgres with grant option;
server # [  149.293100] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1299]: GRANT
server # [  149.295351] postgres[1307]: ::1 2026-10-31 19:39:21.966 UTC [1307] supabase_admin@postgres LOG:  statement: grant all privileges on all routines in schema extensions to postgres with grant option;
server # [  149.331224] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1299]: GRANT
server # [  149.337203] postgres[1307]: ::1 2026-10-31 19:39:22.013 UTC [1307] supabase_admin@postgres LOG:  statement: grant all privileges on all sequences in schema extensions to postgres with grant option;
server # [  149.343833] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1299]: GRANT
server # [  149.349261] postgres[1307]: ::1 2026-10-31 19:39:22.023 UTC [1307] supabase_admin@postgres LOG:  statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;
server # [  149.374592] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1299]: ALTER DEFAULT PRIVILEGES
server # [  149.375942] postgres[1307]: ::1 2026-10-31 19:39:22.044 UTC [1307] supabase_admin@postgres LOG:  statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;
server # [  149.383109] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1299]: ALTER DEFAULT PRIVILEGES
server # [  149.390187] postgres[1307]: ::1 2026-10-31 19:39:22.062 UTC [1307] supabase_admin@postgres LOG:  statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;
server # [  149.402962] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1299]: ALTER DEFAULT PRIVILEGES
server # [  149.494821] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql
server # [  149.823558] postgres[1314]: ::1 2026-10-31 19:39:22.495 UTC [1314] supabase_admin@postgres LOG:  statement: grant pg_monitor to postgres;
server # [  149.862479] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1312]: GRANT ROLE
server # [  149.885678] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql
server # [  150.231342] postgres[1318]: ::1 2026-10-31 19:39:22.894 UTC [1318] supabase_admin@postgres LOG:  statement: grant anon, authenticated, service_role to supabase_storage_admin;
server # [  150.269594] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1316]: GRANT ROLE
server # [  150.287637] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql
server # [  150.631354] postgres[1320]: ::1 2026-10-31 19:39:23.291 UTC [1320] supabase_admin@postgres LOG:  statement: ALTER ROLE authenticated inherit;
server # [  150.642901] postgres[1320]: ::1 2026-10-31 19:39:23.304 UTC [1320] supabase_admin@postgres LOG:  statement: ALTER ROLE anon inherit;
server # [  150.671055] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1319]: ALTER ROLE
server # [  150.682555] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1319]: ALTER ROLE
server # [  150.686276] postgres[1320]: ::1 2026-10-31 19:39:23.319 UTC [1320] supabase_admin@postgres LOG:  statement: ALTER ROLE service_role inherit;
server # [  150.699796] systemd[1]: Starting Virtual Console Setup...
server # [  150.715348] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1319]: ALTER ROLE
server # [  150.730351] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1319]: DO
server # [  150.777769] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql
server # [  150.999181] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [  151.007919] systemd[1]: Stopped Virtual Console Setup.
server # [  151.076032] systemd[1]: Starting Virtual Console Setup...
server # [  151.168500] postgres[1324]: ::1 2026-10-31 19:39:23.836 UTC [1324] supabase_admin@postgres LOG:  statement: grant authenticator to supabase_storage_admin;
server # [  151.199424] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1322]: GRANT ROLE
server # [  151.210711] postgres[1324]: ::1 2026-10-31 19:39:23.860 UTC [1324] supabase_admin@postgres LOG:  statement: revoke anon, authenticated, service_role from supabase_storage_admin;
server # [  151.214418] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1322]: REVOKE ROLE
server # [  151.248843] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql
server # [  151.680371] postgres[1327]: ::1 2026-10-31 19:39:24.343 UTC [1327] supabase_admin@postgres LOG:  statement: create or replace function extensions.grant_pg_graphql_access()
server # [  151.686346] postgres[1327]: 	    returns event_trigger
server # [  151.690366] postgres[1327]: 	    language plpgsql
server # [  151.706138] postgres[1327]: 	AS $func$
server # [  151.714230] postgres[1327]: 	DECLARE
server # [  151.717563] postgres[1327]: 	    func_is_graphql_resolve bool;
server # [  151.721638] postgres[1327]: 	BEGIN
server # [  151.735161] postgres[1327]: 	    func_is_graphql_resolve = (
server # [  151.738309] postgres[1327]: 	        SELECT n.proname = 'resolve'
server # [  151.747369] postgres[1327]: 	        FROM pg_event_trigger_ddl_commands() AS ev
server # [  151.752215] postgres[1327]: 	        LEFT JOIN pg_catalog.pg_proc AS n
server # [  151.758073] postgres[1327]: 	        ON ev.objid = n.oid
server # [  151.766072] postgres[1327]: 	    );
server # [  151.774203] postgres[1327]:
server # [  151.779705] postgres[1327]: 	    IF func_is_graphql_resolve
server # [  151.789695] postgres[1327]: 	    THEN
server # [  151.791805] postgres[1327]: 	        -- Update public wrapper to pass all arguments through to the pg_graphql resolve func
server # [  151.800237] postgres[1327]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;
server # [  151.818292] postgres[1327]: 	        create or replace function graphql_public.graphql(
server # [  151.830798] postgres[1327]: 	            "operationName" text default null,
server # [  151.842632] postgres[1327]: 	            query text default null,
server # [  151.851274] postgres[1327]: 	            variables jsonb default null,
server # [  151.855674] postgres[1327]: 	            extensions jsonb default null
server # [  151.871784] postgres[1327]: 	        )
server # [  151.874764] postgres[1327]: 	            returns jsonb
server # [  151.877810] postgres[1327]: 	            language sql
server # [  151.879279] postgres[1327]: 	        as $$
server # [  151.885678] postgres[1327]: 	            select graphql.resolve(
server # [  151.907099] postgres[1327]: 	                query := query,
server # [  151.913604] postgres[1327]: 	                variables := coalesce(variables, '{}'),
server # [  151.923656] postgres[1327]: 	                "operationName" := "operationName",
server # [  151.931633] postgres[1327]: 	                extensions := extensions
server # [  151.938213] postgres[1327]: 	            );
server # [  151.947667] postgres[1327]: 	        $$;
server # [  151.951780] postgres[1327]:
server # [  151.959165] postgres[1327]: 	        -- This hook executes when `graphql.resolve` is created. That is not necessarily the last
server # [  151.969884] postgres[1327]: 	        -- function in the extension so we need to grant permissions on existing entities AND
server # [  151.978620] postgres[1327]: 	        -- update default permissions to any others that are created after `graphql.resolve`
server # [  151.982593] postgres[1327]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;
server # [  151.985160] postgres[1327]: 	        grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;
server # [  151.986759] postgres[1327]: 	        grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;
server # [  151.999061] postgres[1327]: 	        grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;
server # [  152.008893] postgres[1327]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;
server # [  152.018107] postgres[1327]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;
server # [  152.019833] postgres[1327]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;
server # [  152.029808] postgres[1327]:
server # [  152.038445] postgres[1327]: 	        -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles
server # [  152.052949] postgres[1327]: 	        grant usage on schema graphql_public to postgres with grant option;
server # [  152.054772] postgres[1327]: 	        grant usage on schema graphql to postgres with grant option;
server # [  152.055744] postgres[1327]: 	    END IF;
server # [  152.057858] postgres[1327]:
server # [  152.059385] postgres[1327]: 	END;
server # [  152.067894] postgres[1327]: 	$func$;
server # [  152.077223] postgres[1327]: ::1 2026-10-31 19:39:24.544 UTC [1327] supabase_admin@postgres LOG:  statement: drop extension if exists pg_graphql;
server # [  152.097914] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1326]: CREATE FUNCTION
server # [  152.103026] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1326]: DROP EXTENSION
server # [  154.395966] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1326]: DO
server # [  154.478009] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql
server # [  155.038664] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1348]: DO
server # [  155.070131] postgres[1349]: ::1 2026-10-31 19:39:27.703 UTC [1349] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger
server # [  155.078275] postgres[1349]: 	    LANGUAGE plpgsql
server # [  155.085215] postgres[1349]: 	    AS $$
server # [  155.087443] postgres[1349]: 	BEGIN
server # [  155.094014] postgres[1349]: 	  IF EXISTS (
server # [  155.102908] postgres[1349]: 	    SELECT
server # [  155.104686] postgres[1349]: 	    FROM pg_event_trigger_ddl_commands() AS ev
server # [  155.109676] postgres[1349]: 	    JOIN pg_extension AS ext
server # [  155.117855] postgres[1349]: 	    ON ev.objid = ext.oid
server # [  155.126061] postgres[1349]: 	    WHERE ext.extname = 'pg_cron'
server # [  155.127716] postgres[1349]: 	  )
server # [  155.134470] postgres[1349]: 	  THEN
server # [  155.137983] postgres[1349]: 	    grant usage on schema cron to postgres with grant option;
server # [  155.146225] postgres[1349]:
server # [  155.149090] postgres[1349]: 	    alter default privileges in schema cron grant all on tables to postgres with grant option;
server # [  155.158331] postgres[1349]: 	    alter default privileges in schema cron grant all on functions to postgres with grant option;
server # [  155.164803] postgres[1349]: 	    alter default privileges in schema cron grant all on sequences to postgres with grant option;
server # [  155.173013] postgres[1349]:
server # [  155.180430] postgres[1349]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  155.191170] postgres[1349]: 	        on sequences to postgres with grant option;
server # [  155.194413] postgres[1349]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  155.195387] postgres[1349]: 	        on tables to postgres with grant option;
server # [  155.200744] postgres[1349]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  155.209918] postgres[1349]: 	        on functions to postgres with grant option;
server # [  155.212827] postgres[1349]:
server # [  155.217617] postgres[1349]: 	    grant all privileges on all tables in schema cron to postgres with grant option;
server # [  155.226343] postgres[1349]: 	    revoke all on table cron.job from postgres;
server # [  155.233590] postgres[1349]: 	    grant select on table cron.job to postgres with grant option;
server # [  155.247191] postgres[1349]: 	  END IF;
server # [  155.254944] postgres[1349]: 	END;
server # [  155.257943] postgres[1349]: 	$$;
server # [  155.261908] postgres[1349]: ::1 2026-10-31 19:39:27.859 UTC [1349] supabase_admin@postgres LOG:  statement: drop event trigger if exists issue_pg_cron_access;
server # [  155.270116] postgres[1349]: ::1 2026-10-31 19:39:27.880 UTC [1349] supabase_admin@postgres LOG:  statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;
server # [  155.271296] postgres[1349]: ::1 2026-10-31 19:39:27.914 UTC [1349] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end
server # [  155.272066] postgres[1349]: 	         WHEN TAG IN ('CREATE EXTENSION')
server # [  155.281223] postgres[1349]: 	   EXECUTE FUNCTION extensions.grant_pg_cron_access();
server # [  155.285407] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1348]: CREATE FUNCTION
server # [  155.292975] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1348]: DROP EVENT TRIGGER
server # [  155.298830] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1348]: ALTER FUNCTION
server # [  155.305085] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1348]: CREATE EVENT TRIGGER
server # [  155.321316] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql
server # [  156.041619] postgres[1351]: ::1 2026-10-31 19:39:28.696 UTC [1351] supabase_admin@postgres LOG:  statement: ALTER ROLE authenticator set lock_timeout to '8s';
server # [  156.077272] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1350]: ALTER ROLE
server # [  156.198856] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql
server # [  156.598055] postgres[1353]: ::1 2026-10-31 19:39:29.248 UTC [1353] supabase_admin@postgres LOG:  statement: alter function pg_catalog.lo_export owner to supabase_admin;
server # [  156.650457] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1352]: ALTER FUNCTION
server # [  156.661353] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1352]: ALTER FUNCTION
server # [  156.673646] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1352]: ALTER FUNCTION
server # [  156.687264] postgres[1353]: ::1 2026-10-31 19:39:29.314 UTC [1353] supabase_admin@postgres LOG:  statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;
server # [  156.705655] postgres[1353]: ::1 2026-10-31 19:39:29.319 UTC [1353] supabase_admin@postgres LOG:  statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;
server # [  156.719426] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql
server # [  156.971379] systemd-vconsole-setup[1325]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [  157.048415] systemd[1]: Finished Virtual Console Setup.
server # [  157.211573] postgres[1356]: ::1 2026-10-31 19:39:29.863 UTC [1356] supabase_admin@postgres LOG:  statement: grant pg_read_all_data, pg_signal_backend to postgres;
server # [  157.281570] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1354]: GRANT ROLE
server # [  157.311849] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql
server # [  158.550832] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [  158.623731] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1362]: DO
server # [  158.687213] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql
server # [  159.042116] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1379]: DO
server # [  159.054687] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1379]: DO
server # [  159.110673] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql
server # [  159.403339] postgres[1382]: ::1 2026-10-31 19:39:32.069 UTC [1382] supabase_admin@postgres LOG:  statement: alter role supabase_admin set log_statement = none;
server # [  159.418365] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1381]: ALTER ROLE
server # [  159.423764] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1381]: ALTER ROLE
server # [  159.427254] postgres[1382]: ::1 2026-10-31 19:39:32.089 UTC [1382] supabase_admin@postgres LOG:  statement: alter role supabase_auth_admin set log_statement = none;
server # [  159.429094] postgres[1382]: ::1 2026-10-31 19:39:32.098 UTC [1382] supabase_admin@postgres LOG:  statement: alter role supabase_storage_admin set log_statement = none;
server # [  159.435885] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1381]: ALTER ROLE
server # [  159.478037] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql
server # [  159.836940] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1383]: DO
server # [  159.891187] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql
server # [  160.407048] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1385]: DO
server # [  160.429785] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql
server # [  160.960773] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1397]: CREATE FUNCTION
server # [  160.967914] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1397]: DO
server # [  161.008242] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql
server # [  161.235719] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1409]: ALTER FUNCTION
server # [  161.250176] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1409]: GRANT
server # [  161.294295] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql
server # [  161.524562] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1411]: DROP EVENT TRIGGER
server # [  161.566458] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1411]: ALTER FUNCTION
server # [  161.575195] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1411]: CREATE EVENT TRIGGER
server # [  161.612503] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql
server # [  161.837801] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1413]: DO
server # [  161.886238] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql
server # [  162.183168] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1415]: CREATE FUNCTION
server # [  162.194553] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1415]: GRANT
server # [  162.228985] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql
server # [  162.509537] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1417]: REVOKE ROLE
server # [  162.552462] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1417]: DO
server # [  162.598036] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1417]: DO
server # [  162.599461] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1417]: REVOKE ROLE
server # [  162.628816] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1417]: REVOKE
server # [  162.671672] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1417]: DO
server # [  162.724677] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql
server # [  163.143303] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1425]: DO
server # [  163.204794] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql
server # [  163.635142] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1436]: DO
server # [  163.674378] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql
server # [  164.015646] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1443]: DO
server # [  164.058359] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql
server # [  164.388028] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1445]: ALTER ROLE
server # [  164.451452] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql
server # [  164.703951] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1447]: GRANT ROLE
server # [  164.725454] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1447]: DO
server # [  164.769703] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql
server # [  165.010714] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1449]: GRANT
server # [  165.038529] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql
server # [  165.324361] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1451]: CREATE FUNCTION
server # [  165.333958] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1451]: REVOKE
server # [  165.344107] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1451]: REVOKE
server # [  165.357598] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1451]: GRANT
server # [  165.398319] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql
server # [  165.687145] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1453]: DO
server # [  165.715613] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql
server # [  166.123351] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1460]: ALTER ROLE
server # [  166.179319] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql
server # [  166.551565] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1471]: DROP EXTENSION
server # [  166.586394] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql
server # [  166.926700] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
server # [  167.135214] 8021q: 802.1Q VLAN Support v1.8
server # [  167.080173] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1480]: CREATE FUNCTION
server # [  167.101087] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1480]: DROP EVENT TRIGGER
server # [  167.118769] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1480]: CREATE EVENT TRIGGER
server # [  167.198302] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql
server # [  167.629527] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1484]: DO
server # [  167.659574] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1484]: CREATE FUNCTION
server # [  167.717033] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql
server # [  168.112494] cfg80211: Loading compiled-in X.509 certificates for regulatory database
server # [  168.468070] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
server # [  168.469010] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
server # [  168.386303] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1486]: CREATE FUNCTION
server # [  168.516504] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
server # [  168.517080] cfg80211: failed to load regulatory.db
server # [  168.414142] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1486]: CREATE FUNCTION
server # [  168.495833] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql
server # [  168.804567] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1492]: CREATE FUNCTION
server # [  168.818676] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1492]: CREATE FUNCTION
server # [  168.832247] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1492]: CREATE FUNCTION
server # [  168.848050] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1492]: CREATE FUNCTION
server # [  168.861403] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1492]: CREATE FUNCTION
server # [  168.872922] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1492]: CREATE FUNCTION
server # [  168.920924] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Running postgresql schema...
server # [  169.188745] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER DATABASE
server # [  169.198446] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER DATABASE
server # [  169.266804] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER ROLE
server # [  169.327493] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER ROLE
server # [  169.395650] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER ROLE
server # [  169.462455] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER ROLE
server # [  169.533652] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER ROLE
server # [  169.623273] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER ROLE
server # [  169.730122] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER ROLE
server # [  169.835075] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER ROLE
server # [  169.942301] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER ROLE
server # [  169.961009] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1494]: ALTER ROLE
server # [  170.032021] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1066]: Database initialization complete
server # [  170.082939] systemd[1]: Finished Supabase Database Initialization.
server # [  170.169306] (udev-worker)[1498]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [  170.186929] (udev-worker)[1498]: Network interface NamePolicy= disabled on kernel command line.
server # [  170.341520] (udev-worker)[1497]: Network interface NamePolicy= disabled on kernel command line.
server # [  170.838300] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
server # [  170.932885] systemd[1]: Started backdoor.service.
server # [  170.942631] systemd[1]: Reached target Multi-User System.
server # [  170.986823] systemd[1]: Startup finished in 2.480s (kernel) + 26.246s (initrd) + 2min 22.247s (userspace) = 2min 50.974s.
server # [  171.299305] systemd[1]: Condition check resulted in Virtio network device being skipped.
server # [  171.419206] systemd[1]: Starting Address configuration of eth1...
server # connecting to host...
server: Guest shell says: b'Spawning backdoor root shell...\n'
server: connected to guest root shell
server: (connecting took 173.53 seconds)
server: (finished: waiting for the VM to finish booting, in 173.53 seconds)
server # [  172.635786] 8021q: adding VLAN 0 to HW filter on device eth1
server # [  172.854577] network-addresses-eth1-start[1522]: adding address 192.168.1.1/24... done
server # [  173.091097] network-addresses-eth1-start[1522]: adding address 2001:db8:1::1/64... done
server # [  173.231215] 8021q: adding VLAN 0 to HW filter on device eth0
server # [  173.140067] dhcpcd[748]: eth0: waiting for carrier
server # [  173.323573] systemd[1]: Finished Address configuration of eth1.
server # [  173.549052] dhcpcd[748]: eth0: carrier acquired
server # [  173.763533] dhcpcd[748]: DUID 00:01:00:01:32:79:00:82:52:54:00:12:34:56
server # [  173.770340] dhcpcd[748]: eth0: IAID 00:12:34:56
server # [  173.774544] dhcpcd[748]: eth0: adding address fe80::5054:ff:fe12:3456
server: (finished: waiting for unit supabase-db-init.service, in 175.09 seconds)
subtest: Preconditions
server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select rolsuper from pg_roles where rolname = 'postgres'"
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select rolsuper from pg_roles where rolname = 'postgres'", in 0.51 seconds)
server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select current_user"
server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select current_user", in 0.49 seconds)
(finished: subtest: Preconditions, in 0.99 seconds)
subtest: A non-superuser installs amcheck on PG 15, pinned to pg_catalog
server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension amcheck"
server # [  175.355309] dhcpcd[748]: eth0: soliciting a DHCP lease
server # [  175.376642] dhcpcd[748]: eth0: offered 10.0.2.15 from 10.0.2.2
server # [  175.395672] dhcpcd[748]: eth0: probing address 10.0.2.15/24
server # [  176.285707] dhcpcd[748]: eth0: soliciting an IPv6 router
server # [  176.305660] dhcpcd[748]: eth0: Router Advertisement from fe80::2
server # [  176.307793] dhcpcd[748]: eth0: adding address fec0::5054:ff:fe12:3456/64
server # [  176.323945] dhcpcd[748]: eth0: adding route to fec0::/64
server # [  176.330758] dhcpcd[748]: eth0: adding default route via fe80::2
server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension amcheck", in 1.72 seconds)
server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'"
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'", in 0.45 seconds)
PG 15 amcheck: 1.3,pg_catalog
(finished: subtest: A non-superuser installs amcheck on PG 15, pinned to pg_catalog, in 2.17 seconds)
subtest: PG 15 grants reach postgres only
server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname"
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname", in 0.43 seconds)
(finished: subtest: PG 15 grants reach postgres only, in 0.43 seconds)
subtest: amcheck dropped before upgrade, mirroring EXTENSIONS_TO_DISABLE
server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "drop extension if exists amcheck cascade"
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "drop extension if exists amcheck cascade", in 0.38 seconds)
(finished: subtest: amcheck dropped before upgrade, mirroring EXTENSIONS_TO_DISABLE, in 0.38 seconds)
subtest: switch to postgresql 17
server # Checking switch inhibitors... done
server # [  180.534542] dhcpcd[748]: eth0: leased 10.0.2.15 for 86400 seconds
server # [  180.540959] dhcpcd[748]: eth0: adding route to 10.0.2.0/24
server # [  180.542466] dhcpcd[748]: eth0: adding default route via 10.0.2.2
server # [  184.499846] systemd-logind[590]: Watching system buttons on /dev/input/event0 (gpio-keys)
server # stopping the following units: postgresql.service, supabase-db-init.service
server # [  186.683428] nixos[1603]: switching to system configuration /nix/store/0fijgca9xv0lg145j2mb8cmjiicqp59y-nixos-system-server-test
server # [  186.731338] systemd[1]: supabase-db-init.service: Deactivated successfully.
server # [  186.743907] systemd[1]: Stopped Supabase Database Initialization.
server # [  186.763100] postgres[1030]:  2026-10-31 19:39:59.411 UTC [1030] LOG:  received fast shutdown request
server # [  186.808363] systemd[1]: supabase-db-init.service: Consumed 8.269s CPU time over 1min 7.090s wall clock time, 3.9M memory peak, 90.1K incoming IP traffic, 131K outgoing IP traffic.
server # [  186.852493] postgres[1030]:  2026-10-31 19:39:59.445 UTC [1030] LOG:  aborting any active transactions
server # [  186.856549] systemd[1]: Stopping PostgreSQL Database Server...
server # [  186.890644] postgres[1063]:  2026-10-31 19:39:59.447 UTC [1063] LOG:  pg_cron scheduler shutting down
server # [  186.939268] systemd[1]: Stopped target Local File Systems.
server # [  186.971565] postgres[1061]:  2026-10-31 19:39:59.447 UTC [1061] FATAL:  terminating background worker "TimescaleDB Background Worker Launcher" due to administrator command
server # [  186.985165] postgres[1030]:  2026-10-31 19:39:59.658 UTC [1030] LOG:  background worker "TimescaleDB Background Worker Launcher" (PID 1061) exited with exit code 1
server # [  186.987108] postgres[1030]:  2026-10-31 19:39:59.659 UTC [1030] LOG:  background worker "pg_cron launcher" (PID 1063) exited with exit code 1
server # [  187.004765] systemd[1]: Stopped target Remote File Systems.
server # [  187.007276] postgres[1030]:  2026-10-31 19:39:59.675 UTC [1030] LOG:  background worker "logical replication launcher" (PID 1064) exited with exit code 1
server # [  187.025683] postgres[1030]:  2026-10-31 19:39:59.699 UTC [1030] LOG:  background worker "pg_net 0.20.4 worker" (PID 1082) exited with exit code 1
server # [  187.047420] postgres[1056]:  2026-10-31 19:39:59.707 UTC [1056] LOG:  shutting down
server # [  187.057545] postgres[1056]:  2026-10-31 19:39:59.730 UTC [1056] LOG:  checkpoint starting: shutdown immediate
server # [  187.525838] postgres[1056]:  2026-10-31 19:40:00.196 UTC [1056] LOG:  checkpoint complete: wrote 256 buffers (1.6%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.166 s, sync=0.200 s, total=0.481 s; sync files=132, longest=0.015 s, average=0.002 s; distance=1891 kB, estimate=1891 kB
server # [  187.722353] postgres[1030]:  2026-10-31 19:40:00.396 UTC [1030] LOG:  database system is shut down
server # [  187.835916] systemd[1]: postgresql.service: Deactivated successfully.
server # [  187.840777] systemd[1]: Stopped PostgreSQL Database Server.
server # [  187.845984] systemd[1]: postgresql.service: Consumed 37.613s CPU time over 1min 46.441s wall clock time, 126.5M memory peak, 45.1M written to disk, 135.4K incoming IP traffic, 94.6K outgoing IP traffic.
server # activating the configuration...
server # [  190.515638] mousedev: PS/2 mouse device common for all mice
server # setting up /etc...
server # [  193.578403] systemd-logind[590]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)
server # [  195.723877] systemd[1]: Reload requested from client PID 1603 ('.switch-to-conf') (unit backdoor.service)...
server # [  195.734116] systemd[1]: Reloading...
server # [  201.999919] systemd[1]: Reloading finished in 6243 ms.
server # restarting sysinit-reactivation.target
server # [  202.400787] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....
server # [  203.958700] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..
server # [  204.002370] systemd[1]: Reached target Reactivate sysinit units.
server # reloading the following units: dbus-broker.service
server # [  204.047522] dbus-broker-launch[588]: Caught SIGHUP, trigger reload.
server # [  204.061222] systemd[1]: Reloading D-Bus System Message Bus...
server # [  204.327629] dbus-broker-launch[588]: Looking up NSS user entry for 'systemd-timesync'...
server # [  204.353566] dbus-broker-launch[588]: NSS returned no entry for 'systemd-timesync'
server # [  204.355683] dbus-broker-launch[588]: Invalid user-name in /nix/store/3sy3r4gcahgjcdbrqqgy512vr53vsq3v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [  204.649219] systemd[1]: Reloaded D-Bus System Message Bus.
server # starting the following units: postgresql.service, supabase-db-init.service
server # [  204.680034] systemd[1]: Reached target Remote File Systems.
server # [  204.735504] systemd[1]: Reached target Local File Systems.
server # [  204.739002] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [  204.779320] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [  204.784525] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [  204.790716] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [  204.799220] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
server # [  204.806428] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
server # [  204.807884] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
server # [  205.069226] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [  208.292706] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [  208.302123] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [  208.303688] systemd[1]: suid-sgid-wrappers.service: Consumed 1.559s CPU time over 3.508s wall clock time, 3.2M memory peak.
server # [  208.346712] systemd[1]: Starting linger-users.service...
server # [  208.399848] systemd[1]: Starting PostgreSQL Major Version Migration...
server # [  208.704966] systemd[1]: linger-users.service: Deactivated successfully.
server # [  208.724000] systemd[1]: Finished linger-users.service.
server # [  208.753012] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1951]: Starting pg_upgrade from 15 to 17
server # [  209.452140] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: The files belonging to this database system will be owned by user "postgres".
server # [  209.458706] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: This user must also own the server process.
server # [  209.506349] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: The database cluster will be initialized with locale "en_US.UTF-8".
server # [  209.507317] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: The default database encoding has accordingly been set to "UTF8".
server # [  209.509216] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: The default text search configuration will be set to "english".
server # [  209.509784] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: Data page checksums are enabled.
server # [  209.510570] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: fixing permissions on existing directory /var/lib/postgresql/data-17 ... ok
server # [  209.511650] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: creating subdirectories ... ok
server # [  209.517056] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: selecting dynamic shared memory implementation ... posix
server # [  210.150024] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: selecting default "max_connections" ... 100
server # [  210.718586] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: selecting default "shared_buffers" ... 128MB
server # [  220.721159] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: selecting default time zone ... UTC
server # [  220.773153] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: creating configuration files ... ok
server # [  224.571105] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: running bootstrap script ... ok
server # [  234.313913] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: performing post-bootstrap initialization ... ok
server # [  237.213918] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: syncing data to disk ... ok
server # [  237.217885] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: initdb: warning: enabling "trust" authentication for local connections
server # [  237.218899] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: 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.
server # [  237.220111] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]: Success. You can now start the database server using:
server # [  237.222310] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1955]:     /nix/store/dk435l1mppbbmm8idkycp5q7p6p1fs68-postgresql-and-plugins-17.11/bin/pg_ctl -D /var/lib/postgresql/data-17 -l logfile start
server # [  243.791632] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Performing Consistency Checks
server # [  243.908629] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: -----------------------------
server # [  243.933347] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking cluster versions                                     ok
server # [  249.358412] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking database user is the install user                    ok
server # [  249.453015] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking database connection settings                         ok
server # [  249.561043] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking for prepared transactions                            ok
server # [  249.562608] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking for contrib/isn with bigint-passing mismatch         ok
server # [  250.677525] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking data type usage                                      ok
server # [  251.237686] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking for not-null constraint inconsistencies              ok
server # [  252.158544] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Creating dump of global objects                               ok
server # [  256.088065] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Creating dump of database schemas                             ok
server # [  261.705363] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking for presence of required libraries                   ok
server # [  261.828898] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking database user is the install user                    ok
server # [  261.967969] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking for prepared transactions                            ok
server # [  261.970178] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking for new cluster tablespace directories               ok
server # [  261.992076] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: If pg_upgrade fails after this point, you must re-initdb the
server # [  262.006355] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: new cluster before continuing.
server # [  262.017020] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Performing Upgrade
server # [  262.019676] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: ------------------
server # [  262.105181] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Setting locale and encoding for new cluster                   ok
server # [  266.163952] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Analyzing all rows in the new cluster                         ok
server # [  267.937208] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Freezing all rows in the new cluster                          ok
server # [  268.270617] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [  268.306340] systemd[1]: Stopped Virtual Console Setup.
server # [  268.317005] systemd[1]: systemd-vconsole-setup.service: Consumed 1.431s CPU time over 1min 57.207s wall clock time, 2.7M memory peak.
server # [  268.320233] systemd[1]: Stopping Virtual Console Setup...
server # [  268.371854] systemd[1]: Starting Virtual Console Setup...
server # [  268.679818] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Deleting files from new pg_xact                               ok
server # [  269.063967] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Copying old pg_xact to new server                             ok
server # [  269.892842] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Setting oldest XID for new cluster                            ok
server # [  272.342156] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Setting next transaction ID and epoch for new cluster         ok
server # [  272.349978] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Deleting files from new pg_multixact/offsets                  ok
server # [  272.553258] systemd-vconsole-setup[2453]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [  272.617836] systemd[1]: Finished Virtual Console Setup.
server # [  272.682298] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Copying old pg_multixact/offsets to new server                ok
server # [  272.689131] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Deleting files from new pg_multixact/members                  ok
server # [  272.982792] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Copying old pg_multixact/members to new server                ok
server # [  273.434157] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Setting next multixact ID and offset for new cluster          ok
server # [  273.805904] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Resetting WAL archives                                        ok
server # [  275.797474] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
server # [  276.126058] systemd-logind[590]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
server # [  277.861843] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Setting frozenxid and minmxid counters in new cluster         ok
server # [  278.876813] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Restoring global objects in the new cluster                   ok
server # [  282.709368] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Restoring database schemas in the new cluster                 ok
server # [  283.625391] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Copying user relation files                                   ok
server # [  283.930869] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Setting next OID for new cluster                              ok
server # [  285.740582] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Sync data directory to disk                                   ok
server # [  285.743771] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Creating script to delete old cluster                         ok
server # [  290.121739] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Checking for extension updates                                notice
server # [  290.126707] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Your installation contains extensions that should be updated
server # [  290.129499] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: with the ALTER EXTENSION command.  The file
server # [  290.130725] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]:     update_extensions.sql
server # [  290.133259] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: when executed by psql by the database superuser will update
server # [  290.135662] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: these extensions.
server # [  290.472609] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Upgrade Complete
server # [  290.475961] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: ----------------
server # [  290.479364] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Optimizer statistics are not transferred by pg_upgrade.
server # [  290.483581] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Once you start the new server, consider running:
server # [  290.487257] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]:     /nix/store/dk435l1mppbbmm8idkycp5q7p6p1fs68-postgresql-and-plugins-17.11/bin/vacuumdb -U supabase_admin --all --analyze-in-stages
server # [  290.491189] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]: Running this script will delete the old cluster's data files:
server # [  290.493614] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[2165]:     ./delete_old_cluster.sh
server # [  290.525863] 3rg9dj71plfqlxivxhnr14jlmflmvi8p-postgresql-migrate[1951]: pg_upgrade completed successfully
server # [  290.550895] systemd[1]: Finished PostgreSQL Major Version Migration.
server # [  290.582378] systemd[1]: Starting PostgreSQL Database Server...
server # [  292.079595] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[2569]: Validating PostgreSQL configuration...
server # [  292.428619] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[2581]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault
server # [  293.101944] postgres[2583]:  2026-10-31 19:41:45.770 UTC [2583] LOG:  pgaudit extension initialized
server # [  293.403379] postgres[2583]:  2026-10-31 19:41:46.078 UTC [2583] LOG:  pgsodium primary server secret key loaded
server # [  293.608741] postgres[2583]:  2026-10-31 19:41:46.284 UTC [2583] LOG:  vault primary server secret key loaded
server # [  293.854794] postgres[2583]:  2026-10-31 19:41:46.530 UTC [2583] LOG:  starting PostgreSQL 17.11 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.3.0, 64-bit
server # [  293.865126] postgres[2583]:  2026-10-31 19:41:46.540 UTC [2583] LOG:  listening on IPv4 address "0.0.0.0", port 5432
server # [  293.870045] postgres[2583]:  2026-10-31 19:41:46.541 UTC [2583] LOG:  listening on IPv6 address "::", port 5432
server # [  293.886902] postgres[2583]:  2026-10-31 19:41:46.562 UTC [2583] LOG:  listening on Unix socket "/run/postgresql/.s.PGSQL.5432"
server # [  293.970144] postgres[2588]:  2026-10-31 19:41:46.638 UTC [2588] LOG:  database system was shut down at 2026-10-31 19:41:42 UTC
server # [  294.099769] postgres[2583]:  2026-10-31 19:41:46.766 UTC [2583] LOG:  database system is ready to accept connections
server # [  294.140031] systemd[1]: Started PostgreSQL Database Server.
server # [  294.194034] postgres[2592]:  2026-10-31 19:41:46.847 UTC [2592] LOG:  pg_cron scheduler started
server # [  294.224950] systemd[1]: Starting Supabase Database Initialization...
server # [  294.498596] systemd[1]: Finished Supabase Database Initialization.
server # the following new units were started: postgresql-migrate.service, sys-devices-virtual-input-mice.device, sys-devices-virtual-misc-rfkill.device, sysinit-reactivation.target, systemd-rfkill.socket, systemd-tmpfiles-resetup.service
server # [  294.800653] nixos[1603]: finished switching to system configuration /nix/store/0fijgca9xv0lg145j2mb8cmjiicqp59y-nixos-system-server-test
server: waiting for unit postgresql.service
server: (finished: waiting for unit postgresql.service, in 0.55 seconds)
(finished: subtest: switch to postgresql 17, in 117.61 seconds)
subtest: amcheck recreated fresh on PG 17, mirroring the EXTENSIONS_TO_DISABLE fix
server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension if not exists amcheck cascade"
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension if not exists amcheck cascade", in 1.27 seconds)
server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select default_version from pg_available_extensions where name = 'amcheck'"
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select default_version from pg_available_extensions where name = 'amcheck'", in 0.89 seconds)
server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'"
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'", in 0.42 seconds)
server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname"
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname", in 0.45 seconds)
(finished: subtest: amcheck recreated fresh on PG 17, mirroring the EXTENSIONS_TO_DISABLE fix, in 3.03 seconds)
subtest: The support workflow still works after the upgrade
server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create table amcheck_heap(i int primary key) using heap; insert into amcheck_heap select generate_series(1, 100)"
server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create table amcheck_heap(i int primary key) using heap; insert into amcheck_heap select generate_series(1, 100)", in 0.49 seconds)
server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass)"
server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass)", in 0.43 seconds)
server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass, false, false)"
server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass, false, false)", in 0.41 seconds)
server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('auth.users_pkey'::regclass)"
server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('auth.users_pkey'::regclass)", in 0.41 seconds)
(finished: subtest: The support workflow still works after the upgrade, in 1.74 seconds)
(finished: run the VM test script, in 301.66 seconds)
test script finished in 302.06s
cleanup
kill QemuMachine (pid 13)
server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/vilynzly1pyhawy04ljmrp7n9ffr24qy-python3-3.13.17/bin/python3.13)
(finished: cleanup, in 0.07 seconds)