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 # Disk image does not exist, creating the virtualisation disk image...
server # Formatting '/build/vm-state-server/tmp.ejNa20Dq3H', fmt=raw size=1073741824
server: QEMU running (pid 13)
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: ee42a145-88f3-45b7-b79e-91c6984c2730
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.31 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.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 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 s186520 r8192 d116584 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/98k940gqfarnmsxiry7yqi1w40453j1m-nixos-system-server-test/init regInfo=/nix/store/zri54rd94whqs6rhkh4bxy69132dqgkr-closure-info/registration console=ttyAMA0,115200n8 console=tty0
server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/store/zri54rd94whqs6rhkh4bxy69132dqgkr-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 74832 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 @100b10000 (indirect, esz 8, psz 64K, shr 1)
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b20000 (flat, esz 8, psz 64K, shr 1)
server # [    0.000000] GICv3: using LPI property table @0x0000000100b30000
server # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b40000
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.000048] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
server # [    0.005239] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.018476] Console: colour dummy device 80x25
server # [    0.020819] printk: legacy console [tty0] enabled
server # [    0.027955] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.029263] pid_max: default: 32768 minimum: 301
server # [    0.032541] LSM: initializing lsm=capability,landlock,yama,bpf,ima
server # [    0.035481] landlock: Up and running.
server # [    0.035573] Yama: becoming mindful.
server # [    0.039632] LSM support for eBPF active
server # [    0.043374] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
server # [    0.043881] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
server # [    0.095241] rcu: Hierarchical SRCU implementation.
server # [    0.095350] rcu: 	Max phase no-delay instances is 1000.
server # [    0.096792] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
server # [    0.105653] fsl-mc MSI: its@8080000 domain created
server # [    0.108248] EFI services will not be available.
server # [    0.110350] smp: Bringing up secondary CPUs ...
server # [    0.117784] Detected PIPT I-cache on CPU1
server # [    0.119488] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000
server # [    0.120173] GICv3: CPU1: using allocated LPI pending table @0x0000000100b50000
server # [    0.122061] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]
server # [    0.126717] smp: Brought up 1 node, 2 CPUs
server # [    0.126904] SMP: Total of 2 processors activated.
server # [    0.126953] CPU: All CPU(s) started at EL1
server # [    0.127157] CPU features: detected: Branch Target Identification
server # [    0.127215] CPU features: detected: 32-bit EL0 Support
server # [    0.127250] CPU features: detected: 32-bit EL1 Support
server # [    0.127283] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.127327] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.127375] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.127439] CPU features: detected: Common not Private translations
server # [    0.127473] CPU features: detected: CRC32 instructions
server # [    0.127498] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.127534] CPU features: detected: Data cache clean to Point of Persistence
server # [    0.127568] CPU features: detected: Data independent timing control (DIT)
server # [    0.127598] CPU features: detected: E0PD
server # [    0.127625] CPU features: detected: Enhanced Counter Virtualization
server # [    0.127656] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
server # [    0.127690] CPU features: detected: Enhanced Privileged Access Never
server # [    0.127722] CPU features: detected: Enhanced Virtualization Traps
server # [    0.127754] CPU features: detected: Fine Grained Traps
server # [    0.127785] CPU features: detected: Guarded Control Stack (GCS)
server # [    0.127857] CPU features: detected: Generic authentication (IMP DEF algorithm)
server # [    0.127952] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.128011] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)
server # [    0.128045] CPU features: detected: LSE atomic instructions
server # [    0.128073] CPU features: detected: Memory Copy and Memory Set instructions
server # [    0.128107] CPU features: detected: Privileged Access Never
server # [    0.128158] CPU features: detected: PMUv3
server # [    0.128185] CPU features: detected: SCTLR2
server # [    0.128209] CPU features: detected: RAS Extension Support
server # [    0.128279] CPU features: detected: RASv1p1 Extension Support
server # [    0.128311] CPU features: detected: Random Number Generator
server # [    0.128338] CPU features: detected: Speculation barrier (SB)
server # [    0.128363] CPU features: detected: Stage-2 Force Write-Back
server # [    0.128388] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality
server # [    0.128418] CPU features: detected: TLB range maintenance instructions
server # [    0.128445] CPU features: detected: WFx with timeout
server # [    0.128521] CPU features: detected: Scalable Matrix Extension
server # [    0.128559] CPU features: detected: FA64
server # [    0.128582] CPU features: detected: SME2
server # [    0.128604] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.128632] CPU features: detected: Scalable Vector Extension
server # [    0.136282] alternatives: applying system-wide alternatives
server # [    0.153576] CPU features: detected: Hardware dirty bit management on CPU0-1
server # [    0.154354] SVE: maximum available vector length 256 bytes per vector
server # [    0.154450] SVE: default vector length 64 bytes per vector
server # [    0.155732] SME: minimum available vector length 16 bytes per vector
server # [    0.156621] SME: maximum available vector length 256 bytes per vector
server # [    0.156672] SME: default vector length 32 bytes per vector
server # [    0.173683] Memory: 3904032K/4194304K available (24320K kernel code, 7090K rwdata, 26572K rodata, 4736K init, 1103K bss, 241772K reserved, 32768K cma-reserved)
server # [    0.200814] devtmpfs: initialized
server # [    0.238113] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear)
server # [    0.238451] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear).
server # [    0.241787] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
server # [    0.241887] 0 pages in range for non-PLT usage
server # [    0.241946] 508272 pages in range for PLT usage
server # [    0.244836] pinctrl core: initialized pinctrl subsystem
server # [    0.256781] DMI not present or invalid.
server # [    0.279343] NET: Registered PF_NETLINK/PF_ROUTE protocol family
server # [    0.294451] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
server # [    0.296364] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.297687] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
server # [    0.297998] audit: initializing netlink subsys (disabled)
server # [    0.300239] audit: type=2000 audit(0.236:1): state=initialized audit_enabled=0 res=1
server # [    0.309250] thermal_sys: Registered thermal governor 'fair_share'
server # [    0.309327] thermal_sys: Registered thermal governor 'bang_bang'
server # [    0.309404] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.309442] thermal_sys: Registered thermal governor 'user_space'
server # [    0.309477] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.310432] cpuidle: using governor ladder
server # [    0.311173] cpuidle: using governor menu
server # [    0.313651] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
server # [    0.314603] ASID allocator initialised with 65536 entries
server # [    0.324038] Serial: AMBA PL011 UART driver
server # [    0.395917] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
server # [    0.399390] printk: console [ttyAMA0] enabled
server # [    0.476333] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.476822] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
server # [    0.476908] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
server # [    0.476946] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
server # [    0.477098] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
server # [    0.477205] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
server # [    0.477278] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
server # [    0.477384] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
server # [    0.495577] fbcon: Taking over console
server # [    0.495876] ACPI: Interpreter disabled.
server # [    0.507792] iommu: Default domain type: Translated
server # [    0.507895] iommu: DMA domain TLB invalidation policy: strict mode
server # [    0.520862] SCSI subsystem initialized
server # [    0.523978] usbcore: registered new interface driver usbfs
server # [    0.524244] usbcore: registered new interface driver hub
server # [    0.524430] usbcore: registered new device driver usb
server # [    0.527393] pps_core: LinuxPPS API ver. 1 registered
server # [    0.527464] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    0.527575] PTP clock support registered
server # [    0.527906] EDAC MC: Ver: 3.0.0
server # [    0.534314] scmi_core: SCMI protocol bus registered
server # [    0.538257] FPGA manager framework
server # [    0.554904] vgaarb: loaded
server # [    0.562496] clocksource: Switched to clocksource arch_sys_counter
server # [    0.591018] VFS: Disk quotas dquot_6.6.0
server # [    0.591258] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    0.593876] netfs: FS-Cache loaded
server # [    0.595694] pnp: PnP ACPI: disabled
server # [    0.675212] NET: Registered PF_INET protocol family
server # [    0.676501] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
server # [    0.803481] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
server # [    0.803715] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
server # [    0.803872] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
server # [    0.804340] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
server # [    0.804729] TCP: Hash tables configured (established 32768 bind 32768)
server # [    0.809593] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)
server # [    0.811962] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)
server # [    0.812369] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)
server # [    0.814881] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    0.815455] NET: Registered PF_XDP protocol family
server # [    0.815665] PCI: CLS 0 bytes, default 64
server # [    0.818476] kvm [1]: HYP mode not available
server # [    0.823012] Trying to unpack rootfs image as initramfs...
server # [    0.996622] Initialise system trusted keyrings
server # [    1.000739] workingset: timestamp_bits=42 max_order=20 bucket_order=0
server # [    1.012186] squashfs: version 4.0 (2009/01/31) Phillip Lougher
server # [    1.014761] 9p: Installing v9fs 9p2000 file system support
server # [    1.085969] Key type asymmetric registered
server # [    1.087154] Asymmetric key parser 'x509' registered
server # [    1.087650] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
server # [    1.088679] io scheduler mq-deadline registered
server # [    1.088770] io scheduler kyber registered
server # [    1.139347] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
server # [    1.149747] ledtrig-cpu: registered to indicate activity on CPUs
server # [    1.157142] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    1.157760] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    1.160368] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    1.160510] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    1.161120] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [    1.161636] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
server # [    1.167921] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
server # [    1.168283] pci_bus 0000:00: root bus resource [bus 00-ff]
server # [    1.168389] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
server # [    1.168465] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    1.168507] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
server # [    1.169784] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [    1.176762] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    1.177142] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    1.177248] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.177319] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.177424] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    1.180455] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    1.180584] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
server # [    1.180630] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.180673] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.181393] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    1.181505] pci 0000:00:03.0: BAR 0 [io  0x0000-0x003f]
server # [    1.181551] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.181597] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.182114] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    1.182203] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
server # [    1.182242] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.182283] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.182760] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    1.189338] pci 0000:00:05.0: BAR 0 [io  0x0000-0x001f]
server # [    1.189443] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.189491] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.190220] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
server # [    1.190328] pci 0000:00:06.0: BAR 0 [io  0x0000-0x007f]
server # [    1.190372] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.190416] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.193974] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    1.194130] pci 0000:00:07.0: BAR 0 [io  0x0000-0x001f]
server # [    1.194180] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.194223] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.194264] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    1.197447] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
server # [    1.197586] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.197635] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.199936] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
server # [    1.200074] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.200134] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.200825] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
server # [    1.200916] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]
server # [    1.201722] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
server # [    1.202046] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
server # [    1.202175] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.202256] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.206309] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    1.206464] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
server # [    1.206513] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    1.206556] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    1.208701] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    1.208880] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    1.212464] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    1.212674] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    1.212765] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    1.212829] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    1.212897] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    1.212953] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    1.213144] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    1.213215] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
server # [    1.213282] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    1.213341] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    1.213424] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    1.213491] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    1.213545] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
server # [    1.213593] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
server # [    1.213634] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
server # [    1.213675] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    1.213715] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    1.213756] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned
server # [    1.213796] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
server # [    1.213836] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
server # [    1.213877] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned
server # [    1.213918] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    1.213959] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    1.214008] pci 0000:00:06.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    1.214063] pci 0000:00:03.0: BAR 0 [io  0x1080-0x10bf]: assigned
server # [    1.231250] pci 0000:00:0b.0: BAR 0 [io  0x10c0-0x10ff]: assigned
server # [    1.231350] pci 0000:00:01.0: BAR 0 [io  0x1100-0x111f]: assigned
server # [    1.231403] pci 0000:00:02.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    1.231459] pci 0000:00:04.0: BAR 0 [io  0x1140-0x115f]: assigned
server # [    1.232066] pci 0000:00:05.0: BAR 0 [io  0x1160-0x117f]: assigned
server # [    1.232128] pci 0000:00:07.0: BAR 0 [io  0x1180-0x119f]: assigned
server # [    1.232454] pci 0000:00:0c.0: BAR 0 [io  0x11a0-0x11bf]: assigned
server # [    1.232826] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
server # [    1.232888] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
server # [    1.232929] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
server # [    1.242670] pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    1.330922] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
server # [    1.336833] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [    1.340958] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [    1.345655] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
server # [    1.356299] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)
server # [    1.360849] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)
server # [    1.364475] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)
server # [    1.369692] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
server # [    1.373660] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [    1.377748] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
server # [    1.382111] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [    1.407814] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
server # [    1.421418] msm_serial: driver initialized
server # [    1.422493] SuperH (H)SCI(F) driver initialized
server # [    1.422978] STM32 USART driver initialized
server # [    1.498237] loop: module loaded
server # [    1.499646] virtio_blk virtio5: 2/0/0 default/read/poll queues
server # [    1.505055] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [    1.520839] megasas: 07.734.00.00-rc1
server # [    1.528739] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
server # [    1.532818] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    1.533740] Intel/Sharp Extended Query Table at 0x0031
server # [    1.538262] Using buffer write method
server # [    1.540304] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
server # [    1.541925] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    1.542255] Intel/Sharp Extended Query Table at 0x0031
server # [    1.544463] Using buffer write method
server # [    1.544903] Concatenating MTD devices:
server # [    1.545054] (0): "0.flash"
server # [    1.545160] (1): "0.flash"
server # [    1.545203] into device "0.flash"
server # [    2.144503] Freeing initrd memory: 25488K
server # [    2.277568] tun: Universal TUN/TAP device driver, 1.6
server # [    2.296390] thunder_xcv, ver 1.0
server # [    2.296617] thunder_bgx, ver 1.0
server # [    2.296757] nicpf, ver 1.0
server # [    2.300741] e1000: Intel(R) PRO/1000 Network Driver
server # [    2.300810] e1000: Copyright (c) 1999-2006 Intel Corporation.
server # [    2.301203] e1000e: Intel(R) PRO/1000 Network Driver
server # [    2.301240] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
server # [    2.301390] igb: Intel(R) Gigabit Ethernet Network Driver
server # [    2.301432] igb: Copyright (c) 2007-2014 Intel Corporation.
server # [    2.301593] igbvf: Intel(R) Gigabit Virtual Function Network Driver
server # [    2.301637] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
server # [    2.303842] sky2: driver version 1.30
server # [    2.317936] ehci-pci 0000:00:0a.0: EHCI Host Controller
server # [    2.319498] usbcore: registered new interface driver usb-storage
server # [    2.319815] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1
server # [    2.320560] usbcore: registered new interface driver usbserial_generic
server # [    2.320878] usbserial: USB Serial support registered for generic
server # [    2.327107] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000
server # [    2.329174] hv_vmbus: registering driver hyperv_keyboard
server # [    2.342647] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00
server # [    2.344522] rtc-pl031 9010000.pl031: registered as rtc0
server # [    2.345417] rtc-pl031 9010000.pl031: setting system clock to 2026-10-27T16:04:32 UTC (1793117072)
server # [    2.351371] i2c_dev: i2c /dev entries driver
server # [    2.364546] hub 1-0:1.0: USB hub found
server # [    2.365870] hub 1-0:1.0: 6 ports detected
server # [    2.382742] sdhci: Secure Digital Host Controller Interface driver
server # [    2.382833] sdhci: Copyright(c) Pierre Ossman
server # [    2.385598] Synopsys Designware Multimedia Card Interface Driver
server # [    2.388545] sdhci-pltfm: SDHCI platform and OF driver helper
server # [    2.400907] hid: raw HID events driver (C) Jiri Kosina
server # [    2.403519] usbcore: registered new interface driver usbhid
server # [    2.403596] usbhid: USB HID core driver
server # [    2.416493] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available
server # [    2.428438] drop_monitor: Initializing network drop monitor service
server # [    2.429785] NET: Registered PF_INET6 protocol family
server # [    2.441968] Segment Routing with IPv6
server # [    2.442258] In-situ OAM (IOAM) with IPv6
server # [    2.442863] NET: Registered PF_PACKET protocol family
server # [    2.445322] 9pnet: Installing 9P2000 support
server # [    2.450710] Key type dns_resolver registered
server # [    2.503871] registered taskstats version 1
server # [    2.507680] Loading compiled-in X.509 certificates
server # [    2.590697] Demotion targets for Node 0: null
server # [    2.591938] Key type .fscrypt registered
server # [    2.591999] Key type fscrypt-provisioning registered
server # [    2.596554] ima: No TPM chip found, activating TPM-bypass!
server # [    2.596690] ima: Allocated hash algorithm: sha1
server # [    2.599301] ima: No architecture policies found
server # [    2.608512] input: gpio-keys as /devices/platform/gpio-keys/input/input0
server # [    2.635061] usb 1-1: new high-speed USB device number 2 using ehci-pci
server # [    2.662455] clk: Disabling unused clocks
server # [    2.662806] PM: genpd: Disabling unused power domains
server # [    2.819164] 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.890786] 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 # [    3.010473] usb 1-2: new high-speed USB device number 3 using ehci-pci
server # [    3.048309] Freeing unused kernel memory: 4736K
server # [    3.051624] Run /init as init process
server # [    3.214093] 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 # [    3.215487] 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.308778] systemd[1]: Successfully made /usr/ read-only.
server # [    3.667721] systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
server # [    3.667977] systemd[1]: Detected virtualization qemu.
server # [    3.668336] systemd[1]: Detected architecture arm64.
server # [    3.668406] systemd[1]: Running in initrd.
server # [    3.676409] systemd[1]: Initializing machine ID from random generator.
server # [    3.683328] systemd[1]: Hostname set to <server>.
server # [    4.655930] systemd[1]: Queued start job for default target Initrd Default Target.
server # [    4.719595] systemd[1]: Created slice Slice /system/modprobe.
server # [    4.725534] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [    4.726312] systemd[1]: Expecting device /dev/disk/by-label/nixos...
server # [    4.727484] systemd[1]: Reached target Path Units.
server # [    4.727962] systemd[1]: Reached target Slice Units.
server # [    4.728153] systemd[1]: Reached target Swaps.
server # [    4.728326] systemd[1]: Reached target Timer Units.
server # [    4.732958] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [    4.735528] systemd[1]: Listening on Journal Socket (/dev/log).
server # [    4.736941] systemd[1]: Listening on Journal Sockets.
server # [    4.739380] systemd[1]: Listening on udev Control Socket.
server # [    4.740181] systemd[1]: Listening on udev Kernel Socket.
server # [    4.740394] systemd[1]: Reached target Socket Units.
server # [    4.767696] systemd[1]: Starting Create List of Static Device Nodes...
server # [    4.792457] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [    4.799455] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [    4.827303] systemd[1]: Mounting Kernel Configuration File System...
server # [    4.979508] systemd[1]: Starting Journal Service...
server # [    5.037804] systemd[1]: Starting Load Kernel Modules...
server # [    5.043252] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
server # [    5.085993] systemd[1]: Starting Coldplug All udev Devices...
server # [    5.208476] systemd[1]: Finished Create List of Static Device Nodes.
server # [    5.242150] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [    5.244909] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [    5.260123] systemd[1]: Mounted Kernel Configuration File System.
server # [    5.283180] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [    5.540139] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
server # [    5.555719] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
server # [    5.569559] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0
server # [    5.573913] [drm] features: -virgl +edid -resource_blob -host_visible
server # [    5.573966] [drm] features: -context_init
server # [    5.577810] [drm] number of scanouts: 1
server # [    5.577913] [drm] number of cap sets: 0
server # [    5.595812] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [    5.596219] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic
server # [    5.596333] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0
server # [    5.644249] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [    5.644924] systemd-journald[81]: Collecting audit messages is disabled.
server # [    5.669190] Console: switching to colour frame buffer device 160x50
server # [    5.699077] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device
server # [    5.771937] systemd[1]: Finished Load Kernel Modules.
server # [    5.827210] systemd[1]: Starting Apply Kernel Variables...
server # [    5.984804] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [    5.989376] systemd[1]: Reached target Preparation for Local File Systems.
server # [    5.998974] systemd[1]: Reached target Local File Systems.
server # [    6.032947] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [    6.105469] systemd[1]: Finished Apply Kernel Variables.
server # [    6.865686] systemd[1]: Started Journal Service.
server # [    6.753158] systemd-modules-load[82]: Using 2 probe threads
server # [    6.772648] systemd-modules-load[82]: Module 'virtio_balloon' is built in
server # [    6.779302] systemd-modules-load[82]: Module 'virtio_console' is built in
server # [    6.785389] systemd-modules-load[82]: Inserted module 'dm_mod'
server # [    6.791629] systemd-modules-load[82]: Module 'virtio_rng' is built in
server # [    6.802287] systemd-modules-load[82]: Inserted module 'virtio_gpu'
server # [    6.825172] systemd-udevd[89]: Using default interface naming scheme 'v260'.
server # [    6.866147] systemd[1]: Starting Create System Files and Directories...
server # [    6.883543] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [    7.369440] systemd[1]: Finished Create System Files and Directories.
server # [    7.546479] systemd[1]: Starting Virtual Console Setup...
server # [    7.853814] systemd-vconsole-setup[111]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [    7.874625] systemd[1]: Finished Virtual Console Setup.
server # [   12.726179] systemd[1]: Finished Coldplug All udev Devices.
server # [   12.738283] systemd[1]: Reached target System Initialization.
server # [   12.742280] systemd[1]: Reached target Basic System.
server # [   14.997249] (udev-worker)[127]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [   15.001155] (udev-worker)[127]: Network interface NamePolicy= disabled on kernel command line.
server # [   15.226858] (udev-worker)[130]: Network interface NamePolicy= disabled on kernel command line.
server # [   15.597346] systemd[1]: Found device /dev/disk/by-label/nixos.
server # [   15.702388] systemd[1]: Reached target Initrd Root Device.
server # [   15.723772] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [   16.055921] systemd-fsck[139]: nixos: clean, 12/65536 files, 13019/262144 blocks
server # [   16.116985] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
server # [   16.143891] systemd[1]: Mounting /sysroot...
server # [   16.624743] EXT4-fs (vda): mounted filesystem ee42a145-88f3-45b7-b79e-91c6984c2730 r/w with ordered data mode. Quota mode: none.
server # [   16.543372] systemd[1]: Mounted /sysroot.
server # [   16.565396] systemd[1]: Reached target Initrd Root File System.
server # [   16.581735] systemd[1]: Starting Mountpoints Configured in the Real Root...
server # [   16.723934] systemd-sysroot-fstab-check[147]: /sysroot should be mounted in the initrd, will request daemon-reload.
server # [   16.759021] systemd[1]: Reload requested from client PID 147 ('systemd-sysroot') (unit initrd-parse-etc.service)...
server # [   16.761816] systemd[1]: Reloading...
server # [   18.842860] systemd[1]: Reloading finished in 2071 ms.
server # [   18.945140] systemd-sysroot-fstab-check[147]: Requesting initrd-fs.target/start/replace...
server # [   18.975512] systemd-sysroot-fstab-check[147]: Requesting swap.target/start/replace...
server # [   19.018582] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [   19.072988] systemd[1]: Mounting /sysroot/run...
server # [   19.140209] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [   19.257246] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
server # [   19.290782] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [   19.293756] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [   19.437360] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [   19.451378] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [   19.495567] systemd[1]: Mounted /sysroot/nix/.rw-store.
server # [   19.505464] systemd[1]: Mounted /sysroot/run.
server # [   19.568843] systemd[1]: Mounting /sysroot/nix/.ro-store...
server # [   19.614413] systemd[1]: Mounting /sysroot/tmp/shared...
server # [   19.681799] systemd[1]: Mounting /sysroot/tmp/xchg...
server # [   19.727654] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [   19.993995] systemd[1]: Mounted /sysroot/nix/.ro-store.
server # [   20.051211] systemd[1]: Mounted /sysroot/tmp/shared.
server # [   20.054131] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [   20.058713] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [   20.063542] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   20.122604] systemd[1]: Mounting /sysroot/nix/store...
server # [   20.477521] systemd[1]: Mounted /sysroot/nix/store.
server # [   20.499860] systemd[1]: Reached target Initrd File Systems.
server # [   20.541253] systemd[1]: Starting Find NixOS closure...
server # [   20.595676] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
server # [   20.978395] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
server # [   21.286644] systemd[1]: Finished Find NixOS closure.
server # [   21.304008] systemd[1]: Reached target Initrd Default Target.
server # [   21.333505] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [   21.580304] systemd[1]: Stopped target Initrd Default Target.
server # [   21.587534] systemd[1]: Stopped target Basic System.
server # [   21.595616] systemd[1]: Stopped target Initrd Root Device.
server # [   21.598642] systemd[1]: Stopped target Path Units.
server # [   21.607271] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
server # [   21.610314] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
server # [   21.622217] systemd[1]: Stopped target Slice Units.
server # [   21.630286] systemd[1]: Stopped target Socket Units.
server # [   21.635719] systemd[1]: Stopped target System Initialization.
server # [   21.641838] systemd[1]: Stopped target Swaps.
server # [   21.650211] systemd[1]: Stopped target Timer Units.
server # [   21.654486] systemd[1]: dbus.socket: Deactivated successfully.
server # [   21.661389] systemd[1]: Closed D-Bus System Message Bus Socket.
server # [   21.665122] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
server # [   21.671877] systemd[1]: Stopped Find NixOS closure.
server # [   21.704592] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [   21.745729] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [   21.753360] systemd[1]: systemd-sysctl.service: Deactivated successfully.
server # [   21.765878] systemd[1]: Stopped Apply Kernel Variables.
server # [   21.776979] systemd[1]: systemd-modules-load.service: Deactivated successfully.
server # [   21.789867] systemd[1]: Stopped Load Kernel Modules.
server # [   21.807335] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
server # [   21.810173] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
server # [   21.820372] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
server # [   21.843281] systemd[1]: Stopped Create System Files and Directories.
server # [   21.854413] systemd[1]: Stopped target Local File Systems.
server # [   21.862692] systemd[1]: Stopped target Preparation for Local File Systems.
server # [   21.869835] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
server # [   21.885192] systemd[1]: Stopped Coldplug All udev Devices.
server # [   21.890706] systemd[1]: systemd-udev-trigger.service: Consumed 6.044s CPU time over 16.906s wall clock time, 9.4M memory peak.
server # [   21.898744] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
server # [   21.900228] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   21.917549] systemd[1]: Stopped Virtual Console Setup.
server # [   22.073310] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [   22.078283] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [   22.085746] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [   22.094521] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [   22.104391] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [   22.114529] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   22.496251] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [   22.500992] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
server # [   22.505765] systemd[1]: systemd-udevd.service: Consumed 12.709s CPU time over 16.567s wall clock time, 24.1M memory peak.
server # [   22.518054] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
server # [   22.522505] systemd[1]: Closed udev Control Socket.
server # [   22.537945] systemd[1]: Starting Cleanup udev Database...
server # [   22.546371] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
server # [   22.550702] systemd[1]: Stopped Create Static Device Nodes in /dev.
server # [   22.554102] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [   22.555892] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
server # [   22.558010] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
server # [   22.560373] systemd[1]: Stopped Create List of Static Device Nodes.
server # [   22.722558] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
server # [   22.726058] systemd[1]: Finished Cleanup udev Database.
server # [   22.738900] systemd[1]: Reached target Switch Root.
server # [   22.757098] systemd[1]: Starting NixOS Activation...
server # [   24.786344] initrd-nixos-activation-start[239]: booting system configuration /nix/store/98k940gqfarnmsxiry7yqi1w40453j1m-nixos-system-server-test
server # [   25.558227] initrd-nixos-activation-start[239]: running activation script...
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [   30.501581] initrd-nixos-activation-start[262]: setting up /etc...
server # [   33.255825] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
server # [   33.261290] systemd[1]: Finished NixOS Activation.
server # [   33.263514] systemd[1]: initrd-nixos-activation.service: Consumed 5.345s CPU time over 10.499s wall clock time, 22.6M memory peak.
server # [   33.277351] systemd[1]: Starting Switch Root...
server # [   33.430693] systemd[1]: Switching root.
server # [   33.692940] systemd-journald[81]: Received SIGTERM from PID 1 (systemd).
server # [   36.421706] systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
server # [   36.422133] systemd[1]: Detected virtualization qemu.
server # [   36.426862] systemd[1]: Detected architecture arm64.
server # [   36.429308] systemd[1]: Detected first boot.
server # [   36.468181] systemd[1]: Initializing machine ID from random generator.
server # [   38.540227] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [   40.063584] systemd[1]: Applying preset policy.
server # [   44.950040] systemd[1]: Populated /etc with preset unit settings.
server # [   50.320178] systemd[1]: initrd-switch-root.service: Deactivated successfully.
server # [   50.326270] systemd[1]: Stopped initrd-switch-root.service.
server # [   50.352639] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
server # [   50.368340] systemd[1]: Created slice Slice /system/getty.
server # [   50.384544] systemd[1]: Created slice User and Session Slice.
server # [   50.392382] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [   50.399569] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
server # [   50.404902] systemd[1]: Expecting device /dev/hvc0...
server # [   50.410460] systemd[1]: Expecting device /dev/ttyAMA0...
server # [   50.416502] systemd[1]: Reached target Local Encrypted Volumes.
server # [   50.421167] systemd[1]: Stopped target initrd-fs.target.
server # [   50.425982] systemd[1]: Stopped target initrd-root-fs.target.
server # [   50.431841] systemd[1]: Stopped target initrd-switch-root.target.
server # [   50.436694] systemd[1]: Reached target Virtual Machines and Containers.
server # [   50.442383] systemd[1]: Reached target Path Units.
server # [   50.446705] systemd[1]: Reached target Remote File Systems.
server # [   50.451743] systemd[1]: Reached target Slice Units.
server # [   50.456067] systemd[1]: Reached target Swaps.
server # [   50.496143] systemd[1]: Listening on Process Core Dump Socket.
server # [   50.525138] systemd[1]: Listening on Credential Encryption/Decryption.
server # [   50.572635] systemd[1]: Starting Journal Log Access Socket...
server # [   50.591088] systemd[1]: Listening on Journal Audit Socket.
server # [   50.610415] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
server # [   50.617665] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [   50.627687] systemd[1]: Listening on udev Control Socket.
server # [   50.668120] systemd[1]: Mounting Huge Pages File System...
server # [   50.712083] systemd[1]: Mounting POSIX Message Queue File System...
server # [   50.776900] systemd[1]: Mounting Kernel Debug File System...
server # [   50.833233] systemd[1]: Mounting Kernel Trace File System...
server # [   50.966897] systemd[1]: Starting Create List of Static Device Nodes...
server # [   51.045468] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [   51.059616] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   51.133080] systemd[1]: Mounting Kernel Configuration File System...
server # [   51.150947] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
server # [   51.156007] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [   51.243361] systemd[1]: Starting Load Kernel Module fuse...
server # [   51.253186] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [   51.537926] systemd[1]: Starting Journal Service...
server # [   51.769455] systemd[1]: Starting Load Kernel Modules...
server # [   52.081040] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
server # [   52.469638] systemd[1]: Starting Remount Root and Kernel File Systems...
server # [   52.557634] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
server # [   52.591933] fuse: init (API version 7.45)
server # [   52.640461] systemd[1]: Starting Coldplug All udev Devices...
server # [   53.016748] systemd[1]: Listening on Journal Log Access Socket.
server # [   53.119455] systemd[1]: Mounted Huge Pages File System.
server # [   53.143719] systemd[1]: Mounted POSIX Message Queue File System.
server # [   53.161344] systemd[1]: Mounted Kernel Debug File System.
server # [   53.175138] systemd[1]: Mounted Kernel Trace File System.
server # [   53.191183] systemd[1]: Finished Create List of Static Device Nodes.
server # [   53.207518] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [   53.216647] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [   53.233393] systemd[1]: Mounted Kernel Configuration File System.
server # [   53.245074] systemd[1]: modprobe@fuse.service: Deactivated successfully.
server # [   53.262255] systemd[1]: Finished Load Kernel Module fuse.
server # [   53.280232] systemd[1]: Finished Load Kernel Modules.
server # [   53.327202] systemd-journald[333]: Collecting audit messages is enabled.
server # [   53.357461] systemd[1]: Mounting FUSE Control File System...
server # [   53.588172] systemd[1]: Starting Firewall...
server # [   53.498342] systemd[1]: Queued start job for default target Multi-User System.
server # [   53.508529] systemd[1]: systemd-journald.service: Deactivated successfully.
server # [   53.524125] systemd[1]: systemd-journald.service: Consumed 1.407s CPU time over 45.254s wall clock time, 9.8M memory peak.
server # [   53.539973] systemd-modules-load[334]: Using 2 probe threads
server # [   53.544479] systemd-modules-load[334]: Module 'atkbd' is built in
server # [   53.562279] systemd-modules-load[334]: Module 'loop' is built in
server # [   53.799170] systemd[1]: Starting Apply Kernel Variables...
server # [   53.820058] EXT4-fs (vda): re-mounted ee42a145-88f3-45b7-b79e-91c6984c2730.
server # [   53.904851] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [   53.948088] systemd[1]: Started Journal Service.
server # [   53.889360] systemd[1]: Finished Remount Root and Kernel File Systems.
server # [   54.839424] systemd-oomd[335]: No swap; memory pressure usage will be degraded
server # [   55.123325] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [   55.367999] systemd[1]: Mounted FUSE Control File System.
server # [   55.753258] systemd[1]: Starting Flush Journal to Persistent Storage...
server # [   55.798586] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
server # [   55.999923] systemd[1]: Starting Load/Save OS Random Seed...
server # [   56.022463] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
server # [   56.301765] systemd[1]: Finished Apply Kernel Variables.
server # [   56.478198] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [   56.714870] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [   56.894011] systemd-journald[333]: Received client request to flush runtime journal.
server # [   57.484158] systemd[1]: Finished Load/Save OS Random Seed.
server # [   57.514846] systemd[1]: Reached target First Boot Complete.
server # [   57.538614] systemd[1]: Finished Flush Journal to Persistent Storage.
server # [   58.105989] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [   58.157220] systemd[1]: Reached target Preparation for Local File Systems.
server # [   58.208191] systemd[1]: Mounting /run/wrappers...
server # [   58.299468] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [   58.859493] systemd[1]: Mounted /run/wrappers.
server # [   58.882398] systemd[1]: Reached target Local File Systems.
server # [   58.953556] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [   59.021049] systemd[1]: Starting register-nix-paths.service...
server # [   59.131867] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [   59.143807] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server # [   59.329154] systemd[1]: Starting Save Transient machine-id to Disk...
server # [   59.529803] systemd[1]: Starting Create System Files and Directories...
server # [   60.897413] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [   60.931607] systemd[1]: Finished Save Transient machine-id to Disk.
server # [   62.730901] systemd[1]: Finished Create System Files and Directories.
server # [   62.991550] systemd[1]: Starting Rebuild Journal Catalog...
server # [   63.185199] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [   64.839271] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [   66.098026] systemd[1]: Finished Rebuild Journal Catalog.
server # [   66.226722] systemd[1]: Starting Update is Completed...
server # [   67.327391] systemd[1]: Finished Update is Completed.
server # [   69.378453] hrtimer: interrupt took 24176250 ns
server # [   71.697621] systemd-udevd[385]: Using default interface naming scheme 'v260'.
server # [   73.973471] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [   73.992922] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [   74.008920] systemd[1]: suid-sgid-wrappers.service: Consumed 3.687s CPU time over 14.837s wall clock time, 5.2M memory peak.
server # [   74.911158] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [   76.115597] systemd[1]: Finished register-nix-paths.service.
server # [   78.338357] systemd[1]: Finished Firewall.
server # [   80.699833] systemd[1]: Finished Coldplug All udev Devices.
server # [   80.703868] systemd[1]: Reached target System Initialization.
server # [   80.727338] systemd[1]: Started Discard unused filesystem blocks once a week.
server # [   80.735372] systemd[1]: Started Daily Cleanup of Temporary Directories.
server # [   80.744647] systemd[1]: Reached target Timer Units.
server # [   80.759600] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [   80.765807] systemd[1]: Listening on Nix Daemon Socket.
server # [   80.774429] systemd[1]: Listening on Hostname Service Socket.
server # [   80.778280] systemd[1]: Reached target Socket Units.
server # [   80.787832] systemd[1]: Reached target Basic System.
server # [   80.822323] systemd[1]: Starting Import lastlog data into lastlog2 database...
server # [   80.885582] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   80.966613] systemd[1]: Starting Post-Boot Actions...
server # [   81.147247] systemd[1]: Started Reset console on configuration changes.
server # [   81.356795] systemd[1]: Starting resolvconf update...
server # [   81.910840] systemd[1]: Finished Post-Boot Actions.
server # [   82.158069] systemd[1]: Starting D-Bus System Message Bus...
server # [   82.535573] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   82.579532] nsncd[571]: Oct 27 16:05:52.755 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   82.597352] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # [   82.658698] systemd[1]: Reached target Host and Network Name Lookups.
server # [   82.673745] systemd[1]: Reached target User and Group Name Lookups.
server # [   82.838053] systemd[1]: Starting User Login Management...
server # [   83.988438] dbus-broker-launch[579]: Looking up NSS user entry for 'systemd-timesync'...
server # [   84.305173] dbus-broker-launch[579]: NSS returned no entry for 'systemd-timesync'
server # [   84.318192] dbus-broker-launch[579]: Invalid user-name in /nix/store/3h8rckbl9vs21jahmva0fpck4y03w9xg-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [   84.814749] systemd[1]: Started D-Bus System Message Bus.
server # [   85.079054] systemd-logind[593]: New seat seat0.
server # [   85.132965] systemd[1]: Started User Login Management.
server # [   85.209182] systemd[1]: Starting linger-users.service...
server # [   85.559394] dbus-broker-launch[579]: Ready
server # [   85.907239] systemd[1]: linger-users.service: Deactivated successfully.
server # [   85.927980] systemd[1]: Finished linger-users.service.
server # [   86.097823] systemd[1]: Stopped target Host and Network Name Lookups.
server # [   86.107949] systemd[1]: Stopping Host and Network Name Lookups...
server # [   86.116856] systemd[1]: Stopped target User and Group Name Lookups.
server # [   86.118649] systemd[1]: Stopping User and Group Name Lookups...
server # [   86.141658] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
server # [   86.193679] systemd[1]: nscd.service: Deactivated successfully.
server # [   86.202272] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
server # [   86.508926] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [   87.187628] nsncd[657]: Oct 27 16:05:57.437 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [   87.207377] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [   87.218230] systemd[1]: Reached target Host and Network Name Lookups.
server # [   87.222493] systemd[1]: Reached target User and Group Name Lookups.
server # [   87.626792] systemd[1]: Finished resolvconf update.
server # [   87.646348] systemd[1]: Reached target Preparation for Network.
server # [   87.693589] systemd[1]: Starting DHCP Client...
server # [   87.743371] systemd[1]: Starting Extra networking commands....
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [   90.541042] dhcpcd[700]: dhcpcd-10.3.1 starting
server # [   90.724519] dhcpcd[754]: dev: loaded udev
server # [   90.874601] dhcpcd[754]: no valid interfaces found
server # [   90.876310] dhcpcd[754]: no valid interfaces found
server # [   91.152283] systemd[1]: Finished Extra networking commands..
server # [   91.158466] systemd[1]: Reached target Network.
server # [   91.194494] systemd[1]: Starting PostgreSQL Database Server...
server # [   91.235664] systemd[1]: Starting Permit User Sessions...
server # [   91.749818] systemd[1]: Finished Permit User Sessions.
server # [   91.826371] systemd[1]: Started Getty on tty1.
server # [   91.839037] systemd[1]: Reached target Login Prompts.
server # [   92.919120] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[776]: Initializing database at /var/lib/postgresql/data
server # [   94.549898] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: The files belonging to this database system will be owned by user "postgres".
server # [   94.565023] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: This user must also own the server process.
server # [   94.670681] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: The database cluster will be initialized with locale "en_US.UTF-8".
server # [   94.677874] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: The default database encoding has accordingly been set to "UTF8".
server # [   94.679705] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: The default text search configuration will be set to "english".
server # [   94.681406] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: Data page checksums are enabled.
server # [   94.685738] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: fixing permissions on existing directory /var/lib/postgresql/data ... ok
server # [   94.692058] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: creating subdirectories ... ok
server # [   94.701072] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: selecting dynamic shared memory implementation ... posix
server # [   96.035247] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: selecting default max_connections ... 100
server # [   96.704136] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: selecting default shared_buffers ... 128MB
server # [  108.563588] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: selecting default time zone ... UTC
server # [  108.613648] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: creating configuration files ... ok
server # [  112.404890] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: running bootstrap script ... ok
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  120.929896] dhcpcd[754]: timed out
server # [  120.938267] dhcpcd[754]: timed out
server # [  120.963799] systemd[1]: Started DHCP Client.
server # [  123.398169] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: performing post-bootstrap initialization ... ok
server # [  126.194448] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: syncing data to disk ... ok
server # [  126.221241] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: initdb: warning: enabling "trust" authentication for local connections
server # [  126.225012] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: 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 # [  126.226569] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]: Success. You can now start the database server using:
server # [  126.227697] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[788]:     /nix/store/8f61g0kn68hhlcd0wj7h40w8h17hfb75-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start
server # [  127.731895] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[776]: Validating PostgreSQL configuration...
server # [  128.153755] rg2ds6bsd73gbbpl182gwjpww4kzq3fi-postgresql-init[1032]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault
server # [  129.542968] postgres[1034]:  2026-10-27 16:06:39.787 UTC [1034] LOG:  pgaudit extension initialized
server # [  130.291503] postgres[1034]:  2026-10-27 16:06:40.554 UTC [1034] LOG:  pgsodium primary server secret key loaded
server # [  130.774176] postgres[1034]:  2026-10-27 16:06:41.033 UTC [1034] LOG:  vault primary server secret key loaded
server # [  131.199837] postgres[1034]:  2026-10-27 16:06:41.460 UTC [1034] LOG:  starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.3.0, 64-bit
server # [  131.214276] postgres[1034]:  2026-10-27 16:06:41.479 UTC [1034] LOG:  listening on IPv4 address "0.0.0.0", port 5432
server # [  131.218314] postgres[1034]:  2026-10-27 16:06:41.480 UTC [1034] LOG:  listening on IPv6 address "::", port 5432
server # [  131.249235] postgres[1034]:  2026-10-27 16:06:41.512 UTC [1034] LOG:  listening on Unix socket "/run/postgresql/.s.PGSQL.5432"
server # [  131.434472] postgres[1064]:  2026-10-27 16:06:41.666 UTC [1064] LOG:  database system was shut down at 2026-10-27 16:06:33 UTC
server # [  131.776040] postgres[1071]:  2026-10-27 16:06:42.023 UTC [1071] LOG:  TimescaleDB background worker launcher connected to shared catalogs
server # [  131.853684] postgres[1034]:  2026-10-27 16:06:42.035 UTC [1034] LOG:  database system is ready to accept connections
server # [  131.887505] postgres[1073]:  2026-10-27 16:06:42.051 UTC [1073] FATAL:  role "postgres" does not exist
server # [  131.942156] systemd[1]: Started PostgreSQL Database Server.
server # [  131.963318] postgres[1034]:  2026-10-27 16:06:42.224 UTC [1034] LOG:  background worker "pg_net 0.20.4 worker" (PID 1073) exited with exit code 1
server # [  132.010888] systemd[1]: Starting Supabase Database Initialization...
server # [  132.127927] postgres[1074]:  2026-10-27 16:06:42.382 UTC [1074] LOG:  pg_cron scheduler started
server # [  132.581698] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Waiting for PostgreSQL to be ready...
server # [  133.103049] postgres[1090]:  2026-10-27 16:06:43.313 UTC [1090] FATAL:  role "postgres" does not exist
server # [  133.186850] postgres[1034]:  2026-10-27 16:06:43.424 UTC [1034] LOG:  background worker "pg_net 0.20.4 worker" (PID 1090) exited with exit code 1
server # [  133.483505] postgres[1091]: ::1 2026-10-27 16:06:43.719 UTC [1091] root@root FATAL:  role "root" does not exist
server # [  133.507984] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: PostgreSQL is ready
server # [  133.522423] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Creating postgres role...
server # [  133.945417] postgres[1093]: ::1 2026-10-27 16:06:44.201 UTC [1093] supabase_admin@postgres LOG:  statement: CREATE ROLE postgres SUPERUSER LOGIN;
server # [  133.975884] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1092]: CREATE ROLE
server # [  134.367320] postgres[1096]: ::1 2026-10-27 16:06:44.624 UTC [1096] supabase_admin@postgres LOG:  statement: ALTER DATABASE postgres OWNER TO postgres;
server # [  134.387699] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1094]: ALTER DATABASE
server # [  134.472251] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql
server # [  134.818841] postgres[1098]: ::1 2026-10-27 16:06:45.039 UTC [1098] postgres@postgres LOG:  statement: create publication supabase_realtime;
server # [  134.862447] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: CREATE PUBLICATION
server # [  134.873235] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: ALTER ROLE
server # [  134.875771] postgres[1098]: ::1 2026-10-27 16:06:45.112 UTC [1098] postgres@postgres LOG:  statement: alter user  supabase_admin with superuser createdb createrole replication bypassrls;
server # [  134.882303] postgres[1098]: ::1 2026-10-27 16:06:45.136 UTC [1098] postgres@postgres LOG:  statement: create user supabase_replication_admin with login replication;
server # [  134.883637] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: CREATE ROLE
server # [  134.885443] postgres[1098]: ::1 2026-10-27 16:06:45.149 UTC [1098] postgres@postgres LOG:  statement: create user supabase_etl_admin with login replication bypassrls;
server # [  134.901769] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: CREATE ROLE
server # [  134.905702] postgres[1098]: ::1 2026-10-27 16:06:45.170 UTC [1098] postgres@postgres LOG:  statement: grant pg_read_all_data to supabase_etl_admin;
server # [  134.918234] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: GRANT ROLE
server # [  134.926248] postgres[1098]: ::1 2026-10-27 16:06:45.183 UTC [1098] postgres@postgres LOG:  statement: grant create on database postgres to supabase_etl_admin;
server # [  134.936173] postgres[1098]: ::1 2026-10-27 16:06:45.196 UTC [1098] postgres@postgres LOG:  statement: create role supabase_read_only_user with login bypassrls;
server # [  134.943953] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: GRANT
server # [  134.951022] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: CREATE ROLE
server # [  134.957719] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: GRANT ROLE
server # [  134.962425] postgres[1098]: ::1 2026-10-27 16:06:45.208 UTC [1098] postgres@postgres LOG:  statement: grant pg_read_all_data to supabase_read_only_user;
server # [  134.974316] postgres[1098]: ::1 2026-10-27 16:06:45.220 UTC [1098] postgres@postgres LOG:  statement: create schema if not exists extensions;
server # [  134.976062] postgres[1098]: ::1 2026-10-27 16:06:45.239 UTC [1098] postgres@postgres LOG:  statement: create extension if not exists "uuid-ossp"      with schema extensions;
server # [  134.982672] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: CREATE SCHEMA
server # [  137.815542] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: CREATE EXTENSION
server # [  137.834323] postgres[1098]: ::1 2026-10-27 16:06:48.072 UTC [1098] postgres@postgres LOG:  statement: create extension if not exists pgcrypto         with schema extensions;
server # [  138.946432] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: CREATE EXTENSION
server # [  138.954079] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: CREATE ROLE
server # [  138.965193] postgres[1098]: ::1 2026-10-27 16:06:49.201 UTC [1098] postgres@postgres LOG:  statement: create role anon                nologin noinherit;
server # [  138.968550] postgres[1098]: ::1 2026-10-27 16:06:49.211 UTC [1098] postgres@postgres LOG:  statement: create role authenticated       nologin noinherit;
server # [  138.978187] postgres[1098]: ::1 2026-10-27 16:06:49.224 UTC [1098] postgres@postgres LOG:  statement: create role service_role        nologin noinherit bypassrls;
server # [  138.987614] postgres[1098]: ::1 2026-10-27 16:06:49.232 UTC [1098] postgres@postgres LOG:  statement: create user authenticator noinherit;
server # [  138.996817] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: CREATE ROLE
server # [  139.001539] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: CREATE ROLE
server # [  139.004195] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: CREATE ROLE
server # [  139.014119] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: GRANT ROLE
server # [  139.026169] postgres[1098]: ::1 2026-10-27 16:06:49.246 UTC [1098] postgres@postgres LOG:  statement: grant anon              to authenticator;
server # [  139.029450] postgres[1098]: ::1 2026-10-27 16:06:49.259 UTC [1098] postgres@postgres LOG:  statement: grant authenticated     to authenticator;
server # [  139.036356] postgres[1098]: ::1 2026-10-27 16:06:49.268 UTC [1098] postgres@postgres LOG:  statement: grant service_role      to authenticator;
server # [  139.038977] postgres[1098]: ::1 2026-10-27 16:06:49.283 UTC [1098] postgres@postgres LOG:  statement: grant supabase_admin    to authenticator;
server # [  139.046471] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: GRANT ROLE
server # [  139.050489] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: GRANT ROLE
server # [  139.057860] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: GRANT ROLE
server # [  139.061095] postgres[1098]: ::1 2026-10-27 16:06:49.301 UTC [1098] postgres@postgres LOG:  statement: grant usage                     on schema public to postgres, anon, authenticated, service_role;
server # [  139.072309] postgres[1098]: ::1 2026-10-27 16:06:49.315 UTC [1098] postgres@postgres LOG:  statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;
server # [  139.082052] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: GRANT
server # [  139.085574] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: ALTER DEFAULT PRIVILEGES
server # [  139.095034] postgres[1098]: ::1 2026-10-27 16:06:49.337 UTC [1098] postgres@postgres LOG:  statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;
server # [  139.106514] postgres[1098]: ::1 2026-10-27 16:06:49.353 UTC [1098] postgres@postgres LOG:  statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;
server # [  139.116862] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: ALTER DEFAULT PRIVILEGES
server # [  139.122301] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: ALTER DEFAULT PRIVILEGES
server # [  139.130038] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: GRANT
server # [  139.139309] postgres[1098]: ::1 2026-10-27 16:06:49.365 UTC [1098] postgres@postgres LOG:  statement: grant usage                     on schema extensions to postgres, anon, authenticated, service_role;
server # [  139.149523] postgres[1098]: ::1 2026-10-27 16:06:49.382 UTC [1098] postgres@postgres LOG:  statement: alter user supabase_admin SET search_path TO public, extensions;
server # [  139.157974] postgres[1098]: ::1 2026-10-27 16:06:49.401 UTC [1098] postgres@postgres LOG:  statement: alter default privileges for user supabase_admin in schema public grant all
server # [  139.162399] postgres[1098]: 	    on sequences to postgres, anon, authenticated, service_role;
server # [  139.170337] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: ALTER ROLE
server # [  139.173869] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: ALTER DEFAULT PRIVILEGES
server # [  139.178535] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: ALTER DEFAULT PRIVILEGES
server # [  139.186367] postgres[1098]: ::1 2026-10-27 16:06:49.419 UTC [1098] postgres@postgres LOG:  statement: alter default privileges for user supabase_admin in schema public grant all
server # [  139.193496] postgres[1098]: 	    on tables to postgres, anon, authenticated, service_role;
server # [  139.202002] postgres[1098]: ::1 2026-10-27 16:06:49.434 UTC [1098] postgres@postgres LOG:  statement: alter default privileges for user supabase_admin in schema public grant all
server # [  139.204725] postgres[1098]: 	    on functions to postgres, anon, authenticated, service_role;
server # [  139.207862] postgres[1098]: ::1 2026-10-27 16:06:49.448 UTC [1098] postgres@postgres LOG:  statement: alter role anon set statement_timeout = '3s';
server # [  139.233109] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: ALTER DEFAULT PRIVILEGES
server # [  139.244785] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: ALTER ROLE
server # [  139.251771] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1097]: ALTER ROLE
server # [  139.265976] postgres[1098]: ::1 2026-10-27 16:06:49.462 UTC [1098] postgres@postgres LOG:  statement: alter role authenticated set statement_timeout = '8s';
server # [  139.313451] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql
server # [  139.599261] postgres[1140]: ::1 2026-10-27 16:06:49.851 UTC [1140] postgres@postgres LOG:  statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;
server # [  139.606812] postgres[1140]: ::1 2026-10-27 16:06:49.867 UTC [1140] postgres@postgres LOG:  statement: CREATE TABLE auth.users (
server # [  139.616409] postgres[1140]: 	    instance_id uuid NULL,
server # [  139.620116] postgres[1140]: 	    id uuid NOT NULL UNIQUE,
server # [  139.622439] postgres[1140]: 	    aud varchar(255) NULL,
server # [  139.629240] postgres[1140]: 	    "role" varchar(255) NULL,
server # [  139.631252] postgres[1140]: 	    email varchar(255) NULL UNIQUE,
server # [  139.632187] postgres[1140]: 	    encrypted_password varchar(255) NULL,
server # [  139.642405] postgres[1140]: 	    confirmed_at timestamptz NULL,
server # [  139.643576] postgres[1140]: 	    invited_at timestamptz NULL,
server # [  139.645217] postgres[1140]: 	    confirmation_token varchar(255) NULL,
server # [  139.650329] postgres[1140]: 	    confirmation_sent_at timestamptz NULL,
server # [  139.659270] postgres[1140]: 	    recovery_token varchar(255) NULL,
server # [  139.662325] postgres[1140]: 	    recovery_sent_at timestamptz NULL,
server # [  139.663399] postgres[1140]: 	    email_change_token varchar(255) NULL,
server # [  139.669404] postgres[1140]: 	    email_change varchar(255) NULL,
server # [  139.673335] postgres[1140]: 	    email_change_sent_at timestamptz NULL,
server # [  139.679510] postgres[1140]: 	    last_sign_in_at timestamptz NULL,
server # [  139.681194] postgres[1140]: 	    raw_app_meta_data jsonb NULL,
server # [  139.682520] postgres[1140]: 	    raw_user_meta_data jsonb NULL,
server # [  139.690317] postgres[1140]: 	    is_super_admin bool NULL,
server # [  139.697627] postgres[1140]: 	    created_at timestamptz NULL,
server # [  139.698996] postgres[1140]: 	    updated_at timestamptz NULL,
server # [  139.701998] postgres[1140]: 	    CONSTRAINT users_pkey PRIMARY KEY (id)
server # [  139.706576] postgres[1140]: 	);
server # [  139.713795] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE SCHEMA
server # [  139.762621] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE TABLE
server # [  139.768967] postgres[1140]: ::1 2026-10-27 16:06:50.027 UTC [1140] postgres@postgres LOG:  statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);
server # [  139.794806] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE INDEX
server # [  139.801405] postgres[1140]: ::1 2026-10-27 16:06:50.060 UTC [1140] postgres@postgres LOG:  statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);
server # [  139.829111] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE INDEX
server # [  139.833406] postgres[1140]: ::1 2026-10-27 16:06:50.094 UTC [1140] postgres@postgres LOG:  statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';
server # [  139.842557] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: COMMENT
server # [  139.846697] postgres[1140]: ::1 2026-10-27 16:06:50.111 UTC [1140] postgres@postgres LOG:  statement: CREATE TABLE auth.refresh_tokens (
server # [  139.848969] postgres[1140]: 	    instance_id uuid NULL,
server # [  139.851059] postgres[1140]: 	    id bigserial NOT NULL,
server # [  139.852577] postgres[1140]: 	    "token" varchar(255) NULL,
server # [  139.854594] postgres[1140]: 	    user_id varchar(255) NULL,
server # [  139.856884] postgres[1140]: 	    revoked bool NULL,
server # [  139.859518] postgres[1140]: 	    created_at timestamptz NULL,
server # [  139.860779] postgres[1140]: 	    updated_at timestamptz NULL,
server # [  139.862277] postgres[1140]: 	    CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)
server # [  139.866777] postgres[1140]: 	);
server # [  139.966893] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE TABLE
server # [  139.971770] postgres[1140]: ::1 2026-10-27 16:06:50.232 UTC [1140] postgres@postgres LOG:  statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);
server # [  140.006833] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE INDEX
server # [  140.008315] postgres[1140]: ::1 2026-10-27 16:06:50.272 UTC [1140] postgres@postgres LOG:  statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id);
server # [  140.054639] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE INDEX
server # [  140.061108] postgres[1140]: ::1 2026-10-27 16:06:50.320 UTC [1140] postgres@postgres LOG:  statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);
server # [  140.099593] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE INDEX
server # [  140.102129] postgres[1140]: ::1 2026-10-27 16:06:50.362 UTC [1140] postgres@postgres LOG:  statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.';
server # [  140.107485] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: COMMENT
server # [  140.109909] postgres[1140]: ::1 2026-10-27 16:06:50.372 UTC [1140] postgres@postgres LOG:  statement: CREATE TABLE auth.instances (
server # [  140.111752] postgres[1140]: 	    id uuid NOT NULL,
server # [  140.113735] postgres[1140]: 	    uuid uuid NULL,
server # [  140.114662] postgres[1140]: 	    raw_base_config text NULL,
server # [  140.115435] postgres[1140]: 	    created_at timestamptz NULL,
server # [  140.116143] postgres[1140]: 	    updated_at timestamptz NULL,
server # [  140.118093] postgres[1140]: 	    CONSTRAINT instances_pkey PRIMARY KEY (id)
server # [  140.119014] postgres[1140]: 	);
server # [  140.198927] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE TABLE
server # [  140.207351] postgres[1140]: ::1 2026-10-27 16:06:50.463 UTC [1140] postgres@postgres LOG:  statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';
server # [  140.210336] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: COMMENT
server # [  140.215906] postgres[1140]: ::1 2026-10-27 16:06:50.475 UTC [1140] postgres@postgres LOG:  statement: CREATE TABLE auth.audit_log_entries (
server # [  140.218935] postgres[1140]: 	    instance_id uuid NULL,
server # [  140.222104] postgres[1140]: 	    id uuid NOT NULL,
server # [  140.225233] postgres[1140]: 	    payload json NULL,
server # [  140.226188] postgres[1140]: 	    created_at timestamptz NULL,
server # [  140.227715] postgres[1140]: 	    CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)
server # [  140.234899] postgres[1140]: 	);
server # [  140.275756] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE TABLE
server # [  140.284205] postgres[1140]: ::1 2026-10-27 16:06:50.542 UTC [1140] postgres@postgres LOG:  statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);
server # [  140.304561] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE INDEX
server # [  140.309862] postgres[1140]: ::1 2026-10-27 16:06:50.572 UTC [1140] postgres@postgres LOG:  statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';
server # [  140.314624] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: COMMENT
server # [  140.319697] postgres[1140]: ::1 2026-10-27 16:06:50.579 UTC [1140] postgres@postgres LOG:  statement: CREATE TABLE auth.schema_migrations (
server # [  140.330513] postgres[1140]: 	    "version" varchar(255) NOT NULL,
server # [  140.337355] postgres[1140]: 	    CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")
server # [  140.342088] postgres[1140]: 	);
server # [  140.353908] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE TABLE
server # [  140.357512] postgres[1140]: ::1 2026-10-27 16:06:50.620 UTC [1140] postgres@postgres LOG:  statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';
server # [  140.367633] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: COMMENT
server # [  140.402429] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: INSERT 0 7
server # [  140.409979] postgres[1140]: ::1 2026-10-27 16:06:50.670 UTC [1140] postgres@postgres LOG:  statement: create or replace function auth.uid() returns uuid as $$
server # [  140.412811] postgres[1140]: 	  select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;
server # [  140.415386] postgres[1140]: 	$$ language sql stable;
server # [  140.418634] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE FUNCTION
server # [  140.421729] postgres[1140]: ::1 2026-10-27 16:06:50.685 UTC [1140] postgres@postgres LOG:  statement: create or replace function auth.role() returns text as $$
server # [  140.423796] postgres[1140]: 	  select nullif(current_setting('request.jwt.claim.role', true), '')::text;
server # [  140.426140] postgres[1140]: 	$$ language sql stable;
server # [  140.441272] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE FUNCTION
server # [  140.448964] postgres[1140]: ::1 2026-10-27 16:06:50.703 UTC [1140] postgres@postgres LOG:  statement: create or replace function auth.email() returns text as $$
server # [  140.452802] postgres[1140]: 	  select nullif(current_setting('request.jwt.claim.email', true), '')::text;
server # [  140.458915] postgres[1140]: 	$$ language sql stable;
server # [  140.469687] postgres[1140]: ::1 2026-10-27 16:06:50.723 UTC [1140] postgres@postgres LOG:  statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;
server # [  140.481720] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE FUNCTION
server # [  140.489287] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: GRANT
server # [  140.492580] postgres[1140]: ::1 2026-10-27 16:06:50.739 UTC [1140] postgres@postgres LOG:  statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;
server # [  140.498529] postgres[1140]: ::1 2026-10-27 16:06:50.748 UTC [1140] postgres@postgres LOG:  statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;
server # [  140.502290] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: CREATE ROLE
server # [  140.503831] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: GRANT
server # [  140.506157] postgres[1140]: ::1 2026-10-27 16:06:50.762 UTC [1140] postgres@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;
server # [  140.516016] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: GRANT
server # [  140.524765] postgres[1140]: ::1 2026-10-27 16:06:50.784 UTC [1140] postgres@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;
server # [  140.537632] postgres[1140]: ::1 2026-10-27 16:06:50.794 UTC [1140] postgres@postgres LOG:  statement: ALTER USER supabase_auth_admin SET search_path = "auth";
server # [  140.539787] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: GRANT
server # [  140.544890] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: ALTER ROLE
server # [  140.550425] postgres[1140]: ::1 2026-10-27 16:06:50.807 UTC [1140] postgres@postgres LOG:  statement: ALTER table "auth".users OWNER TO supabase_auth_admin;
server # [  140.558461] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: ALTER TABLE
server # [  140.564058] postgres[1140]: ::1 2026-10-27 16:06:50.824 UTC [1140] postgres@postgres LOG:  statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;
server # [  140.576616] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: ALTER TABLE
server # [  140.578171] postgres[1140]: ::1 2026-10-27 16:06:50.839 UTC [1140] postgres@postgres LOG:  statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;
server # [  140.587211] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: ALTER TABLE
server # [  140.608436] postgres[1140]: ::1 2026-10-27 16:06:50.852 UTC [1140] postgres@postgres LOG:  statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;
server # [  140.611055] postgres[1140]: ::1 2026-10-27 16:06:50.865 UTC [1140] postgres@postgres LOG:  statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;
server # [  140.614024] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: ALTER TABLE
server # [  140.615261] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1139]: ALTER TABLE
server # [  140.680783] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql
server # [  141.011499] postgres[1142]: ::1 2026-10-27 16:06:51.240 UTC [1142] postgres@postgres LOG:  statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;
server # [  141.023691] postgres[1142]: ::1 2026-10-27 16:06:51.282 UTC [1142] postgres@postgres LOG:  statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;
server # [  141.045932] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1141]: CREATE SCHEMA
server # [  141.047265] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1141]: CREATE ROLE
server # [  141.050984] postgres[1142]: ::1 2026-10-27 16:06:51.310 UTC [1142] postgres@postgres LOG:  statement: ALTER USER supabase_storage_admin SET search_path = "storage";
server # [  141.060688] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1141]: ALTER ROLE
server # [  141.062357] postgres[1142]: ::1 2026-10-27 16:06:51.327 UTC [1142] postgres@postgres LOG:  statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;
server # [  141.095706] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1141]: GRANT
server # [  141.157235] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1141]: DO
server # [  141.205043] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql
server # [  141.614039] postgres[1157]: ::1 2026-10-27 16:06:51.865 UTC [1157] postgres@postgres LOG:  statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;
server # [  141.675404] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: ALTER ROLE
server # [  141.687821] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: ALTER ROLE
server # [  141.694746] postgres[1157]: ::1 2026-10-27 16:06:51.910 UTC [1157] postgres@postgres LOG:  statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;
server # [  141.702411] postgres[1157]: ::1 2026-10-27 16:06:51.926 UTC [1157] postgres@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()
server # [  141.714199] postgres[1157]: 	RETURNS event_trigger
server # [  141.717050] postgres[1157]: 	LANGUAGE plpgsql
server # [  141.726099] postgres[1157]: 	AS $$
server # [  141.740493] postgres[1157]: 	DECLARE
server # [  141.743805] postgres[1157]: 	  schema_is_cron bool;
server # [  141.746819] postgres[1157]: 	BEGIN
server # [  141.749377] postgres[1157]: 	  schema_is_cron = (
server # [  141.750607] postgres[1157]: 	    SELECT n.nspname = 'cron'
server # [  141.751862] postgres[1157]: 	    FROM pg_event_trigger_ddl_commands() AS ev
server # [  141.754609] postgres[1157]: 	    LEFT JOIN pg_catalog.pg_namespace AS n
server # [  141.758737] postgres[1157]: 	      ON ev.objid = n.oid
server # [  141.763892] postgres[1157]: 	  );
server # [  141.767648] postgres[1157]:
server # [  141.769420] postgres[1157]: 	  IF schema_is_cron
server # [  141.770163] postgres[1157]: 	  THEN
server # [  141.771034] postgres[1157]: 	    grant usage on schema cron to postgres with grant option;
server # [  141.772803] postgres[1157]:
server # [  141.774193] postgres[1157]: 	    alter default privileges in schema cron grant all on tables to postgres with grant option;
server # [  141.775927] postgres[1157]: 	    alter default privileges in schema cron grant all on functions to postgres with grant option;
server # [  141.783255] postgres[1157]: 	    alter default privileges in schema cron grant all on sequences to postgres with grant option;
server # [  141.785873] postgres[1157]:
server # [  141.787514] postgres[1157]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  141.789916] postgres[1157]: 	        on sequences to postgres with grant option;
server # [  141.791383] postgres[1157]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  141.792641] postgres[1157]: 	        on tables to postgres with grant option;
server # [  141.794195] postgres[1157]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  141.797285] postgres[1157]: 	        on functions to postgres with grant option;
server # [  141.798178] postgres[1157]:
server # [  141.799032] postgres[1157]: 	    grant all privileges on all tables in schema cron to postgres with grant option;
server # [  141.801553] postgres[1157]:
server # [  141.803495] postgres[1157]: 	  END IF;
server # [  141.806246] postgres[1157]:
server # [  141.807560] postgres[1157]: 	END;
server # [  141.810703] postgres[1157]: 	$$;
server # [  141.813761] postgres[1157]: ::1 2026-10-27 16:06:52.008 UTC [1157] postgres@postgres LOG:  statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')
server # [  141.815909] postgres[1157]: 	EXECUTE PROCEDURE extensions.grant_pg_cron_access();
server # [  141.821801] postgres[1157]: ::1 2026-10-27 16:06:52.036 UTC [1157] postgres@postgres LOG:  statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';
server # [  141.822981] postgres[1157]: ::1 2026-10-27 16:06:52.054 UTC [1157] postgres@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()
server # [  141.828783] postgres[1157]: 	RETURNS event_trigger
server # [  141.830485] postgres[1157]: 	LANGUAGE plpgsql
server # [  141.832162] postgres[1157]: 	AS $$
server # [  141.838040] postgres[1157]: 	BEGIN
server # [  141.839844] postgres[1157]: 	  IF EXISTS (
server # [  141.845733] postgres[1157]: 	    SELECT 1
server # [  141.847685] postgres[1157]: 	    FROM pg_event_trigger_ddl_commands() AS ev
server # [  141.857919] postgres[1157]: 	    JOIN pg_extension AS ext
server # [  141.860000] postgres[1157]: 	    ON ev.objid = ext.oid
server # [  141.862581] postgres[1157]: 	    WHERE ext.extname = 'pg_net'
server # [  141.863887] postgres[1157]: 	  )
server # [  141.866295] postgres[1157]: 	  THEN
server # [  141.869101] postgres[1157]: 	    IF NOT EXISTS (
server # [  141.877677] postgres[1157]: 	      SELECT 1
server # [  141.881546] postgres[1157]: 	      FROM pg_roles
server # [  141.885893] postgres[1157]: 	      WHERE rolname = 'supabase_functions_admin'
server # [  141.887963] postgres[1157]: 	    )
server # [  141.898975] postgres[1157]: 	    THEN
server # [  141.901228] postgres[1157]: 	      CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;
server # [  141.902947] postgres[1157]: 	    END IF;
server # [  141.909662] postgres[1157]:
server # [  141.911007] postgres[1157]: 	    GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;
server # [  141.913198] postgres[1157]:
server # [  141.919209] postgres[1157]: 	    ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;
server # [  141.928011] postgres[1157]: 	    ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;
server # [  141.934425] postgres[1157]:
server # [  141.935066] postgres[1157]: 	    ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;
server # [  141.936774] postgres[1157]: 	    ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;
server # [  141.938531] postgres[1157]:
server # [  141.945252] postgres[1157]: 	    REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;
server # [  141.947420] postgres[1157]: 	    REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;
server # [  141.953333] postgres[1157]:
server # [  141.954662] postgres[1157]: 	    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 # [  141.962366] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: CREATE FUNCTION
server # [  141.964284] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: CREATE EVENT TRIGGER
server # [  141.966901] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: COMMENT
server # [  141.974814] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: CREATE FUNCTION
server # [  141.975925] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: COMMENT
server # [  141.981098] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: DO
server # [  141.982676] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: CREATE ROLE
server # [  141.990728] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: GRANT
server # [  141.992229] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: GRANT
server # [  141.993786] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: GRANT
server # [  141.994623] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: GRANT
server # [  141.996227] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: GRANT
server # [  142.002651] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: GRANT
server # [  142.003730] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: GRANT
server # [  142.005459] postgres[1157]: 	    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 # [  142.009947] postgres[1157]: 	  END IF;
server # [  142.017879] postgres[1157]: 	END;
server # [  142.019483] postgres[1157]: 	$$;
server # [  142.021298] postgres[1157]: ::1 2026-10-27 16:06:52.078 UTC [1157] postgres@postgres LOG:  statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';
server # [  142.023179] postgres[1157]: ::1 2026-10-27 16:06:52.131 UTC [1157] postgres@postgres LOG:  statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;
server # [  142.030633] postgres[1157]: ::1 2026-10-27 16:06:52.146 UTC [1157] postgres@postgres LOG:  statement: GRANT ALL ON DATABASE postgres TO dashboard_user;
server # [  142.032493] postgres[1157]: ::1 2026-10-27 16:06:52.158 UTC [1157] postgres@postgres LOG:  statement: GRANT ALL ON SCHEMA auth TO dashboard_user;
server # [  142.038806] postgres[1157]: ::1 2026-10-27 16:06:52.165 UTC [1157] postgres@postgres LOG:  statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;
server # [  142.045325] postgres[1157]: ::1 2026-10-27 16:06:52.174 UTC [1157] postgres@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;
server # [  142.046799] postgres[1157]: ::1 2026-10-27 16:06:52.196 UTC [1157] postgres@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;
server # [  142.047987] postgres[1157]: ::1 2026-10-27 16:06:52.203 UTC [1157] postgres@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;
server # [  142.053135] postgres[1157]: ::1 2026-10-27 16:06:52.219 UTC [1157] postgres@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;
server # [  142.061050] postgres[1157]: ::1 2026-10-27 16:06:52.226 UTC [1157] postgres@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;
server # [  142.063963] postgres[1157]: ::1 2026-10-27 16:06:52.270 UTC [1157] postgres@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;
server # [  142.069285] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: GRANT
server # [  142.078303] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: GRANT
server # [  142.118316] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1151]: DO
server # [  142.180269] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running pgbouncer auth schema...
server # [  142.558852] postgres[1166]: ::1 2026-10-27 16:06:52.807 UTC [1166] postgres@postgres LOG:  statement: CREATE USER pgbouncer;
server # [  142.571916] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1165]: CREATE ROLE
server # [  142.574696] postgres[1166]: ::1 2026-10-27 16:06:52.839 UTC [1166] postgres@postgres LOG:  statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;
server # [  142.601928] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1165]: REVOKE
server # [  142.605617] postgres[1166]: ::1 2026-10-27 16:06:52.864 UTC [1166] postgres@postgres LOG:  statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;
server # [  142.650097] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1165]: CREATE SCHEMA
server # [  142.651836] postgres[1166]: ::1 2026-10-27 16:06:52.916 UTC [1166] postgres@postgres LOG:  statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)
server # [  142.665204] postgres[1166]: 	RETURNS TABLE(username TEXT, password TEXT) AS
server # [  142.670530] postgres[1166]: 	$$
server # [  142.671761] postgres[1166]: 	BEGIN
server # [  142.679147] postgres[1166]: 	    RAISE WARNING 'PgBouncer auth request: %', p_usename;
server # [  142.687859] postgres[1166]:
server # [  142.691510] postgres[1166]: 	    RETURN QUERY
server # [  142.698929] postgres[1166]: 	    SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow
server # [  142.709266] postgres[1166]: 	    WHERE usename = p_usename;
server # [  142.715974] postgres[1166]: 	END;
server # [  142.730964] postgres[1166]: 	$$ LANGUAGE plpgsql
server # [  142.746430] postgres[1166]: 	SET search_path = ''
server # [  142.762162] postgres[1166]: 	SECURITY DEFINER;
server # [  142.766736] postgres[1166]: ::1 2026-10-27 16:06:52.935 UTC [1166] postgres@postgres LOG:  statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;
server # [  142.784276] postgres[1166]: ::1 2026-10-27 16:06:52.948 UTC [1166] postgres@postgres LOG:  statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;
server # [  142.790553] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1165]: CREATE FUNCTION
server # [  142.805385] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1165]: REVOKE
server # [  142.809621] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1165]: GRANT
server # [  142.814554] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running stat extension...
server # [  143.067349] postgres[1168]: ::1 2026-10-27 16:06:53.319 UTC [1168] postgres@postgres LOG:  statement: CREATE SCHEMA IF NOT exists extensions;
server # [  143.082808] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1167]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE:  schema "extensions" already exists, skipping
server # [  143.089561] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1167]: CREATE SCHEMA
server # [  143.090767] postgres[1168]: ::1 2026-10-27 16:06:53.351 UTC [1168] postgres@postgres LOG:  statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;
server # [  144.378555] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1167]: CREATE EXTENSION
server # [  144.423683] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql
server # [  144.840231] postgres[1188]: ::1 2026-10-27 16:06:55.082 UTC [1188] supabase_admin@postgres LOG:  statement: GRANT ALL ON DATABASE postgres TO postgres;
server # [  144.852031] postgres[1188]: ::1 2026-10-27 16:06:55.107 UTC [1188] supabase_admin@postgres LOG:  statement: GRANT ALL ON SCHEMA auth TO postgres;
server # [  144.887056] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1181]: GRANT
server # [  144.897136] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1181]: GRANT
server # [  144.918316] postgres[1188]: ::1 2026-10-27 16:06:55.166 UTC [1188] supabase_admin@postgres LOG:  statement: GRANT ALL ON SCHEMA extensions TO postgres;
server # [  144.932814] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1181]: GRANT
server # [  144.934668] postgres[1188]: ::1 2026-10-27 16:06:55.197 UTC [1188] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;
server # [  144.955175] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1181]: GRANT
server # [  144.965579] postgres[1188]: ::1 2026-10-27 16:06:55.230 UTC [1188] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;
server # [  144.982201] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1181]: GRANT
server # [  144.983521] postgres[1188]: ::1 2026-10-27 16:06:55.247 UTC [1188] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;
server # [  144.993944] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1181]: GRANT
server # [  144.997742] postgres[1188]: ::1 2026-10-27 16:06:55.257 UTC [1188] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;
server # [  145.006669] postgres[1188]: ::1 2026-10-27 16:06:55.260 UTC [1188] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;
server # [  145.008990] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1181]: GRANT
server # [  145.016688] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1181]: GRANT
server # [  145.018212] postgres[1188]: ::1 2026-10-27 16:06:55.273 UTC [1188] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;
server # [  145.045650] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1181]: GRANT
server # [  145.081700] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1181]: DO
server # [  145.087302] postgres[1188]: ::1 2026-10-27 16:06:55.344 UTC [1188] supabase_admin@postgres LOG:  statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;
server # [  145.094309] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1181]: ALTER ROLE
server # [  145.142570] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql
server # [  145.470867] postgres[1192]: ::1 2026-10-27 16:06:55.727 UTC [1192] supabase_admin@postgres LOG:  statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;
server # [  145.502921] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: GRANT
server # [  145.508398] postgres[1192]: ::1 2026-10-27 16:06:55.753 UTC [1192] supabase_admin@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;
server # [  145.513893] postgres[1192]: ::1 2026-10-27 16:06:55.766 UTC [1192] supabase_admin@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;
server # [  145.518654] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: GRANT
server # [  145.521703] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: GRANT
server # [  145.522951] postgres[1192]: ::1 2026-10-27 16:06:55.786 UTC [1192] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;
server # [  145.530240] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: ALTER TABLE
server # [  145.534435] postgres[1192]: ::1 2026-10-27 16:06:55.798 UTC [1192] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;
server # [  145.542478] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: ALTER TABLE
server # [  145.550017] postgres[1192]: ::1 2026-10-27 16:06:55.811 UTC [1192] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;
server # [  145.561839] postgres[1192]: ::1 2026-10-27 16:06:55.821 UTC [1192] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;
server # [  145.570471] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: ALTER TABLE
server # [  145.573329] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: ALTER TABLE
server # [  145.574522] postgres[1192]: ::1 2026-10-27 16:06:55.831 UTC [1192] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;
server # [  145.577709] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: ALTER TABLE
server # [  145.582007] postgres[1192]: ::1 2026-10-27 16:06:55.846 UTC [1192] supabase_admin@postgres LOG:  statement: GRANT USAGE ON SCHEMA auth TO postgres;
server # [  145.590081] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: GRANT
server # [  145.594064] postgres[1192]: ::1 2026-10-27 16:06:55.857 UTC [1192] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;
server # [  145.607887] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: GRANT
server # [  145.620887] postgres[1192]: ::1 2026-10-27 16:06:55.883 UTC [1192] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;
server # [  145.646612] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: GRANT
server # [  145.652664] postgres[1192]: ::1 2026-10-27 16:06:55.901 UTC [1192] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;
server # [  145.663438] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: GRANT
server # [  145.668336] postgres[1192]: ::1 2026-10-27 16:06:55.933 UTC [1192] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user;
server # [  145.689428] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: ALTER DEFAULT PRIVILEGES
server # [  145.693775] postgres[1192]: ::1 2026-10-27 16:06:55.956 UTC [1192] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user;
server # [  145.709486] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: ALTER DEFAULT PRIVILEGES
server # [  145.711001] postgres[1192]: ::1 2026-10-27 16:06:55.971 UTC [1192] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user;
server # [  145.729579] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1191]: ALTER DEFAULT PRIVILEGES
server # [  145.798107] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql
server # [  146.074134] postgres[1194]: ::1 2026-10-27 16:06:56.332 UTC [1194] supabase_admin@postgres LOG:  statement: CREATE SCHEMA IF NOT EXISTS realtime;
server # [  146.141202] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1193]: CREATE SCHEMA
server # [  146.152882] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql
server # [  146.462786] postgres[1196]: ::1 2026-10-27 16:06:56.719 UTC [1196] supabase_admin@postgres LOG:  statement: GRANT USAGE ON SCHEMA realtime TO postgres;
server # [  146.494239] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1195]: GRANT
server # [  146.502757] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1195]: GRANT
server # [  146.507582] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1195]: GRANT
server # [  146.510010] postgres[1196]: ::1 2026-10-27 16:06:56.754 UTC [1196] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;
server # [  146.512691] postgres[1196]: ::1 2026-10-27 16:06:56.764 UTC [1196] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;
server # [  146.515490] postgres[1196]: ::1 2026-10-27 16:06:56.767 UTC [1196] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;
server # [  146.520158] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1195]: GRANT
server # [  146.574357] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql
server # [  146.950862] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1197]: DO
server # [  146.959614] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1197]: DO
server # [  146.974566] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1197]: DO
server # [  147.035441] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql
server # [  147.584315] postgres[1207]: ::1 2026-10-27 16:06:57.842 UTC [1207] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user;
server # [  147.624853] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1199]: ALTER DEFAULT PRIVILEGES
server # [  147.629810] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1199]: ALTER DEFAULT PRIVILEGES
server # [  147.635230] postgres[1207]: ::1 2026-10-27 16:06:57.881 UTC [1207] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user;
server # [  147.646757] postgres[1207]: ::1 2026-10-27 16:06:57.894 UTC [1207] supabase_admin@postgres LOG:  statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user;
server # [  147.669956] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1199]: ALTER DEFAULT PRIVILEGES
server # [  147.714815] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql
server # [  148.270808] postgres[1217]: ::1 2026-10-27 16:06:58.510 UTC [1217] supabase_admin@postgres LOG:  statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';
server # [  148.286295] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1212]: ALTER ROLE
server # [  148.359912] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql
server # [  148.765512] postgres[1224]: ::1 2026-10-27 16:06:59.022 UTC [1224] supabase_admin@postgres LOG:  statement: drop event trigger if exists api_restart;
server # [  148.779152] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE:  event trigger "api_restart" does not exist, skipping
server # [  148.787930] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: DROP EVENT TRIGGER
server # [  148.794758] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE:  function extensions.notify_api_restart() does not exist, skipping
server # [  148.797670] postgres[1224]: ::1 2026-10-27 16:06:59.047 UTC [1224] supabase_admin@postgres LOG:  statement: drop function if exists extensions.notify_api_restart();
server # [  148.805445] postgres[1224]: ::1 2026-10-27 16:06:59.056 UTC [1224] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$
server # [  148.812763] postgres[1224]: 	DECLARE
server # [  148.814401] postgres[1224]: 	  cmd record;
server # [  148.815363] postgres[1224]: 	BEGIN
server # [  148.821359] postgres[1224]: 	  FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()
server # [  148.825360] postgres[1224]: 	  LOOP
server # [  148.826429] postgres[1224]: 	    IF cmd.command_tag IN (
server # [  148.827871] postgres[1224]: 	      'CREATE SCHEMA', 'ALTER SCHEMA'
server # [  148.838287] postgres[1224]: 	    , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'
server # [  148.845717] postgres[1224]: 	    , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'
server # [  148.853347] postgres[1224]: 	    , 'CREATE VIEW', 'ALTER VIEW'
server # [  148.854729] postgres[1224]: 	    , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'
server # [  148.857514] postgres[1224]: 	    , 'CREATE FUNCTION', 'ALTER FUNCTION'
server # [  148.866361] postgres[1224]: 	    , 'CREATE TRIGGER'
server # [  148.869896] postgres[1224]: 	    , 'CREATE TYPE'
server # [  148.877900] postgres[1224]: 	    , 'CREATE RULE'
server # [  148.878980] postgres[1224]: 	    , 'COMMENT'
server # [  148.879916] postgres[1224]: 	    )
server # [  148.892579] postgres[1224]: 	    -- don't notify in case of CREATE TEMP table or other objects created on pg_temp
server # [  148.902185] postgres[1224]: 	    AND cmd.schema_name is distinct from 'pg_temp'
server # [  148.908243] postgres[1224]: 	    THEN
server # [  148.920259] postgres[1224]: 	      NOTIFY pgrst, 'reload schema';
server # [  148.942625] postgres[1224]: 	    END IF;
server # [  148.948400] postgres[1224]: 	  END LOOP;
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  148.955025] postgres[1224]: 	END; $$ LANGUAGE plpgsql;
server # [  148.960761] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: DROP FUNCTION
server # [  148.962301] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: CREATE FUNCTION
server # [  148.967487] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: CREATE FUNCTION
server # [  148.973687] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE:  event trigger "pgrst_ddl_watch" does not exist, skipping
server # [  148.983229] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: DROP EVENT TRIGGER
server # [  148.990211] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: CREATE EVENT TRIGGER
server # [  148.995503] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE:  event trigger "pgrst_drop_watch" does not exist, skipping
server # [  149.001493] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: DROP EVENT TRIGGER
server # [  149.008829] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1221]: CREATE EVENT TRIGGER
server # [  149.019717] postgres[1224]: ::1 2026-10-27 16:06:59.099 UTC [1224] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$
server # [  149.026029] postgres[1224]: 	DECLARE
server # [  149.029545] postgres[1224]: 	  obj record;
server # [  149.037268] postgres[1224]: 	BEGIN
server # [  149.039246] postgres[1224]: 	  FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()
server # [  149.044386] postgres[1224]: 	  LOOP
server # [  149.059865] postgres[1224]: 	    IF obj.object_type IN (
server # [  149.069451] postgres[1224]: 	      'schema'
server # [  149.082230] postgres[1224]: 	    , 'table'
server # [  149.087354] postgres[1224]: 	    , 'foreign table'
server # [  149.090592] postgres[1224]: 	    , 'view'
server # [  149.094812] postgres[1224]: 	    , 'materialized view'
server # [  149.097497] postgres[1224]: 	    , 'function'
server # [  149.100742] postgres[1224]: 	    , 'trigger'
server # [  149.104107] postgres[1224]: 	    , 'type'
server # [  149.106689] postgres[1224]: 	    , 'rule'
server # [  149.107925] postgres[1224]: 	    )
server # [  149.111728] postgres[1224]: 	    AND obj.is_temporary IS false -- no pg_temp objects
server # [  149.114009] postgres[1224]: 	    THEN
server # [  149.116612] postgres[1224]: 	      NOTIFY pgrst, 'reload schema';
server # [  149.119778] postgres[1224]: 	    END IF;
server # [  149.122961] postgres[1224]: 	  END LOOP;
server # [  149.126050] postgres[1224]: 	END; $$ LANGUAGE plpgsql;
server # [  149.129699] postgres[1224]: ::1 2026-10-27 16:06:59.118 UTC [1224] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;
server # [  149.134821] postgres[1224]: ::1 2026-10-27 16:06:59.125 UTC [1224] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_ddl_watch
server # [  149.138518] postgres[1224]: 	  ON ddl_command_end
server # [  149.143059] postgres[1224]: 	  EXECUTE PROCEDURE extensions.pgrst_ddl_watch();
server # [  149.146912] postgres[1224]: ::1 2026-10-27 16:06:59.141 UTC [1224] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;
server # [  149.151202] postgres[1224]: ::1 2026-10-27 16:06:59.145 UTC [1224] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_drop_watch
server # [  149.154763] postgres[1224]: 	  ON sql_drop
server # [  149.157763] postgres[1224]: 	  EXECUTE PROCEDURE extensions.pgrst_drop_watch();
server # [  149.165398] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql
server # [  149.999681] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1225]: DO
server # [  150.051982] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql
server # [  150.386337] postgres[1228]: ::1 2026-10-27 16:07:00.622 UTC [1228] supabase_admin@postgres LOG:  statement: create schema if not exists graphql_public;
server # [  150.510389] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: CREATE SCHEMA
server # [  150.523940] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: 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 # [  150.533953] postgres[1228]: ::1 2026-10-27 16:07:00.752 UTC [1228] supabase_admin@postgres LOG:  statement: drop function if exists graphql_public.graphql(text, text, jsonb);
server # [  150.537163] postgres[1228]: ::1 2026-10-27 16:07:00.796 UTC [1228] supabase_admin@postgres LOG:  statement: create or replace function graphql_public.graphql(
server # [  150.538763] postgres[1228]: 	    "operationName" text default null,
server # [  150.540381] postgres[1228]: 	    query text default null,
server # [  150.542504] postgres[1228]: 	    variables jsonb default null,
server # [  150.545262] postgres[1228]: 	    extensions jsonb default null
server # [  150.547405] postgres[1228]: 	)
server # [  150.548988] postgres[1228]: 	    returns jsonb
server # [  150.551333] postgres[1228]: 	    language plpgsql
server # [  150.553774] postgres[1228]: 	as $$
server # [  150.554861] postgres[1228]: 	    DECLARE
server # [  150.557472] postgres[1228]: 	        server_version float;
server # [  150.558465] postgres[1228]: 	    BEGIN
server # [  150.561220] postgres[1228]: 	        server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);
server # [  150.563863] postgres[1228]:
server # [  150.572740] postgres[1228]: 	        IF server_version >= 14 THEN
server # [  150.573970] postgres[1228]: 	            RETURN jsonb_build_object(
server # [  150.577877] postgres[1228]: 	                'data', null::jsonb,
server # [  150.581268] postgres[1228]: 	                'errors', array['pg_graphql extension is not enabled.']
server # [  150.587429] postgres[1228]: 	            );
server # [  150.590060] postgres[1228]: 	        ELSE
server # [  150.591597] postgres[1228]: 	            RETURN jsonb_build_object(
server # [  150.597408] postgres[1228]: 	                'data', null::jsonb,
server # [  150.599067] postgres[1228]: 	                'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']
server # [  150.604981] postgres[1228]: 	            );
server # [  150.611186] postgres[1228]: 	        END IF;
server # [  150.614374] postgres[1228]: 	    END;
server # [  150.615680] postgres[1228]: 	$$;
server # [  150.621854] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: DROP FUNCTION
server # [  150.624465] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: CREATE FUNCTION
server # [  150.631973] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: GRANT
server # [  150.638747] postgres[1228]: ::1 2026-10-27 16:07:00.838 UTC [1228] supabase_admin@postgres LOG:  statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;
server # [  150.642881] postgres[1228]: ::1 2026-10-27 16:07:00.875 UTC [1228] supabase_admin@postgres LOG:  statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;
server # [  150.647227] postgres[1228]: ::1 2026-10-27 16:07:00.896 UTC [1228] supabase_admin@postgres LOG:  statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;
server # [  150.664052] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: ALTER DEFAULT PRIVILEGES
server # [  150.666260] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: ALTER DEFAULT PRIVILEGES
server # [  150.669080] postgres[1228]: ::1 2026-10-27 16:07:00.918 UTC [1228] supabase_admin@postgres LOG:  statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;
server # [  150.678956] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: ALTER DEFAULT PRIVILEGES
server # [  150.681050] postgres[1228]: ::1 2026-10-27 16:07:00.944 UTC [1228] supabase_admin@postgres LOG:  statement: alter default privileges for user supabase_admin in schema graphql_public grant all
server # [  150.682326] postgres[1228]: 	    on sequences to postgres, anon, authenticated, service_role;
server # [  150.697159] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: ALTER DEFAULT PRIVILEGES
server # [  150.698566] postgres[1228]: ::1 2026-10-27 16:07:00.962 UTC [1228] supabase_admin@postgres LOG:  statement: alter default privileges for user supabase_admin in schema graphql_public grant all
server # [  150.700357] postgres[1228]: 	    on tables to postgres, anon, authenticated, service_role;
server # [  150.708382] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: ALTER DEFAULT PRIVILEGES
server # [  150.721259] postgres[1228]: ::1 2026-10-27 16:07:00.973 UTC [1228] supabase_admin@postgres LOG:  statement: alter default privileges for user supabase_admin in schema graphql_public grant all
server # [  150.723660] postgres[1228]: 	    on functions to postgres, anon, authenticated, service_role;
server # [  150.734136] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: ALTER DEFAULT PRIVILEGES
server # [  150.742897] postgres[1228]: ::1 2026-10-27 16:07:01.007 UTC [1228] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()
server # [  150.745543] postgres[1228]: 	RETURNS event_trigger
server # [  150.749938] postgres[1228]: 	LANGUAGE plpgsql
server # [  150.756004] postgres[1228]: 	AS $func$
server # [  150.760989] postgres[1228]: 	    DECLARE
server # [  150.762843] postgres[1228]: 	    func_is_graphql_resolve bool;
server # [  150.764077] postgres[1228]: 	    BEGIN
server # [  150.771464] postgres[1228]: 	    func_is_graphql_resolve = (
server # [  150.775380] postgres[1228]: 	        SELECT n.proname = 'resolve'
server # [  150.781182] postgres[1228]: 	        FROM pg_event_trigger_ddl_commands() AS ev
server # [  150.783883] postgres[1228]: 	        LEFT JOIN pg_catalog.pg_proc AS n
server # [  150.794416] postgres[1228]: 	        ON ev.objid = n.oid
server # [  150.797368] postgres[1228]: 	    );
server # [  150.805417] postgres[1228]:
server # [  150.807617] postgres[1228]: 	    IF func_is_graphql_resolve
server # [  150.810758] postgres[1228]: 	    THEN
server # [  150.811783] postgres[1228]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;
server # [  150.812690] postgres[1228]: 	        grant all on function graphql.resolve to postgres, anon, authenticated, service_role;
server # [  150.836180] postgres[1228]:
server # [  150.845212] postgres[1228]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;
server # [  150.860910] postgres[1228]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;
server # [  150.883558] postgres[1228]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;
server # [  150.898103] postgres[1228]:
server # [  150.901245] postgres[1228]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;
server # [  150.909169] postgres[1228]: 	        create or replace function graphql_public.graphql(
server # [  150.913127] postgres[1228]: 	            "operationName" text default null,
server # [  150.914798] postgres[1228]: 	            query text default null,
server # [  150.919816] postgres[1228]: 	            variables jsonb default null,
server # [  150.928685] postgres[1228]: 	            extensions jsonb default null
server # [  150.933223] postgres[1228]: 	        )
server # [  150.939009] postgres[1228]: 	            returns jsonb
server # [  150.945694] postgres[1228]: 	            language sql
server # [  150.946825] postgres[1228]: 	        as $$
server # [  150.947577] postgres[1228]: 	            SELECT graphql.resolve(query, coalesce(variables, '{}'));
server # [  150.950011] postgres[1228]: 	        $$;
server # [  150.951411] postgres[1228]:
server # [  150.958806] postgres[1228]: 	        grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;
server # [  150.962155] postgres[1228]: 	    END IF;
server # [  150.970688] postgres[1228]:
server # [  150.976572] postgres[1228]: 	    END;
server # [  150.991402] postgres[1228]: 	$func$;
server # [  151.010320] postgres[1228]: ::1 2026-10-27 16:07:01.031 UTC [1228] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;
server # [  151.036763] postgres[1228]: ::1 2026-10-27 16:07:01.042 UTC [1228] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')
server # [  151.041615] postgres[1228]: 	EXECUTE PROCEDURE extensions.grant_pg_graphql_access();
server # [  151.053429] postgres[1228]: ::1 2026-10-27 16:07:01.058 UTC [1228] supabase_admin@postgres LOG:  statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';
server # [  151.059729] postgres[1228]: ::1 2026-10-27 16:07:01.088 UTC [1228] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()
server # [  151.070406] postgres[1228]: 	RETURNS event_trigger
server # [  151.071664] postgres[1228]: 	LANGUAGE plpgsql
server # [  151.076878] postgres[1228]: 	AS $func$
server # [  151.078491] postgres[1228]: 	    DECLARE
server # [  151.081899] postgres[1228]: 	    graphql_is_dropped bool;
server # [  151.085872] postgres[1228]: 	    BEGIN
server # [  151.089528] postgres[1228]: 	    graphql_is_dropped = (
server # [  151.094436] postgres[1228]: 	        SELECT ev.schema_name = 'graphql_public'
server # [  151.098207] postgres[1228]: 	        FROM pg_event_trigger_dropped_objects() AS ev
server # [  151.101520] postgres[1228]: 	        WHERE ev.schema_name = 'graphql_public'
server # [  151.103885] postgres[1228]: 	    );
server # [  151.110275] postgres[1228]:
server # [  151.113248] postgres[1228]: 	    IF graphql_is_dropped
server # [  151.118132] postgres[1228]: 	    THEN
server # [  151.122329] postgres[1228]: 	        create or replace function graphql_public.graphql(
server # [  151.125108] postgres[1228]: 	            "operationName" text default null,
server # [  151.130499] postgres[1228]: 	            query text default null,
server # [  151.134005] postgres[1228]: 	            variables jsonb default null,
server # [  151.137177] postgres[1228]: 	            extensions jsonb default null
server # [  151.139035] postgres[1228]: 	        )
server # [  151.141422] postgres[1228]: 	            returns jsonb
server # [  151.144697] postgres[1228]: 	            language plpgsql
server # [  151.149839] postgres[1228]: 	        as $$
server # [  151.153244] postgres[1228]: 	            DECLARE
server # [  151.157646] postgres[1228]: 	                server_version float;
server # [  151.161766] postgres[1228]: 	            BEGIN
server # [  151.169414] postgres[1228]: 	                server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);
server # [  151.172039] postgres[1228]:
server # [  151.176802] postgres[1228]: 	                IF server_version >= 14 THEN
server # [  151.178588] postgres[1228]: 	                    RETURN jsonb_build_object(
server # [  151.185325] postgres[1228]: 	                        'data', null::jsonb,
server # [  151.188176] postgres[1228]: 	                        'errors', array['pg_graphql extension is not enabled.']
server # [  151.190661] postgres[1228]: 	                    );
server # [  151.192218] postgres[1228]: 	                ELSE
server # [  151.195561] postgres[1228]: 	                    RETURN jsonb_build_object(
server # [  151.202913] postgres[1228]: 	                        'data', null::jsonb,
server # [  151.209963] postgres[1228]: 	                        'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']
server # [  151.213341] postgres[1228]: 	                    );
server # [  151.217676] postgres[1228]: 	                END IF;
server # [  151.225989] postgres[1228]: 	            END;
server # [  151.229477] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: CREATE FUNCTION
server # [  151.233706] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE:  event trigger "issue_pg_graphql_access" does not exist, skipping
server # [  151.236203] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: DROP EVENT TRIGGER
server # [  151.240809] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: CREATE EVENT TRIGGER
server # [  151.242010] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: COMMENT
server # [  151.243211] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: CREATE FUNCTION
server # [  151.249953] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE:  event trigger "issue_graphql_placeholder" does not exist, skipping
server # [  151.255590] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: DROP EVENT TRIGGER
server # [  151.258303] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: CREATE EVENT TRIGGER
server # [  151.263224] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1227]: COMMENT
server # [  151.270214] postgres[1228]: 	        $$;
server # [  151.279107] postgres[1228]: 	    END IF;
server # [  151.281656] postgres[1228]:
server # [  151.282564] postgres[1228]: 	    END;
server # [  151.283322] postgres[1228]: 	$func$;
server # [  151.288382] postgres[1228]: ::1 2026-10-27 16:07:01.210 UTC [1228] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;
server # [  151.294704] postgres[1228]: ::1 2026-10-27 16:07:01.217 UTC [1228] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')
server # [  151.309176] postgres[1228]: 	EXECUTE PROCEDURE extensions.set_graphql_placeholder();
server # [  151.314760] postgres[1228]: ::1 2026-10-27 16:07:01.229 UTC [1228] supabase_admin@postgres LOG:  statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';
server # [  151.325884] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql
server # [  151.482124] postgres[1244]: ::1 2026-10-27 16:07:01.730 UTC [1244] supabase_admin@postgres LOG:  statement: drop event trigger if exists api_restart;
server # [  151.484748] postgres[1244]: ::1 2026-10-27 16:07:01.740 UTC [1244] supabase_admin@postgres LOG:  statement: drop function if exists extensions.notify_api_restart();
server # [  151.491659] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1239]: 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 # [  151.497748] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1239]: DROP EVENT TRIGGER
server # [  151.501286] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1239]: 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 # [  151.505504] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1239]: DROP FUNCTION
server # [  151.508041] postgres[1244]: ::1 2026-10-27 16:07:01.764 UTC [1244] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$
server # [  151.515624] postgres[1244]: 	DECLARE
server # [  151.522028] postgres[1244]: 	  cmd record;
server # [  151.523298] postgres[1244]: 	BEGIN
server # [  151.529367] postgres[1244]: 	  FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()
server # [  151.533593] postgres[1244]: 	  LOOP
server # [  151.537213] postgres[1244]: 	    IF cmd.command_tag IN (
server # [  151.541285] postgres[1244]: 	      'CREATE SCHEMA', 'ALTER SCHEMA'
server # [  151.547820] postgres[1244]: 	    , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'
server # [  151.554615] postgres[1244]: 	    , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'
server # [  151.561116] postgres[1244]: 	    , 'CREATE VIEW', 'ALTER VIEW'
server # [  151.569861] postgres[1244]: 	    , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'
server # [  151.576335] postgres[1244]: 	    , 'CREATE FUNCTION', 'ALTER FUNCTION'
server # [  151.578772] postgres[1244]: 	    , 'CREATE TRIGGER'
server # [  151.586239] postgres[1244]: 	    , 'CREATE TYPE', 'ALTER TYPE'
server # [  151.590315] postgres[1244]: 	    , 'CREATE RULE'
server # [  151.593564] postgres[1244]: 	    , 'COMMENT'
server # [  151.597489] postgres[1244]: 	    )
server # [  151.598770] postgres[1244]: 	    -- don't notify in case of CREATE TEMP table or other objects created on pg_temp
server # [  151.603833] postgres[1244]: 	    AND cmd.schema_name is distinct from 'pg_temp'
server # [  151.614480] postgres[1244]: 	    THEN
server # [  151.621434] postgres[1244]: 	      NOTIFY pgrst, 'reload schema';
server # [  151.630471] postgres[1244]: 	    END IF;
server # [  151.637496] postgres[1244]: 	  END LOOP;
server # [  151.638682] postgres[1244]: 	END; $$ LANGUAGE plpgsql;
server # [  151.649053] postgres[1244]: ::1 2026-10-27 16:07:01.838 UTC [1244] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$
server # [  151.651771] postgres[1244]: 	DECLARE
server # [  151.653909] postgres[1244]: 	  obj record;
server # [  151.661073] postgres[1244]: 	BEGIN
server # [  151.667158] postgres[1244]: 	  FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()
server # [  151.677000] postgres[1244]: 	  LOOP
server # [  151.686126] postgres[1244]: 	    IF obj.object_type IN (
server # [  151.694573] postgres[1244]: 	      'schema'
server # [  151.704960] postgres[1244]: 	    , 'table'
server # [  151.717008] postgres[1244]: 	    , 'foreign table'
server # [  151.718836] postgres[1244]: 	    , 'view'
server # [  151.726987] postgres[1244]: 	    , 'materialized view'
server # [  151.734029] postgres[1244]: 	    , 'function'
server # [  151.734983] postgres[1244]: 	    , 'trigger'
server # [  151.735691] postgres[1244]: 	    , 'type'
server # [  151.736968] postgres[1244]: 	    , 'rule'
server # [  151.745712] postgres[1244]: 	    )
server # [  151.749516] postgres[1244]: 	    AND obj.is_temporary IS false -- no pg_temp objects
server # [  151.757962] postgres[1244]: 	    THEN
server # [  151.759710] postgres[1244]: 	      NOTIFY pgrst, 'reload schema';
server # [  151.765247] postgres[1244]: 	    END IF;
server # [  151.773775] postgres[1244]: 	  END LOOP;
server # [  151.779652] postgres[1244]: 	END; $$ LANGUAGE plpgsql;
server # [  151.785449] postgres[1244]: ::1 2026-10-27 16:07:01.867 UTC [1244] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;
server # [  151.794076] postgres[1244]: ::1 2026-10-27 16:07:01.884 UTC [1244] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_ddl_watch
server # [  151.797086] postgres[1244]: 	  ON ddl_command_end
server # [  151.801617] postgres[1244]: 	  EXECUTE PROCEDURE extensions.pgrst_ddl_watch();
server # [  151.806937] postgres[1244]: ::1 2026-10-27 16:07:01.902 UTC [1244] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;
server # [  151.819188] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1239]: CREATE FUNCTION
server # [  151.821642] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1239]: CREATE FUNCTION
server # [  151.825605] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1239]: DROP EVENT TRIGGER
server # [  151.829138] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1239]: CREATE EVENT TRIGGER
server # [  151.831941] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1239]: DROP EVENT TRIGGER
server # [  151.837799] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1239]: CREATE EVENT TRIGGER
server # [  151.841982] postgres[1244]: ::1 2026-10-27 16:07:01.916 UTC [1244] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_drop_watch
server # [  151.845928] postgres[1244]: 	  ON sql_drop
server # [  151.853139] postgres[1244]: 	  EXECUTE PROCEDURE extensions.pgrst_drop_watch();
server # [  151.857132] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql
server # [  152.147927] postgres[1252]: ::1 2026-10-27 16:07:02.395 UTC [1252] supabase_admin@postgres LOG:  statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;
server # [  152.165158] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1250]: ALTER ROLE
server # [  152.207392] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql
server # [  152.584026] postgres[1254]: ::1 2026-10-27 16:07:02.839 UTC [1254] supabase_admin@postgres LOG:  statement: create or replace function extensions.grant_pg_graphql_access()
server # [  152.587370] postgres[1254]: 	    returns event_trigger
server # [  152.590122] postgres[1254]: 	    language plpgsql
server # [  152.591832] postgres[1254]: 	AS $func$
server # [  152.593419] postgres[1254]: 	DECLARE
server # [  152.595333] postgres[1254]: 	    func_is_graphql_resolve bool;
server # [  152.597910] postgres[1254]: 	BEGIN
server # [  152.599777] postgres[1254]: 	    func_is_graphql_resolve = (
server # [  152.601512] postgres[1254]: 	        SELECT n.proname = 'resolve'
server # [  152.603458] postgres[1254]: 	        FROM pg_event_trigger_ddl_commands() AS ev
server # [  152.605094] postgres[1254]: 	        LEFT JOIN pg_catalog.pg_proc AS n
server # [  152.606002] postgres[1254]: 	        ON ev.objid = n.oid
server # [  152.607464] postgres[1254]: 	    );
server # [  152.611055] postgres[1254]:
server # [  152.612859] postgres[1254]: 	    IF func_is_graphql_resolve
server # [  152.614220] postgres[1254]: 	    THEN
server # [  152.617662] postgres[1254]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;
server # [  152.619325] postgres[1254]: 	        grant all on function graphql.resolve to postgres, anon, authenticated, service_role;
server # [  152.622461] postgres[1254]:
server # [  152.625244] postgres[1254]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;
server # [  152.627611] postgres[1254]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;
server # [  152.629525] postgres[1254]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;
server # [  152.631002] postgres[1254]:
server # [  152.633687] postgres[1254]: 	        -- Update public wrapper to pass all arguments through to the pg_graphql resolve func
server # [  152.635012] postgres[1254]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;
server # [  152.638571] postgres[1254]: 	        create or replace function graphql_public.graphql(
server # [  152.639774] postgres[1254]: 	            "operationName" text default null,
server # [  152.641289] postgres[1254]: 	            query text default null,
server # [  152.642203] postgres[1254]: 	            variables jsonb default null,
server # [  152.643793] postgres[1254]: 	            extensions jsonb default null
server # [  152.645243] postgres[1254]: 	        )
server # [  152.646388] postgres[1254]: 	            returns jsonb
server # [  152.647757] postgres[1254]: 	            language sql
server # [  152.648751] postgres[1254]: 	        as $$
server # [  152.650809] postgres[1254]: 	            -- This changed
server # [  152.652199] postgres[1254]: 	            select graphql.resolve(
server # [  152.653752] postgres[1254]: 	                query := query,
server # [  152.655430] postgres[1254]: 	                variables := coalesce(variables, '{}'),
server # [  152.657732] postgres[1254]: 	                "operationName" := "operationName",
server # [  152.658684] postgres[1254]: 	                extensions := extensions
server # [  152.660403] postgres[1254]: 	            );
server # [  152.661749] postgres[1254]: 	        $$;
server # [  152.662865] postgres[1254]:
server # [  152.664692] postgres[1254]: 	        grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;
server # [  152.666559] postgres[1254]: 	    END IF;
server # [  152.667714] postgres[1254]:
server # [  152.669194] postgres[1254]: 	END;
server # [  152.670463] postgres[1254]: 	$func$;
server # [  152.704513] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1253]: CREATE FUNCTION
server # [  152.706249] postgres[1254]: ::1 2026-10-27 16:07:02.963 UTC [1254] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()
server # [  152.708088] postgres[1254]: 	RETURNS event_trigger
server # [  152.710368] postgres[1254]: 	LANGUAGE plpgsql
server # [  152.712100] postgres[1254]: 	AS $func$
server # [  152.714567] postgres[1254]: 	    DECLARE
server # [  152.717085] postgres[1254]: 	    graphql_is_dropped bool;
server # [  152.718783] postgres[1254]: 	    BEGIN
server # [  152.721684] postgres[1254]: 	    graphql_is_dropped = (
server # [  152.723844] postgres[1254]: 	        SELECT ev.schema_name = 'graphql_public'
server # [  152.726052] postgres[1254]: 	        FROM pg_event_trigger_dropped_objects() AS ev
server # [  152.727276] postgres[1254]: 	        WHERE ev.schema_name = 'graphql_public'
server # [  152.729229] postgres[1254]: 	    );
server # [  152.731482] postgres[1254]:
server # [  152.733619] postgres[1254]: 	    IF graphql_is_dropped
server # [  152.735936] postgres[1254]: 	    THEN
server # [  152.737385] postgres[1254]: 	        create or replace function graphql_public.graphql(
server # [  152.738948] postgres[1254]: 	            "operationName" text default null,
server # [  152.743929] postgres[1254]: 	            query text default null,
server # [  152.747216] postgres[1254]: 	            variables jsonb default null,
server # [  152.750633] postgres[1254]: 	            extensions jsonb default null
server # [  152.753045] postgres[1254]: 	        )
server # [  152.754413] postgres[1254]: 	            returns jsonb
server # [  152.757399] postgres[1254]: 	            language plpgsql
server # [  152.759368] postgres[1254]: 	        as $$
server # [  152.763608] postgres[1254]: 	            DECLARE
server # [  152.766454] postgres[1254]: 	                server_version float;
server # [  152.769663] postgres[1254]: 	            BEGIN
server # [  152.770964] postgres[1254]: 	                server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);
server # [  152.773636] postgres[1254]:
server # [  152.774639] postgres[1254]: 	                IF server_version >= 14 THEN
server # [  152.775923] postgres[1254]: 	                    RETURN jsonb_build_object(
server # [  152.776979] postgres[1254]: 	                        'errors', jsonb_build_array(
server # [  152.781745] postgres[1254]: 	                            jsonb_build_object(
server # [  152.789335] postgres[1254]: 	                                'message', 'pg_graphql extension is not enabled.'
server # [  152.791770] postgres[1254]: 	                            )
server # [  152.795902] postgres[1254]: 	                        )
server # [  152.798117] postgres[1254]: 	                    );
server # [  152.799931] postgres[1254]: 	                ELSE
server # [  152.801783] postgres[1254]: 	                    RETURN jsonb_build_object(
server # [  152.804649] postgres[1254]: 	                        'errors', jsonb_build_array(
server # [  152.807657] postgres[1254]: 	                            jsonb_build_object(
server # [  152.810514] postgres[1254]: 	                                'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'
server # [  152.813005] postgres[1254]: 	                            )
server # [  152.814087] postgres[1254]: 	                        )
server # [  152.814820] postgres[1254]: 	                    );
server # [  152.816906] postgres[1254]: 	                END IF;
server # [  152.818803] postgres[1254]: 	            END;
server # [  152.820314] postgres[1254]: 	        $$;
server # [  152.822524] postgres[1254]: 	    END IF;
server # [  152.823735] postgres[1254]:
server # [  152.824648] postgres[1254]: 	    END;
server # [  152.825361] postgres[1254]: 	$func$;
server # [  152.829481] postgres[1254]: ::1 2026-10-27 16:07:03.029 UTC [1254] supabase_admin@postgres LOG:  statement: create or replace function graphql_public.graphql(
server # [  152.831858] postgres[1254]: 	    "operationName" text default null,
server # [  152.834720] postgres[1254]: 	    query text default null,
server # [  152.835783] postgres[1254]: 	    variables jsonb default null,
server # [  152.838487] postgres[1254]: 	    extensions jsonb default null
server # [  152.840172] postgres[1254]: 	)
server # [  152.845594] postgres[1254]: 	    returns jsonb
server # [  152.846849] postgres[1254]: 	    language plpgsql
server # [  152.848659] postgres[1254]: 	as $$
server # [  152.850469] postgres[1254]: 	    DECLARE
server # [  152.851764] postgres[1254]: 	        server_version float;
server # [  152.854501] postgres[1254]: 	    BEGIN
server # [  152.855612] postgres[1254]: 	        server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);
server # [  152.857366] postgres[1254]:
server # [  152.859044] postgres[1254]: 	        IF server_version >= 14 THEN
server # [  152.861292] postgres[1254]: 	            RETURN jsonb_build_object(
server # [  152.863427] postgres[1254]: 	                'errors', jsonb_build_array(
server # [  152.865913] postgres[1254]: 	                    jsonb_build_object(
server # [  152.867586] postgres[1254]: 	                        'message', 'pg_graphql extension is not enabled.'
server # [  152.871905] postgres[1254]: 	                    )
server # [  152.873452] postgres[1254]: 	                )
server # [  152.874629] postgres[1254]: 	            );
server # [  152.876332] postgres[1254]: 	        ELSE
server # [  152.878511] postgres[1254]: 	            RETURN jsonb_build_object(
server # [  152.880883] postgres[1254]: 	                'errors', jsonb_build_array(
server # [  152.882734] postgres[1254]: 	                    jsonb_build_object(
server # [  152.883631] postgres[1254]: 	                        'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'
server # [  152.886972] postgres[1254]: 	                    )
server # [  152.894093] postgres[1254]: 	                )
server # [  152.897300] postgres[1254]: 	            );
server # [  152.901270] postgres[1254]: 	        END IF;
server # [  152.905541] postgres[1254]: 	    END;
server # [  152.909725] postgres[1254]: 	$$;
server # [  152.913662] postgres[1254]: ::1 2026-10-27 16:07:03.060 UTC [1254] supabase_admin@postgres LOG:  statement: drop extension if exists pg_graphql;
server # [  152.916061] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1253]: CREATE FUNCTION
server # [  152.921355] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1253]: CREATE FUNCTION
server # [  152.923668] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1253]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE:  extension "pg_graphql" does not exist, skipping
server # [  152.926669] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1253]: DROP EXTENSION
server # [  154.614137] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1253]: DO
server # [  154.667305] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql
server # [  155.033415] postgres[1272]: ::1 2026-10-27 16:07:05.279 UTC [1272] supabase_admin@postgres LOG:  statement: grant supabase_auth_admin, supabase_storage_admin to postgres;
server # [  155.066218] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1267]: GRANT ROLE
server # [  155.084813] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql
server # [  155.453056] postgres[1277]: ::1 2026-10-27 16:07:05.700 UTC [1277] supabase_admin@postgres LOG:  statement: create or replace function extensions.grant_pg_graphql_access()
server # [  155.461209] postgres[1277]: 	    returns event_trigger
server # [  155.463479] postgres[1277]: 	    language plpgsql
server # [  155.470612] postgres[1277]: 	AS $func$
server # [  155.481382] postgres[1277]: 	DECLARE
server # [  155.487613] postgres[1277]: 	    func_is_graphql_resolve bool;
server # [  155.494733] postgres[1277]: 	BEGIN
server # [  155.502446] postgres[1277]: 	    func_is_graphql_resolve = (
server # [  155.509738] postgres[1277]: 	        SELECT n.proname = 'resolve'
server # [  155.525237] postgres[1277]: 	        FROM pg_event_trigger_ddl_commands() AS ev
server # [  155.529684] postgres[1277]: 	        LEFT JOIN pg_catalog.pg_proc AS n
server # [  155.537194] postgres[1277]: 	        ON ev.objid = n.oid
server # [  155.559144] postgres[1277]: 	    );
server # [  155.561877] postgres[1277]:
server # [  155.571688] postgres[1277]: 	    IF func_is_graphql_resolve
server # [  155.574080] postgres[1277]: 	    THEN
server # [  155.578780] postgres[1277]: 	        -- Update public wrapper to pass all arguments through to the pg_graphql resolve func
server # [  155.580701] postgres[1277]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;
server # [  155.585506] postgres[1277]: 	        create or replace function graphql_public.graphql(
server # [  155.587971] postgres[1277]: 	            "operationName" text default null,
server # [  155.601364] postgres[1277]: 	            query text default null,
server # [  155.604991] postgres[1277]: 	            variables jsonb default null,
server # [  155.609199] postgres[1277]: 	            extensions jsonb default null
server # [  155.621550] postgres[1277]: 	        )
server # [  155.623717] postgres[1277]: 	            returns jsonb
server # [  155.625678] postgres[1277]: 	            language sql
server # [  155.626943] postgres[1277]: 	        as $$
server # [  155.627841] postgres[1277]: 	            select graphql.resolve(
server # [  155.632927] postgres[1277]: 	                query := query,
server # [  155.634135] postgres[1277]: 	                variables := coalesce(variables, '{}'),
server # [  155.634952] postgres[1277]: 	                "operationName" := "operationName",
server # [  155.636597] postgres[1277]: 	                extensions := extensions
server # [  155.641136] postgres[1277]: 	            );
server # [  155.642832] postgres[1277]: 	        $$;
server # [  155.649708] postgres[1277]:
server # [  155.651978] postgres[1277]: 	        -- This hook executes when `graphql.resolve` is created. That is not necessarily the last
server # [  155.654526] postgres[1277]: 	        -- function in the extension so we need to grant permissions on existing entities AND
server # [  155.656850] postgres[1277]: 	        -- update default permissions to any others that are created after `graphql.resolve`
server # [  155.658536] postgres[1277]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;
server # [  155.662080] postgres[1277]: 	        grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;
server # [  155.665566] postgres[1277]: 	        grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;
server # [  155.674169] postgres[1277]: 	        grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;
server # [  155.675791] postgres[1277]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;
server # [  155.678439] postgres[1277]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;
server # [  155.680004] postgres[1277]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;
server # [  155.684642] postgres[1277]: 	    END IF;
server # [  155.686578] postgres[1277]:
server # [  155.689091] postgres[1277]: 	END;
server # [  155.692104] postgres[1277]: 	$func$;
server # [  155.698544] postgres[1277]: ::1 2026-10-27 16:07:05.867 UTC [1277] supabase_admin@postgres LOG:  statement: drop extension if exists pg_graphql;
server # [  155.708335] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1274]: CREATE FUNCTION
server # [  155.712756] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1274]: DROP EXTENSION
server # [  157.378054] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1274]: DO
server # [  157.438416] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql
server # [  157.985407] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3
server # [  158.717951] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1281]: DO
server # [  159.606751] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1281]: DO
server # [  159.666899] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql
server # [  159.971876] postgres[1304]: ::1 2026-10-27 16:07:10.227 UTC [1304] supabase_admin@postgres LOG:  statement: alter role authenticator set statement_timeout = '8s';
server # [  159.996279] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1303]: ALTER ROLE
server # [  160.053417] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql
server # [  160.334465] postgres[1306]: ::1 2026-10-27 16:07:10.591 UTC [1306] supabase_admin@postgres LOG:  statement: revoke supabase_admin from authenticator;
server # [  160.385574] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1305]: REVOKE ROLE
server # [  160.395303] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql
server # [  162.955935] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1307]: DO
server # [  162.994189] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql
server # [  163.335120] postgres[1330]: ::1 2026-10-27 16:07:13.590 UTC [1330] supabase_admin@postgres LOG:  statement: grant anon, authenticated, service_role to postgres;
server # [  163.351842] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1329]: GRANT ROLE
server # [  163.392008] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql
server # [  163.703178] postgres[1332]: ::1 2026-10-27 16:07:13.952 UTC [1332] supabase_admin@postgres LOG:  statement: grant all privileges on all tables in schema extensions to postgres with grant option;
server # [  163.762636] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1331]: GRANT
server # [  163.768960] postgres[1332]: ::1 2026-10-27 16:07:14.022 UTC [1332] supabase_admin@postgres LOG:  statement: grant all privileges on all routines in schema extensions to postgres with grant option;
server # [  163.799023] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1331]: GRANT
server # [  163.806199] postgres[1332]: ::1 2026-10-27 16:07:14.067 UTC [1332] supabase_admin@postgres LOG:  statement: grant all privileges on all sequences in schema extensions to postgres with grant option;
server # [  163.811741] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1331]: GRANT
server # [  163.815341] postgres[1332]: ::1 2026-10-27 16:07:14.079 UTC [1332] supabase_admin@postgres LOG:  statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;
server # [  163.838060] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1331]: ALTER DEFAULT PRIVILEGES
server # [  163.839837] postgres[1332]: ::1 2026-10-27 16:07:14.103 UTC [1332] supabase_admin@postgres LOG:  statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;
server # [  163.854964] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1331]: ALTER DEFAULT PRIVILEGES
server # [  163.858050] postgres[1332]: ::1 2026-10-27 16:07:14.118 UTC [1332] supabase_admin@postgres LOG:  statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;
server # [  163.869253] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1331]: ALTER DEFAULT PRIVILEGES
server # [  163.929575] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql
server # [  164.187452] postgres[1334]: ::1 2026-10-27 16:07:14.447 UTC [1334] supabase_admin@postgres LOG:  statement: grant pg_monitor to postgres;
server # [  164.235458] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1333]: GRANT ROLE
server # [  164.268620] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql
server # [  164.570709] postgres[1336]: ::1 2026-10-27 16:07:14.827 UTC [1336] supabase_admin@postgres LOG:  statement: grant anon, authenticated, service_role to supabase_storage_admin;
server # [  164.614301] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1335]: GRANT ROLE
server # [  164.636706] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql
server # [  165.022694] postgres[1342]: ::1 2026-10-27 16:07:15.276 UTC [1342] supabase_admin@postgres LOG:  statement: ALTER ROLE authenticated inherit;
server # [  165.051535] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1337]: ALTER ROLE
server # [  165.069312] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1337]: ALTER ROLE
server # [  165.079788] postgres[1342]: ::1 2026-10-27 16:07:15.312 UTC [1342] supabase_admin@postgres LOG:  statement: ALTER ROLE anon inherit;
server # [  165.090059] postgres[1342]: ::1 2026-10-27 16:07:15.330 UTC [1342] supabase_admin@postgres LOG:  statement: ALTER ROLE service_role inherit;
server # [  165.092974] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1337]: ALTER ROLE
server # [  165.170343] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1337]: DO
server # [  165.239195] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql
server # [  165.590107] postgres[1352]: ::1 2026-10-27 16:07:15.838 UTC [1352] supabase_admin@postgres LOG:  statement: grant authenticator to supabase_storage_admin;
server # [  165.623810] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1348]: GRANT ROLE
server # [  165.650716] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1348]: REVOKE ROLE
server # [  165.674273] postgres[1352]: ::1 2026-10-27 16:07:15.882 UTC [1352] supabase_admin@postgres LOG:  statement: revoke anon, authenticated, service_role from supabase_storage_admin;
server # [  165.704825] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql
server # [  166.124431] postgres[1359]: ::1 2026-10-27 16:07:16.369 UTC [1359] supabase_admin@postgres LOG:  statement: create or replace function extensions.grant_pg_graphql_access()
server # [  166.135152] postgres[1359]: 	    returns event_trigger
server # [  166.142290] postgres[1359]: 	    language plpgsql
server # [  166.145883] postgres[1359]: 	AS $func$
server # [  166.153513] postgres[1359]: 	DECLARE
server # [  166.154696] postgres[1359]: 	    func_is_graphql_resolve bool;
server # [  166.161626] postgres[1359]: 	BEGIN
server # [  166.173188] postgres[1359]: 	    func_is_graphql_resolve = (
server # [  166.174278] postgres[1359]: 	        SELECT n.proname = 'resolve'
server # [  166.181279] postgres[1359]: 	        FROM pg_event_trigger_ddl_commands() AS ev
server # [  166.182939] postgres[1359]: 	        LEFT JOIN pg_catalog.pg_proc AS n
server # [  166.184186] postgres[1359]: 	        ON ev.objid = n.oid
server # [  166.189252] postgres[1359]: 	    );
server # [  166.190385] postgres[1359]:
server # [  166.192036] postgres[1359]: 	    IF func_is_graphql_resolve
server # [  166.198812] postgres[1359]: 	    THEN
server # [  166.206134] postgres[1359]: 	        -- Update public wrapper to pass all arguments through to the pg_graphql resolve func
server # [  166.217696] postgres[1359]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;
server # [  166.219851] postgres[1359]: 	        create or replace function graphql_public.graphql(
server # [  166.226505] postgres[1359]: 	            "operationName" text default null,
server # [  166.227770] postgres[1359]: 	            query text default null,
server # [  166.229853] postgres[1359]: 	            variables jsonb default null,
server # [  166.233880] postgres[1359]: 	            extensions jsonb default null
server # [  166.237352] postgres[1359]: 	        )
server # [  166.238372] postgres[1359]: 	            returns jsonb
server # [  166.239636] postgres[1359]: 	            language sql
server # [  166.241073] postgres[1359]: 	        as $$
server # [  166.241907] postgres[1359]: 	            select graphql.resolve(
server # [  166.243563] postgres[1359]: 	                query := query,
server # [  166.248924] postgres[1359]: 	                variables := coalesce(variables, '{}'),
server # [  166.250153] postgres[1359]: 	                "operationName" := "operationName",
server # [  166.250980] postgres[1359]: 	                extensions := extensions
server # [  166.253450] postgres[1359]: 	            );
server # [  166.257823] postgres[1359]: 	        $$;
server # [  166.259644] postgres[1359]:
server # [  166.266186] postgres[1359]: 	        -- This hook executes when `graphql.resolve` is created. That is not necessarily the last
server # [  166.269254] postgres[1359]: 	        -- function in the extension so we need to grant permissions on existing entities AND
server # [  166.270340] postgres[1359]: 	        -- update default permissions to any others that are created after `graphql.resolve`
server # [  166.271694] postgres[1359]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;
server # [  166.273625] postgres[1359]: 	        grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;
server # [  166.277284] postgres[1359]: 	        grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;
server # [  166.279264] postgres[1359]: 	        grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;
server # [  166.285707] postgres[1359]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;
server # [  166.287724] postgres[1359]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;
server # [  166.289640] postgres[1359]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;
server # [  166.292832] postgres[1359]:
server # [  166.293910] postgres[1359]: 	        -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles
server # [  166.294808] postgres[1359]: 	        grant usage on schema graphql_public to postgres with grant option;
server # [  166.301796] postgres[1359]: 	        grant usage on schema graphql to postgres with grant option;
server # [  166.305337] postgres[1359]: 	    END IF;
server # [  166.306769] postgres[1359]:
server # [  166.307945] postgres[1359]: 	END;
server # [  166.311870] postgres[1359]: 	$func$;
server # [  166.317878] postgres[1359]: ::1 2026-10-27 16:07:16.534 UTC [1359] supabase_admin@postgres LOG:  statement: drop extension if exists pg_graphql;
server # [  166.337492] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1356]: CREATE FUNCTION
server # [  166.350490] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1356]: DROP EXTENSION
server # [  167.882856] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1356]: DO
server # [  167.930212] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql
server # [  168.240373] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1363]: DO
server # [  168.272890] postgres[1364]: ::1 2026-10-27 16:07:18.510 UTC [1364] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger
server # [  168.281391] postgres[1364]: 	    LANGUAGE plpgsql
server # [  168.286730] postgres[1364]: 	    AS $$
server # [  168.297980] postgres[1364]: 	BEGIN
server # [  168.311682] postgres[1364]: 	  IF EXISTS (
server # [  168.317552] postgres[1364]: 	    SELECT
server # [  168.319719] postgres[1364]: 	    FROM pg_event_trigger_ddl_commands() AS ev
server # [  168.325575] postgres[1364]: 	    JOIN pg_extension AS ext
server # [  168.326692] postgres[1364]: 	    ON ev.objid = ext.oid
server # [  168.333292] postgres[1364]: 	    WHERE ext.extname = 'pg_cron'
server # [  168.334847] postgres[1364]: 	  )
server # [  168.335603] postgres[1364]: 	  THEN
server # [  168.340745] postgres[1364]: 	    grant usage on schema cron to postgres with grant option;
server # [  168.343286] postgres[1364]:
server # [  168.350128] postgres[1364]: 	    alter default privileges in schema cron grant all on tables to postgres with grant option;
server # [  168.351024] postgres[1364]: 	    alter default privileges in schema cron grant all on functions to postgres with grant option;
server # [  168.353551] postgres[1364]: 	    alter default privileges in schema cron grant all on sequences to postgres with grant option;
server # [  168.354685] postgres[1364]:
server # [  168.365573] postgres[1364]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  168.368896] postgres[1364]: 	        on sequences to postgres with grant option;
server # [  168.370409] postgres[1364]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  168.371823] postgres[1364]: 	        on tables to postgres with grant option;
server # [  168.372549] postgres[1364]: 	    alter default privileges for user supabase_admin in schema cron grant all
server # [  168.375243] postgres[1364]: 	        on functions to postgres with grant option;
server # [  168.376187] postgres[1364]:
server # [  168.378360] postgres[1364]: 	    grant all privileges on all tables in schema cron to postgres with grant option;
server # [  168.381922] postgres[1364]: 	    revoke all on table cron.job from postgres;
server # [  168.392005] postgres[1364]: 	    grant select on table cron.job to postgres with grant option;
server # [  168.394287] postgres[1364]: 	  END IF;
server # [  168.398448] postgres[1364]: 	END;
server # [  168.405102] postgres[1364]: 	$$;
server # [  168.409741] postgres[1364]: ::1 2026-10-27 16:07:18.615 UTC [1364] supabase_admin@postgres LOG:  statement: drop event trigger if exists issue_pg_cron_access;
server # [  168.413879] postgres[1364]: ::1 2026-10-27 16:07:18.639 UTC [1364] supabase_admin@postgres LOG:  statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;
server # [  168.422532] postgres[1364]: ::1 2026-10-27 16:07:18.653 UTC [1364] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end
server # [  168.426465] postgres[1364]: 	         WHEN TAG IN ('CREATE EXTENSION')
server # [  168.433755] postgres[1364]: 	   EXECUTE FUNCTION extensions.grant_pg_cron_access();
server # [  168.442116] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1363]: CREATE FUNCTION
server # [  168.450596] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1363]: DROP EVENT TRIGGER
server # [  168.462783] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1363]: ALTER FUNCTION
server # [  168.482519] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1363]: CREATE EVENT TRIGGER
server # [  168.486024] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql
server # [  168.979202] postgres[1377]: ::1 2026-10-27 16:07:19.207 UTC [1377] supabase_admin@postgres LOG:  statement: ALTER ROLE authenticator set lock_timeout to '8s';
server # [  169.013854] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1370]: ALTER ROLE
server # [  169.033569] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql
server # [  169.412091] postgres[1386]: ::1 2026-10-27 16:07:19.662 UTC [1386] supabase_admin@postgres LOG:  statement: alter function pg_catalog.lo_export owner to supabase_admin;
server # [  169.453555] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1380]: ALTER FUNCTION
server # [  169.457537] postgres[1386]: ::1 2026-10-27 16:07:19.709 UTC [1386] supabase_admin@postgres LOG:  statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;
server # [  169.467295] postgres[1386]: ::1 2026-10-27 16:07:19.726 UTC [1386] supabase_admin@postgres LOG:  statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;
server # [  169.481837] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1380]: ALTER FUNCTION
server # [  169.483500] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1380]: ALTER FUNCTION
server # [  169.521482] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql
server # [  169.812832] postgres[1390]: ::1 2026-10-27 16:07:20.074 UTC [1390] supabase_admin@postgres LOG:  statement: grant pg_read_all_data, pg_signal_backend to postgres;
server # [  169.858331] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1389]: GRANT ROLE
server # [  169.869877] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql
server # [  170.823035] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1391]: DO
server # [  170.876948] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql
server # [  171.303144] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1393]: DO
server # [  171.310373] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1393]: DO
server # [  171.369118] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql
server # [  171.862619] postgres[1407]: ::1 2026-10-27 16:07:22.117 UTC [1407] supabase_admin@postgres LOG:  statement: alter role supabase_admin set log_statement = none;
server # [  171.886656] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1402]: ALTER ROLE
server # [  171.890658] postgres[1407]: ::1 2026-10-27 16:07:22.140 UTC [1407] supabase_admin@postgres LOG:  statement: alter role supabase_auth_admin set log_statement = none;
server # [  171.897949] postgres[1407]: ::1 2026-10-27 16:07:22.154 UTC [1407] supabase_admin@postgres LOG:  statement: alter role supabase_storage_admin set log_statement = none;
server # [  171.901453] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1402]: ALTER ROLE
server # [  171.915306] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1402]: ALTER ROLE
server # [  171.969394] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql
server # [  172.379058] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1412]: DO
server # [  172.425195] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql
server # [  172.811827] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1419]: DO
server # [  172.849080] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql
server # [  173.161215] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1422]: CREATE FUNCTION
server # [  173.178225] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1422]: DO
server # [  173.225888] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql
server # [  173.493925] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1424]: ALTER FUNCTION
server # [  173.498017] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1424]: GRANT
server # [  173.547989] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql
server # [  173.823940] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1426]: DROP EVENT TRIGGER
server # [  173.861637] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1426]: ALTER FUNCTION
server # [  173.874559] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1426]: CREATE EVENT TRIGGER
server # [  173.921155] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql
server # [  174.326933] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1428]: DO
server # [  174.378253] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql
server # [  174.935903] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1440]: CREATE FUNCTION
server # [  174.942481] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1440]: GRANT
server # [  175.010755] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql
server # [  175.326547] systemd[1]: Starting Virtual Console Setup...
server # [  175.455453] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1452]: REVOKE ROLE
server # [  175.515340] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1452]: DO
server # [  175.540751] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1452]: DO
server # [  175.545663] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1452]: REVOKE ROLE
server # [  175.552765] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1452]: REVOKE
server # [  175.606893] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1452]: DO
server # [  175.700191] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql
server # [  175.822020] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [  175.851289] systemd[1]: Stopped Virtual Console Setup.
server # [  176.034266] systemd[1]: Starting Virtual Console Setup...
server # [  176.080527] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1457]: DO
server # [  176.125799] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql
server # [  176.684085] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1461]: DO
server # [  176.737138] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql
server # [  177.342452] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1463]: DO
server # [  177.390191] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql
server # [  177.859959] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1466]: ALTER ROLE
server # [  177.920173] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql
server # [  178.432108] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1468]: GRANT ROLE
server # [  178.467238] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1468]: DO
server # [  178.521706] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_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 # [  179.049571] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1470]: GRANT
server # [  179.108167] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql
server # [  179.681639] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1472]: CREATE FUNCTION
server # [  179.699530] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1472]: REVOKE
server # [  179.729108] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1472]: REVOKE
server # [  179.733787] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1472]: GRANT
server # [  179.757078] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql
server # [  180.430493] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1474]: DO
server # [  180.487991] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql
server # [  181.163637] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1476]: ALTER ROLE
server # [  181.199285] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql
server # [  181.667197] systemd-vconsole-setup[1460]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [  181.703910] systemd[1]: Finished Virtual Console Setup.
server # [  181.758179] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1478]: DROP EXTENSION
server # [  181.815142] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql
server # [  182.172288] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1481]: CREATE FUNCTION
server # [  182.189260] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1481]: DROP EVENT TRIGGER
server # [  182.202336] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1481]: CREATE EVENT TRIGGER
server # [  182.257437] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql
server # [  182.745743] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1483]: DO
server # [  182.809174] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1483]: CREATE FUNCTION
server # [  182.906950] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql
server # [  183.436437] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1496]: CREATE FUNCTION
server # [  183.451768] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1496]: CREATE FUNCTION
server # [  183.508877] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql
server # [  183.816854] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1506]: CREATE FUNCTION
server # [  183.844950] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1506]: CREATE FUNCTION
server # [  183.859777] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1506]: CREATE FUNCTION
server # [  183.877465] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1506]: CREATE FUNCTION
server # [  183.892990] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1506]: CREATE FUNCTION
server # [  183.910623] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1506]: CREATE FUNCTION
server # [  183.959527] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Running postgresql schema...
server # [  184.235027] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER DATABASE
server # [  184.248764] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER DATABASE
server # [  184.317863] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER ROLE
server # [  184.366262] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER ROLE
server # [  184.430357] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER ROLE
server # [  184.489681] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER ROLE
server # [  184.547979] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER ROLE
server # [  184.598657] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER ROLE
server # [  184.685154] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER ROLE
server # [  184.799852] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER ROLE
server # [  184.954206] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER ROLE
server # [  184.976964] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1508]: ALTER ROLE
server # [  185.031852] 1wrg825a3nq6qlidwqp8gr3hd5132j1n-supabase-db-init[1078]: Database initialization complete
server # [  185.077263] systemd[1]: Finished Supabase Database Initialization.
server # [  185.441608] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [  186.213500] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
server # [  186.792228] 8021q: 802.1Q VLAN Support v1.8
server # [  187.329531] cfg80211: Loading compiled-in X.509 certificates for regulatory database
server # [  187.602020] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
server # [  187.603882] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
server # [  187.631128] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
server # [  187.632278] cfg80211: failed to load regulatory.db
server # [  188.415626] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.
server # [  188.467754] systemd[1]: Started backdoor.service.
server # [  188.498275] systemd[1]: Reached target Multi-User System.
server # [  188.517714] systemd[1]: Startup finished in 2.981s (kernel) + 31.652s (initrd) + 2min 33.883s (userspace) = 3min 8.516s.
server # connecting to host...
server # [  189.239050] (udev-worker)[1541]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [  189.273715] (udev-worker)[1540]: Network interface NamePolicy= disabled on kernel command line.
server # [  189.282239] (udev-worker)[1541]: Network interface NamePolicy= disabled on kernel command line.
server: Guest shell says: b'Spawning backdoor root shell...\n'
server: connected to guest root shell
server: (connecting took 190.50 seconds)
server: (finished: waiting for the VM to finish booting, in 190.50 seconds)
server # [  190.262950] systemd[1]: Condition check resulted in Virtio network device being skipped.
server: (finished: waiting for unit supabase-db-init.service, in 191.53 seconds)
subtest: Prepare Regression Scenario
server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS wrappers;" 
server # [  190.374361] systemd[1]: Starting Address configuration of eth1...
server # [  191.327525] 8021q: adding VLAN 0 to HW filter on device eth0
server # [  191.260804] dhcpcd[754]: eth0: waiting for carrier
server # [  191.268349] dhcpcd[754]: eth0: carrier acquired
server # NOTICE:  extension "wrappers" does not exist, skipping
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS wrappers;" , in 1.08 seconds)
server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION wrappers WITH VERSION '0.6.3' CASCADE;" 
server # [  191.545690] dhcpcd[754]: DUID 00:01:00:01:32:73:88:cd:52:54:00:12:34:56
server # [  191.555003] dhcpcd[754]: eth0: IAID 00:12:34:56
server # [  191.667723] 8021q: adding VLAN 0 to HW filter on device eth1
server # [  191.566541] dhcpcd[754]: eth0: adding address fe80::5054:ff:fe12:3456
server # [  191.882516] network-addresses-eth1-start[1574]: adding address 192.168.1.1/24... done
server # [  192.069559] network-addresses-eth1-start[1574]: adding address 2001:db8:1::1/64... done
server # [  192.343435] systemd[1]: Finished Address configuration of eth1.
server # [  193.448699] dhcpcd[754]: eth0: soliciting an IPv6 router
server # [  193.474368] dhcpcd[754]: eth0: Router Advertisement from fe80::2
server # [  193.475831] dhcpcd[754]: eth0: adding address fec0::5054:ff:fe12:3456/64
server # [  193.488139] dhcpcd[754]: eth0: adding route to fec0::/64
server # [  193.489851] dhcpcd[754]: eth0: adding default route via fe80::2
server # [  193.505600] dhcpcd[754]: eth0: soliciting a DHCP lease
server # [  193.534607] dhcpcd[754]: eth0: offered 10.0.2.15 from 10.0.2.2
server # [  193.544923] dhcpcd[754]: eth0: probing address 10.0.2.15/24
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION wrappers WITH VERSION '0.6.3' CASCADE;" , in 4.19 seconds)
server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'wrappers';" 
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'wrappers';" , in 0.81 seconds)
server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "
        CREATE EXTENSION postgres_fdw;
        CREATE SERVER wrappers_upgrade_test FOREIGN DATA WRAPPER postgres_fdw
        OPTIONS (host 'localhost');
    " 
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "
        CREATE EXTENSION postgres_fdw;
        CREATE SERVER wrappers_upgrade_test FOREIGN DATA WRAPPER postgres_fdw
        OPTIONS (host 'localhost');
    " , in 1.45 seconds)
server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT 1 FROM pg_foreign_server WHERE srvname = 'wrappers_upgrade_test';" 
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT 1 FROM pg_foreign_server WHERE srvname = 'wrappers_upgrade_test';" , in 0.70 seconds)
server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION supabase_vault;" 
server # [  199.090671] dhcpcd[754]: eth0: leased 10.0.2.15 for 86400 seconds
server # [  199.107514] dhcpcd[754]: eth0: adding route to 10.0.2.0/24
server # [  199.113934] dhcpcd[754]: eth0: adding default route via 10.0.2.2
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION supabase_vault;" , in 0.68 seconds)
server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT 1 FROM pg_extension WHERE extname = 'supabase_vault';" 
server # [  199.702835] systemd-logind[593]: Watching system buttons on /dev/input/event0 (gpio-keys)
server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT 1 FROM pg_extension WHERE extname = 'supabase_vault';" , in 0.82 seconds)
(finished: subtest: Prepare Regression Scenario, in 9.73 seconds)
subtest: Check Patch Wrappers Without Vault
server: must succeed: /nix/store/020xmprsgd9nh6sg8vaygiv1h1cybgwy-pg_upgrade_scripts/complete.sh execute_wrappers_patch
server: (finished: must succeed: /nix/store/020xmprsgd9nh6sg8vaygiv1h1cybgwy-pg_upgrade_scripts/complete.sh execute_wrappers_patch, in 1.92 seconds)
(finished: subtest: Check Patch Wrappers Without Vault, in 1.92 seconds)
(finished: run the VM test script, in 203.50 seconds)
test script finished in 204.42s
cleanup
kill QemuMachine (pid 13)
server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/76jq0mngg7m8zv5yjz1qgg0xspzi8x2w-python3-3.13.15/bin/python3.13)
(finished: cleanup, in 0.07 seconds)