vm-test-run-wrappers-regression-PSQL-1387
checks.aarch64-linux.ext-wrappers-regression-PSQL-1387
· build #367
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600 seconds5run the VM test script6additionally exposed symbols:7 server,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11server: starting vm12server # Disk image does not exist, creating the virtualisation disk image...13server # Formatting '/build/vm-state-server/tmp.rPeKHehIPd', fmt=raw size=107374182414server # mke2fs 1.47.4 (6-Mar-2025)15server # Discarding device blocks: 0/262144 done16server: QEMU running (pid 13)17server # Creating filesystem with 262144 4k blocks and 65536 inodes18(finished: start all VMs, in 0.13 seconds)19server: waiting for unit supabase-db-init.service20server # Filesystem UUID: 63604480-4f93-41e8-a470-d5daf7d1319821server # Superblock backups stored on blocks:22server # 32768, 98304, 163840, 22937623server # 24server # Allocating group tables: 0/8 done25server # Writing inode tables: 0/8 done26server # Creating journal (8192 blocks): done27server # Writing superblocks and filesystem accounting information: 0/8 done28server # 29server # Virtualisation disk image created.30server # qemu-system-aarch64: Could not access KVM kernel module: No such file or directory31server # qemu-system-aarch64: failed to initialize kvm: No such file or directory32server: waiting for the VM to finish booting33server # qemu-system-aarch64: falling back to tcg34server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]35server # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 202636server # [ 0.000000] KASLR enabled37server # [ 0.000000] random: crng init done38server # [ 0.000000] Machine model: linux,dummy-virt39server # [ 0.000000] efi: UEFI not found.40server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT41server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]42server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f6031c0-0x13f60693f]43server # [ 0.000000] Zone ranges:44server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff]45server # [ 0.000000] DMA32 empty46server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff]47server # [ 0.000000] Device empty48server # [ 0.000000] Movable zone start for each node49server # [ 0.000000] Early memory node ranges50server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff]51server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]52server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe00000053server # [ 0.000000] psci: probing for conduit method from DT.54server # [ 0.000000] psci: PSCIv1.1 detected in firmware.55server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs56server # [ 0.000000] psci: Trusted OS migration not required57server # [ 0.000000] psci: SMC Calling Convention v1.058server # [ 0.000000] percpu: Embedded 76 pages/cpu s186520 r8192 d116584 u31129659server # [ 0.000000] Detected PIPT I-cache on CPU060server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)61server # [ 0.000000] CPU features: detected: GICv3 CPU interface62server # [ 0.000000] CPU features: detected: HCRX_EL2 register63server # [ 0.000000] CPU features: detected: Stage-1 Permission Indirection Extension (S1PIE)64server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2)65server # [ 0.000000] CPU features: detected: Spectre-v466server # [ 0.000000] alternatives: applying boot alternatives67server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/66r413gqlkj8dkxb9rk16rira7faybkp-nixos-system-server-test/init regInfo=/nix/store/dwv4zq1hsjxi5zigcqpnwnjcjd000qd6-closure-info/registration console=ttyAMA0,115200n8 console=tty068server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/dwv4zq1hsjxi5zigcqpnwnjcjd000qd6-closure-info/registration", will be passed to user space.69server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes70server # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)71server # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)72server # [ 0.000000] software IO TLB: area num 2.73server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)74server # [ 0.000000] Fallback order for Node 0: 075server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 104857676server # [ 0.000000] Policy zone: Normal77server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off78server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=179server # [ 0.000000] allocated 8388608 bytes of page_ext80server # [ 0.000000] ftrace: allocating 74832 entries in 294 pages81server # [ 0.000000] ftrace: allocated 294 pages with 4 groups82server # [ 0.000000] rcu: Hierarchical RCU implementation.83server # [ 0.000000] rcu: RCU event tracing is enabled.84server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2.85server # [ 0.000000] Trampoline variant of Tasks RCU enabled.86server # [ 0.000000] Rude variant of Tasks RCU enabled.87server # [ 0.000000] Tracing variant of Tasks RCU enabled.88server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.89server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=290server # [ 0.000000] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.91server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.92server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.93server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 094server # [ 0.000000] GICv3: 256 SPIs implemented95server # [ 0.000000] GICv3: 0 Extended SPIs implemented96server # [ 0.000000] Root IRQ handler: gic_handle_irq97server # [ 0.000000] GICv3: GICv3 features: 16 PPIs98server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=099server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000100server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]101server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b00000 (indirect, esz 8, psz 64K, shr 1)102server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b10000 (flat, esz 8, psz 64K, shr 1)103server # [ 0.000000] GICv3: using LPI property table @0x0000000100b20000104server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b30000105server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.106server # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns107server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).108server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns109server # [ 0.000045] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns110server # [ 0.004525] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)111server # [ 0.018099] Console: colour dummy device 80x25112server # [ 0.019997] printk: legacy console [tty0] enabled113server # [ 0.026285] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)114server # [ 0.026768] pid_max: default: 32768 minimum: 301115server # [ 0.030356] LSM: initializing lsm=capability,landlock,yama,bpf,ima116server # [ 0.032086] landlock: Up and running.117server # [ 0.032156] Yama: becoming mindful.118server # [ 0.036174] LSM support for eBPF active119server # [ 0.039494] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)120server # [ 0.039924] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)121server # [ 0.087077] rcu: Hierarchical SRCU implementation.122server # [ 0.087192] rcu: Max phase no-delay instances is 1000.123server # [ 0.088522] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level124server # [ 0.097500] fsl-mc MSI: its@8080000 domain created125server # [ 0.099889] EFI services will not be available.126server # [ 0.101909] smp: Bringing up secondary CPUs ...127server # [ 0.107905] Detected PIPT I-cache on CPU1128server # [ 0.109572] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000129server # [ 0.110293] GICv3: CPU1: using allocated LPI pending table @0x0000000100b40000130server # [ 0.111853] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]131server # [ 0.116129] smp: Brought up 1 node, 2 CPUs132server # [ 0.116310] SMP: Total of 2 processors activated.133server # [ 0.116364] CPU: All CPU(s) started at EL1134server # [ 0.116572] CPU features: detected: Branch Target Identification135server # [ 0.116628] CPU features: detected: 32-bit EL0 Support136server # [ 0.116662] CPU features: detected: 32-bit EL1 Support137server # [ 0.116696] CPU features: detected: ARMv8.4 Translation Table Level138server # [ 0.116907] CPU features: detected: Instruction cache invalidation not required for I/D coherence139server # [ 0.116963] CPU features: detected: Data cache clean to the PoU not required for I/D coherence140server # [ 0.117037] CPU features: detected: Common not Private translations141server # [ 0.117074] CPU features: detected: CRC32 instructions142server # [ 0.117106] CPU features: detected: Data cache clean to Point of Deep Persistence143server # [ 0.117141] CPU features: detected: Data cache clean to Point of Persistence144server # [ 0.117175] CPU features: detected: Data independent timing control (DIT)145server # [ 0.117209] CPU features: detected: E0PD146server # [ 0.117236] CPU features: detected: Enhanced Counter Virtualization147server # [ 0.117269] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)148server # [ 0.117303] CPU features: detected: Enhanced Privileged Access Never149server # [ 0.117333] CPU features: detected: Enhanced Virtualization Traps150server # [ 0.117366] CPU features: detected: Fine Grained Traps151server # [ 0.117396] CPU features: detected: Guarded Control Stack (GCS)152server # [ 0.117462] CPU features: detected: Generic authentication (IMP DEF algorithm)153server # [ 0.117560] CPU features: detected: RCpc load-acquire (LDAPR)154server # [ 0.117613] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)155server # [ 0.117647] CPU features: detected: LSE atomic instructions156server # [ 0.117675] CPU features: detected: Memory Copy and Memory Set instructions157server # [ 0.117705] CPU features: detected: Privileged Access Never158server # [ 0.117754] CPU features: detected: PMUv3159server # [ 0.117777] CPU features: detected: SCTLR2160server # [ 0.117799] CPU features: detected: RAS Extension Support161server # [ 0.117863] CPU features: detected: RASv1p1 Extension Support162server # [ 0.117893] CPU features: detected: Random Number Generator163server # [ 0.117920] CPU features: detected: Speculation barrier (SB)164server # [ 0.117949] CPU features: detected: Stage-2 Force Write-Back165server # [ 0.117974] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality166server # [ 0.118004] CPU features: detected: TLB range maintenance instructions167server # [ 0.118031] CPU features: detected: WFx with timeout168server # [ 0.118107] CPU features: detected: Scalable Matrix Extension169server # [ 0.118134] CPU features: detected: FA64170server # [ 0.118155] CPU features: detected: SME2171server # [ 0.118177] CPU features: detected: Speculative Store Bypassing Safe (SSBS)172server # [ 0.118205] CPU features: detected: Scalable Vector Extension173server # [ 0.125388] alternatives: applying system-wide alternatives174server # [ 0.140421] CPU features: detected: Hardware dirty bit management on CPU0-1175server # [ 0.141245] SVE: maximum available vector length 256 bytes per vector176server # [ 0.141341] SVE: default vector length 64 bytes per vector177server # [ 0.142453] SME: minimum available vector length 16 bytes per vector178server # [ 0.142504] SME: maximum available vector length 256 bytes per vector179server # [ 0.142548] SME: default vector length 32 bytes per vector180server # [ 0.158865] Memory: 3904064K/4194304K available (24320K kernel code, 7090K rwdata, 26572K rodata, 4736K init, 1103K bss, 241772K reserved, 32768K cma-reserved)181server # [ 0.183235] devtmpfs: initialized182server # [ 0.219348] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear)183server # [ 0.219749] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear).184server # [ 0.222514] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL185server # [ 0.222603] 0 pages in range for non-PLT usage186server # [ 0.222658] 508272 pages in range for PLT usage187server # [ 0.226095] pinctrl core: initialized pinctrl subsystem188server # [ 0.237715] DMI not present or invalid.189server # [ 0.257021] NET: Registered PF_NETLINK/PF_ROUTE protocol family190server # [ 0.269460] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations191server # [ 0.270417] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations192server # [ 0.271755] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations193server # [ 0.272080] audit: initializing netlink subsys (disabled)194server # [ 0.275234] audit: type=2000 audit(0.228:1): state=initialized audit_enabled=0 res=1195server # [ 0.281984] thermal_sys: Registered thermal governor 'fair_share'196server # [ 0.282057] thermal_sys: Registered thermal governor 'bang_bang'197server # [ 0.282132] thermal_sys: Registered thermal governor 'step_wise'198server # [ 0.282168] thermal_sys: Registered thermal governor 'user_space'199server # [ 0.282204] thermal_sys: Registered thermal governor 'power_allocator'200server # [ 0.283021] cpuidle: using governor ladder201server # [ 0.283386] cpuidle: using governor menu202server # [ 0.286130] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.203server # [ 0.286865] ASID allocator initialised with 65536 entries204server # [ 0.295249] Serial: AMBA PL011 UART driver205server # [ 0.356656] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1206server # [ 0.359987] printk: console [ttyAMA0] enabled207server # [ 0.416668] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages208server # [ 0.417011] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page209server # [ 0.417082] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages210server # [ 0.417119] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page211server # [ 0.417158] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages212server # [ 0.417189] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page213server # [ 0.417221] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages214server # [ 0.417254] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page215server # [ 0.445178] fbcon: Taking over console216server # [ 0.445651] ACPI: Interpreter disabled.217server # [ 0.454877] iommu: Default domain type: Translated218server # [ 0.454960] iommu: DMA domain TLB invalidation policy: strict mode219server # [ 0.458653] SCSI subsystem initialized220server # [ 0.467159] usbcore: registered new interface driver usbfs221server # [ 0.467428] usbcore: registered new interface driver hub222server # [ 0.467619] usbcore: registered new device driver usb223server # [ 0.470613] pps_core: LinuxPPS API ver. 1 registered224server # [ 0.470671] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>225server # [ 0.470785] PTP clock support registered226server # [ 0.471063] EDAC MC: Ver: 3.0.0227server # [ 0.472490] scmi_core: SCMI protocol bus registered228server # [ 0.480282] FPGA manager framework229server # [ 0.492028] vgaarb: loaded230server # [ 0.498942] clocksource: Switched to clocksource arch_sys_counter231server # [ 0.523977] VFS: Disk quotas dquot_6.6.0232server # [ 0.524194] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)233server # [ 0.531652] netfs: FS-Cache loaded234server # [ 0.532914] pnp: PnP ACPI: disabled235server # [ 0.596637] NET: Registered PF_INET protocol family236server # [ 0.598031] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)237server # [ 0.717659] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)238server # [ 0.717874] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)239server # [ 0.718042] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)240server # [ 0.718508] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)241server # [ 0.721251] TCP: Hash tables configured (established 32768 bind 32768)242server # [ 0.722826] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)243server # [ 0.724998] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)244server # [ 0.725317] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)245server # [ 0.726789] NET: Registered PF_UNIX/PF_LOCAL protocol family246server # [ 0.727489] NET: Registered PF_XDP protocol family247server # [ 0.728100] PCI: CLS 0 bytes, default 64248server # [ 0.733737] Trying to unpack rootfs image as initramfs...249server # [ 0.736584] kvm [1]: HYP mode not available250server # [ 0.891605] Initialise system trusted keyrings251server # [ 0.900085] workingset: timestamp_bits=42 max_order=20 bucket_order=0252server # [ 0.909216] squashfs: version 4.0 (2009/01/31) Phillip Lougher253server # [ 0.910221] 9p: Installing v9fs 9p2000 file system support254server # [ 0.979636] Key type asymmetric registered255server # [ 0.979826] Asymmetric key parser 'x509' registered256server # [ 0.980183] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)257server # [ 0.985418] io scheduler mq-deadline registered258server # [ 0.985532] io scheduler kyber registered259server # [ 1.028929] pl061_gpio 9030000.pl061: PL061 GPIO chip registered260server # [ 1.035731] ledtrig-cpu: registered to indicate activity on CPUs261server # [ 1.041132] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:262server # [ 1.041681] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000263server # [ 1.042113] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000264server # [ 1.042213] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000265server # [ 1.042734] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits266server # [ 1.045113] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]267server # [ 1.046565] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00268server # [ 1.048087] pci_bus 0000:00: root bus resource [bus 00-ff]269server # [ 1.048209] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]270server # [ 1.048283] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]271server # [ 1.048324] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]272server # [ 1.050177] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint273server # [ 1.057418] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint274server # [ 1.057690] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]275server # [ 1.057774] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]276server # [ 1.057830] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]277server # [ 1.057923] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]278server # [ 1.058501] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint279server # [ 1.058596] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]280server # [ 1.058637] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]281server # [ 1.058677] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282server # [ 1.059090] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint283server # [ 1.059169] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]284server # [ 1.059211] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]285server # [ 1.059253] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]286server # [ 1.066539] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint287server # [ 1.066673] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]288server # [ 1.066725] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]289server # [ 1.068512] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290server # [ 1.069482] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint291server # [ 1.069596] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]292server # [ 1.069644] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]293server # [ 1.069692] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]294server # [ 1.070145] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint295server # [ 1.070243] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]296server # [ 1.070282] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]297server # [ 1.070320] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298server # [ 1.074135] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint299server # [ 1.074260] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]300server # [ 1.074717] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]301server # [ 1.074775] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]302server # [ 1.074822] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]303server # [ 1.077124] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint304server # [ 1.077248] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]305server # [ 1.077296] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]306server # [ 1.077719] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint307server # [ 1.078116] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]308server # [ 1.078167] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]309server # [ 1.078722] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint310server # [ 1.078817] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]311server # [ 1.079292] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint312server # [ 1.079405] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]313server # [ 1.082645] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]314server # [ 1.082846] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]315server # [ 1.086097] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint316server # [ 1.086250] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]317server # [ 1.086302] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]318server # [ 1.086347] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]319server # [ 1.091431] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned320server # [ 1.091631] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned321server # [ 1.091731] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned322server # [ 1.091882] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned323server # [ 1.091957] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned324server # [ 1.092016] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned325server # [ 1.092074] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned326server # [ 1.092126] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned327server # [ 1.092176] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned328server # [ 1.092226] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned329server # [ 1.092276] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned330server # [ 1.092330] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned331server # [ 1.092407] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned332server # [ 1.092468] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned333server # [ 1.092795] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned334server # [ 1.092848] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned335server # [ 1.092892] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned336server # [ 1.092937] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned337server # [ 1.092982] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned338server # [ 1.093026] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned339server # [ 1.093067] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned340server # [ 1.093115] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned341server # [ 1.093158] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned342server # [ 1.093203] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned343server # [ 1.093243] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned344server # [ 1.093298] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned345server # [ 1.093358] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned346server # [ 1.093399] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned347server # [ 1.093439] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned348server # [ 1.093480] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned349server # [ 1.093525] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned350server # [ 1.093573] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned351server # [ 1.093620] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned352server # [ 1.093663] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned353server # [ 1.093959] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]354server # [ 1.094017] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]355server # [ 1.094065] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]356server # [ 1.110344] pci 0000:00:0a.0: enabling device (0000 -> 0002)357server # [ 1.192288] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)358server # [ 1.196615] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)359server # [ 1.198526] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)360server # [ 1.201730] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)361server # [ 1.205406] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)362server # [ 1.208457] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)363server # [ 1.211976] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)364server # [ 1.213993] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)365server # [ 1.216507] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)366server # [ 1.219771] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)367server # [ 1.221877] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)368server # [ 1.244689] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled369server # [ 1.257548] msm_serial: driver initialized370server # [ 1.258413] SuperH (H)SCI(F) driver initialized371server # [ 1.259577] STM32 USART driver initialized372server # [ 1.326287] loop: module loaded373server # [ 1.326898] virtio_blk virtio5: 2/0/0 default/read/poll queues374server # [ 1.332410] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)375server # [ 1.347296] megasas: 07.734.00.00-rc1376server # [ 1.353753] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]377server # [ 1.356993] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000378server # [ 1.357457] Intel/Sharp Extended Query Table at 0x0031379server # [ 1.358472] Using buffer write method380server # [ 1.361271] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]381server # [ 1.362323] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000382server # [ 1.362449] Intel/Sharp Extended Query Table at 0x0031383server # [ 1.363255] Using buffer write method384server # [ 1.363371] Concatenating MTD devices:385server # [ 1.363407] (0): "0.flash"386server # [ 1.363437] (1): "0.flash"387server # [ 1.363467] into device "0.flash"388server # [ 1.926791] Freeing initrd memory: 25488K389server # [ 2.048265] tun: Universal TUN/TAP device driver, 1.6390server # [ 2.064229] thunder_xcv, ver 1.0391server # [ 2.064427] thunder_bgx, ver 1.0392server # [ 2.064575] nicpf, ver 1.0393server # [ 2.068411] e1000: Intel(R) PRO/1000 Network Driver394server # [ 2.068479] e1000: Copyright (c) 1999-2006 Intel Corporation.395server # [ 2.068669] e1000e: Intel(R) PRO/1000 Network Driver396server # [ 2.068763] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.397server # [ 2.068931] igb: Intel(R) Gigabit Ethernet Network Driver398server # [ 2.068969] igb: Copyright (c) 2007-2014 Intel Corporation.399server # [ 2.069116] igbvf: Intel(R) Gigabit Virtual Function Network Driver400server # [ 2.069154] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.401server # [ 2.069932] sky2: driver version 1.30402server # [ 2.081251] ehci-pci 0000:00:0a.0: EHCI Host Controller403server # [ 2.081689] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1404server # [ 2.082311] usbcore: registered new interface driver usb-storage405server # [ 2.082764] usbcore: registered new interface driver usbserial_generic406server # [ 2.082979] usbserial: USB Serial support registered for generic407server # [ 2.083663] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000408server # [ 2.088863] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00409server # [ 2.089447] hv_vmbus: registering driver hyperv_keyboard410server # [ 2.098488] rtc-pl031 9010000.pl031: registered as rtc0411server # [ 2.100017] hub 1-0:1.0: USB hub found412server # [ 2.099879] rtc-pl031 9010000.pl031: setting system clock to 2026-10-20T16:12:20 UTC (1792512740)413server # [ 2.100646] hub 1-0:1.0: 6 ports detected414server # [ 2.102131] i2c_dev: i2c /dev entries driver415server # [ 2.121623] sdhci: Secure Digital Host Controller Interface driver416server # [ 2.121715] sdhci: Copyright(c) Pierre Ossman417server # [ 2.125019] Synopsys Designware Multimedia Card Interface Driver418server # [ 2.128879] sdhci-pltfm: SDHCI platform and OF driver helper419server # [ 2.139641] hid: raw HID events driver (C) Jiri Kosina420server # [ 2.141621] usbcore: registered new interface driver usbhid421server # [ 2.141687] usbhid: USB HID core driver422server # [ 2.153408] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available423server # [ 2.165238] drop_monitor: Initializing network drop monitor service424server # [ 2.166416] NET: Registered PF_INET6 protocol family425server # [ 2.179297] Segment Routing with IPv6426server # [ 2.179755] In-situ OAM (IOAM) with IPv6427server # [ 2.180354] NET: Registered PF_PACKET protocol family428server # [ 2.182346] 9pnet: Installing 9P2000 support429server # [ 2.188637] Key type dns_resolver registered430server # [ 2.233225] registered taskstats version 1431server # [ 2.235470] Loading compiled-in X.509 certificates432server # [ 2.309582] Demotion targets for Node 0: null433server # [ 2.311989] Key type .fscrypt registered434server # [ 2.312223] Key type fscrypt-provisioning registered435server # [ 2.314953] ima: No TPM chip found, activating TPM-bypass!436server # [ 2.315638] ima: Allocated hash algorithm: sha1437server # [ 2.318230] ima: No architecture policies found438server # [ 2.328786] input: gpio-keys as /devices/platform/gpio-keys/input/input0439server # [ 2.363997] usb 1-1: new high-speed USB device number 2 using ehci-pci440server # [ 2.379832] clk: Disabling unused clocks441server # [ 2.380086] PM: genpd: Disabling unused power domains442server # [ 2.564339] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1443server # [ 2.624596] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0444server # [ 2.752208] Freeing unused kernel memory: 4736K445server # [ 2.753939] Run /init as init process446server # [ 2.759996] usb 1-2: new high-speed USB device number 3 using ehci-pci447server # [ 2.926693] systemd[1]: Successfully made /usr/ read-only.448server # [ 2.942086] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2449server # [ 2.948208] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0450server # [ 3.285859] systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)451server # [ 3.286118] systemd[1]: Detected virtualization qemu.452server # [ 3.286443] systemd[1]: Detected architecture arm64.453server # [ 3.286512] systemd[1]: Running in initrd.454server # [ 3.298154] systemd[1]: Initializing machine ID from random generator.455server # [ 3.304431] systemd[1]: Hostname set to <server>.456server # [ 4.023179] systemd[1]: Queued start job for default target Initrd Default Target.457server # [ 4.074780] systemd[1]: Created slice Slice /system/modprobe.458server # [ 4.080971] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.459server # [ 4.081928] systemd[1]: Expecting device /dev/disk/by-label/nixos...460server # [ 4.082381] systemd[1]: Reached target Path Units.461server # [ 4.082580] systemd[1]: Reached target Slice Units.462server # [ 4.082746] systemd[1]: Reached target Swaps.463server # [ 4.083733] systemd[1]: Reached target Timer Units.464server # [ 4.087992] systemd[1]: Listening on D-Bus System Message Bus Socket.465server # [ 4.089794] systemd[1]: Listening on Journal Socket (/dev/log).466server # [ 4.092855] systemd[1]: Listening on Journal Sockets.467server # [ 4.094165] systemd[1]: Listening on udev Control Socket.468server # [ 4.094875] systemd[1]: Listening on udev Kernel Socket.469server # [ 4.096357] systemd[1]: Reached target Socket Units.470server # [ 4.123765] systemd[1]: Starting Create List of Static Device Nodes...471server # [ 4.144798] systemd[1]: Starting Load Kernel Module 9pnet_virtio...472server # [ 4.146436] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs473server # [ 4.196818] systemd[1]: Mounting Kernel Configuration File System...474server # [ 4.283423] systemd[1]: Starting Journal Service...475server # [ 4.324633] systemd[1]: Starting Load Kernel Modules...476server # [ 4.325320] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki477server # [ 4.369726] systemd[1]: Starting Coldplug All udev Devices...478server # [ 4.452661] systemd[1]: Finished Create List of Static Device Nodes.479server # [ 4.563809] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.480server # [ 4.582756] systemd[1]: Finished Load Kernel Module 9pnet_virtio.481server # [ 4.605000] systemd[1]: Mounted Kernel Configuration File System.482server # [ 4.649981] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...483server # [ 4.694812] systemd-journald[81]: Collecting audit messages is disabled.484server # [ 4.879592] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0485server # [ 4.880218] [drm] features: -virgl +edid -resource_blob -host_visible486server # [ 4.880249] [drm] features: -context_init487server # [ 4.885784] [drm] number of scanouts: 1488server # [ 4.885887] [drm] number of cap sets: 0489server # [ 4.892622] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.490server # [ 4.894640] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev491server # [ 4.926333] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic492server # [ 4.926461] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0493server # [ 5.013629] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.494server # [ 5.058224] Console: switching to colour frame buffer device 160x50495server # [ 5.066253] systemd[1]: Starting Create Static Device Nodes in /dev...496server # [ 5.081065] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device497server # [ 5.134736] systemd[1]: Finished Load Kernel Modules.498server # [ 5.181368] systemd[1]: Starting Apply Kernel Variables...499server # [ 5.374496] systemd[1]: Finished Create Static Device Nodes in /dev.500server # [ 5.401949] systemd[1]: Reached target Preparation for Local File Systems.501server # [ 5.406512] systemd[1]: Reached target Local File Systems.502server # [ 5.457137] systemd[1]: Starting Rule-based Manager for Device Events and Files...503server # [ 5.552517] systemd[1]: Finished Apply Kernel Variables.504server # [ 5.638109] systemd[1]: Started Journal Service.505server # [ 5.557460] systemd-modules-load[82]: Using 2 probe threads506server # [ 5.581884] systemd-modules-load[82]: Module 'virtio_balloon' is built in507server # [ 5.592001] systemd-modules-load[82]: Module 'virtio_console' is built in508server # [ 5.603360] systemd-modules-load[82]: Inserted module 'dm_mod'509server # [ 5.619775] systemd-modules-load[82]: Module 'virtio_rng' is built in510server # [ 5.631424] systemd-modules-load[82]: Inserted module 'virtio_gpu'511server # [ 5.639392] systemd[1]: Starting Create System Files and Directories...512server # [ 5.878828] systemd[1]: Finished Create System Files and Directories.513server # [ 5.989568] systemd-udevd[89]: Using default interface naming scheme 'v260'.514server # [ 6.247501] systemd[1]: Started Rule-based Manager for Device Events and Files.515server # [ 6.673139] systemd[1]: Starting Virtual Console Setup...516server # [ 7.003600] systemd-vconsole-setup[112]: Configuration of first virtual console was skipped, ignoring remaining ones.517server # [ 7.027264] systemd[1]: Finished Virtual Console Setup.518server # [ 11.445088] systemd[1]: Finished Coldplug All udev Devices.519server # [ 11.447631] systemd[1]: Reached target System Initialization.520server # [ 11.455158] systemd[1]: Reached target Basic System.521server # [ 13.564200] (udev-worker)[120]: Network interface NamePolicy= disabled on kernel command line.522server # [ 13.935189] (udev-worker)[123]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.523server # [ 13.938183] (udev-worker)[123]: Network interface NamePolicy= disabled on kernel command line.524server # [ 14.202236] systemd[1]: Found device /dev/disk/by-label/nixos.525server # [ 14.291149] systemd[1]: Reached target Initrd Root Device.526server # [ 14.305419] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...527server # [ 14.619925] systemd-fsck[140]: nixos: clean, 12/65536 files, 13019/262144 blocks528server # [ 14.680867] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.529server # [ 14.723071] systemd[1]: Mounting /sysroot...530server # [ 15.059710] EXT4-fs (vda): mounted filesystem 63604480-4f93-41e8-a470-d5daf7d13198 r/w with ordered data mode. Quota mode: none.531server # [ 15.017066] systemd[1]: Mounted /sysroot.532server # [ 15.023614] systemd[1]: Reached target Initrd Root File System.533server # [ 15.042576] systemd[1]: Starting Mountpoints Configured in the Real Root...534server # [ 15.173897] systemd-sysroot-fstab-check[148]: /sysroot should be mounted in the initrd, will request daemon-reload.535server # [ 15.207204] systemd[1]: Reload requested from client PID 148 ('systemd-sysroot') (unit initrd-parse-etc.service)...536server # [ 15.213674] systemd[1]: Reloading...537server # [ 16.383842] systemd[1]: Reloading finished in 1174 ms.538server # [ 16.440102] systemd-sysroot-fstab-check[148]: Requesting initrd-fs.target/start/replace...539server # [ 16.450525] systemd-sysroot-fstab-check[148]: Requesting swap.target/start/replace...540server # [ 16.486941] systemd[1]: Mounting /sysroot/nix/.rw-store...541server # [ 16.505064] systemd[1]: Mounting /sysroot/run...542server # [ 16.549306] systemd[1]: Starting Load Kernel Module 9pnet_virtio...543server # [ 16.559909] systemd[1]: initrd-parse-etc.service: Deactivated successfully.544server # [ 16.567264] systemd[1]: Finished Mountpoints Configured in the Real Root.545server # [ 16.569517] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.546server # [ 16.666104] systemd[1]: Mounted /sysroot/nix/.rw-store.547server # [ 16.718746] systemd[1]: Mounted /sysroot/run.548server # [ 16.741067] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.549server # [ 16.745792] systemd[1]: Finished Load Kernel Module 9pnet_virtio.550server # [ 16.780999] systemd[1]: Mounting /sysroot/nix/.ro-store...551server # [ 16.802605] systemd[1]: Mounting /sysroot/tmp/shared...552server # [ 16.858837] systemd[1]: Mounting /sysroot/tmp/xchg...553server # [ 16.889016] systemd[1]: Starting rw-sysroot-nix-store.service...554server # [ 16.993289] systemd[1]: Mounted /sysroot/tmp/shared.555server # [ 17.001036] systemd[1]: Mounted /sysroot/nix/.ro-store.556server # [ 17.087564] systemd[1]: Mounted /sysroot/tmp/xchg.557server # [ 17.091218] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.558server # [ 17.094502] systemd[1]: Finished rw-sysroot-nix-store.service.559server # [ 17.483700] systemd[1]: Mounting /sysroot/nix/store...560server # [ 17.819749] systemd[1]: Mounted /sysroot/nix/store.561server # [ 17.835990] systemd[1]: Reached target Initrd File Systems.562server # [ 17.854738] systemd[1]: Starting Find NixOS closure...563server # [ 17.890914] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...564server # [ 18.124339] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.565server # [ 18.163166] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.566server # [ 18.373601] systemd[1]: Finished Find NixOS closure.567server # [ 18.387618] systemd[1]: Reached target Initrd Default Target.568server # [ 18.396542] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...569server # [ 18.658495] systemd[1]: Stopped target Initrd Default Target.570server # [ 18.660069] systemd[1]: Stopped target Basic System.571server # [ 18.665268] systemd[1]: Stopped target Initrd Root Device.572server # [ 18.668755] systemd[1]: Stopped target Path Units.573server # [ 18.678652] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.574server # [ 18.685174] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.575server # [ 18.690867] systemd[1]: Stopped target Slice Units.576server # [ 18.693100] systemd[1]: Stopped target Socket Units.577server # [ 18.697650] systemd[1]: Stopped target System Initialization.578server # [ 18.698598] systemd[1]: Stopped target Swaps.579server # [ 18.703555] systemd[1]: Stopped target Timer Units.580server # [ 18.710701] systemd[1]: dbus.socket: Deactivated successfully.581server # [ 18.711930] systemd[1]: Closed D-Bus System Message Bus Socket.582server # [ 18.718606] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.583server # [ 18.733371] systemd[1]: Stopped Find NixOS closure.584server # [ 18.780175] systemd[1]: Starting Load Kernel Module 9pnet_virtio...585server # [ 18.850533] systemd[1]: Starting rw-sysroot-nix-store.service...586server # [ 18.854275] systemd[1]: systemd-sysctl.service: Deactivated successfully.587server # [ 18.862125] systemd[1]: Stopped Apply Kernel Variables.588server # [ 18.887191] systemd[1]: systemd-modules-load.service: Deactivated successfully.589server # [ 18.907494] systemd[1]: Stopped Load Kernel Modules.590server # [ 18.934252] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.591server # [ 18.941762] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.592server # [ 18.957400] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.593server # [ 18.967459] systemd[1]: Stopped Create System Files and Directories.594server # [ 18.989011] systemd[1]: Stopped target Local File Systems.595server # [ 18.992994] systemd[1]: Stopped target Preparation for Local File Systems.596server # [ 18.997697] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.597server # [ 19.022771] systemd[1]: Stopped Coldplug All udev Devices.598server # [ 19.040983] systemd[1]: systemd-udev-trigger.service: Consumed 5.678s CPU time over 14.730s wall clock time, 9.4M memory peak.599server # [ 19.057500] systemd[1]: Stopping Rule-based Manager for Device Events and Files...600server # [ 19.070157] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.601server # [ 19.071438] systemd[1]: Stopped Virtual Console Setup.602server # [ 19.195394] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.603server # [ 19.206123] systemd[1]: Finished Load Kernel Module 9pnet_virtio.604server # [ 19.231574] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.605server # [ 19.235865] systemd[1]: Finished rw-sysroot-nix-store.service.606server # [ 19.325601] systemd[1]: initrd-cleanup.service: Deactivated successfully.607server # [ 19.333570] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.608server # [ 19.834307] systemd[1]: systemd-udevd.service: Deactivated successfully.609server # [ 19.837850] systemd[1]: Stopped Rule-based Manager for Device Events and Files.610server # [ 19.839910] systemd[1]: systemd-udevd.service: Consumed 10.346s CPU time over 14.452s wall clock time, 28.3M memory peak.611server # [ 19.845421] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.612server # [ 19.847700] systemd[1]: Closed udev Control Socket.613server # [ 19.859892] systemd[1]: Starting Cleanup udev Database...614server # [ 19.865560] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.615server # [ 19.867584] systemd[1]: Stopped Create Static Device Nodes in /dev.616server # [ 19.873132] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.617server # [ 19.874174] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.618server # [ 19.875345] systemd[1]: kmod-static-nodes.service: Deactivated successfully.619server # [ 19.878125] systemd[1]: Stopped Create List of Static Device Nodes.620server # [ 20.031197] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.621server # [ 20.035841] systemd[1]: Finished Cleanup udev Database.622server # [ 20.043066] systemd[1]: Reached target Switch Root.623server # [ 20.055922] systemd[1]: Starting NixOS Activation...624server # [ 21.830549] initrd-nixos-activation-start[240]: booting system configuration /nix/store/66r413gqlkj8dkxb9rk16rira7faybkp-nixos-system-server-test625server # [ 22.467627] initrd-nixos-activation-start[240]: running activation script...626server # [ 26.335514] initrd-nixos-activation-start[263]: setting up /etc...627server # [ 28.619744] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.628server # [ 28.622747] systemd[1]: Finished NixOS Activation.629server # [ 28.623981] systemd[1]: initrd-nixos-activation.service: Consumed 4.323s CPU time over 8.562s wall clock time, 22.6M memory peak.630server # [ 28.639348] systemd[1]: Starting Switch Root...631server # [ 28.764554] systemd[1]: Switching root.632server: Guest root shell did not produce any data yet...633server: To debug, enter the VM and run 'systemctl status backdoor.service'.634server # [ 28.989276] systemd-journald[81]: Received SIGTERM from PID 1 (systemd).635server # [ 31.031252] 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)636server # [ 31.034417] systemd[1]: Detected virtualization qemu.637server # [ 31.036698] systemd[1]: Detected architecture arm64.638server # [ 31.039048] systemd[1]: Detected first boot.639server # [ 31.080206] systemd[1]: Initializing machine ID from random generator.640server # [ 32.385867] systemd[1]: bpf-restrict-fs: LSM BPF program attached641server # [ 33.661871] systemd[1]: Applying preset policy.642server # [ 37.494039] systemd[1]: Populated /etc with preset unit settings.643server # [ 42.017547] systemd[1]: initrd-switch-root.service: Deactivated successfully.644server # [ 42.022676] systemd[1]: Stopped initrd-switch-root.service.645server # [ 42.045954] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.646server # [ 42.063786] systemd[1]: Created slice Slice /system/getty.647server # [ 42.076677] systemd[1]: Created slice User and Session Slice.648server # [ 42.082557] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.649server # [ 42.088471] systemd[1]: Started Forward Password Requests to Wall Directory Watch.650server # [ 42.092055] systemd[1]: Expecting device /dev/hvc0...651server # [ 42.095685] systemd[1]: Expecting device /dev/ttyAMA0...652server # [ 42.099405] systemd[1]: Reached target Local Encrypted Volumes.653server # [ 42.102660] systemd[1]: Stopped target initrd-fs.target.654server # [ 42.107113] systemd[1]: Stopped target initrd-root-fs.target.655server # [ 42.111718] systemd[1]: Stopped target initrd-switch-root.target.656server # [ 42.114763] systemd[1]: Reached target Virtual Machines and Containers.657server # [ 42.118430] systemd[1]: Reached target Path Units.658server # [ 42.121913] systemd[1]: Reached target Remote File Systems.659server # [ 42.125468] systemd[1]: Reached target Slice Units.660server # [ 42.129426] systemd[1]: Reached target Swaps.661server # [ 42.162130] systemd[1]: Listening on Process Core Dump Socket.662server # [ 42.187468] systemd[1]: Listening on Credential Encryption/Decryption.663server # [ 42.225505] systemd[1]: Starting Journal Log Access Socket...664server # [ 42.236695] systemd[1]: Listening on Journal Audit Socket.665server # [ 42.243906] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.666server # [ 42.250285] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki667server # [ 42.260270] systemd[1]: Listening on udev Control Socket.668server # [ 42.296284] systemd[1]: Mounting Huge Pages File System...669server # [ 42.327249] systemd[1]: Mounting POSIX Message Queue File System...670server # [ 42.402540] systemd[1]: Mounting Kernel Debug File System...671server # [ 42.492901] systemd[1]: Mounting Kernel Trace File System...672server # [ 42.593539] systemd[1]: Starting Create List of Static Device Nodes...673server # [ 42.701634] systemd[1]: Starting Load Kernel Module 9pnet_virtio...674server # [ 42.718947] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs675server # [ 42.945382] systemd[1]: Mounting Kernel Configuration File System...676server # [ 42.969008] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm677server # [ 43.011063] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore678server # [ 43.181039] systemd[1]: Starting Load Kernel Module fuse...679server # [ 43.210457] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67680server # [ 43.393858] systemd[1]: Starting Journal Service...681server # [ 43.607647] systemd[1]: Starting Load Kernel Modules...682server # [ 43.758635] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...683server # [ 43.870163] fuse: init (API version 7.45)684server # [ 43.929566] systemd[1]: Starting Remount Root and Kernel File Systems...685server # [ 43.959702] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki686server # [ 44.167021] systemd[1]: Starting Coldplug All udev Devices...687server # [ 44.390799] systemd-journald[334]: Collecting audit messages is enabled.688server # [ 44.558277] systemd[1]: Listening on Journal Log Access Socket.689server # [ 44.577909] systemd[1]: Mounted Huge Pages File System.690server # [ 44.598100] systemd[1]: Mounted POSIX Message Queue File System.691server # [ 44.630537] systemd[1]: Mounted Kernel Debug File System.692server # [ 44.657244] systemd[1]: Mounted Kernel Trace File System.693server # [ 44.604928] systemd[1]: Queued start job for default target Multi-User System.694server # [ 44.629147] systemd[1]: systemd-journald.service: Deactivated successfully.695server # [ 44.707756] systemd[1]: Finished Create List of Static Device Nodes.696server # [ 44.636280] systemd[1]: systemd-journald.service: Consumed 1.294s CPU time over 37.663s wall clock time, 9.9M memory peak.697server # [ 44.714898] systemd[1]: Started Journal Service.698server # [ 44.650094] systemd-modules-load[335]: Using 2 probe threads699server # [ 44.657394] systemd-modules-load[335]: Module 'atkbd' is built in700server # [ 44.663780] systemd-modules-load[335]: Module 'loop' is built in701server # [ 44.725548] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.702server # [ 44.750284] systemd[1]: Finished Load Kernel Module 9pnet_virtio.703server # [ 44.778699] systemd[1]: Mounted Kernel Configuration File System.704server # [ 44.794607] systemd[1]: modprobe@fuse.service: Deactivated successfully.705server # [ 44.812287] systemd[1]: Finished Load Kernel Module fuse.706server # [ 44.843735] systemd[1]: Finished Load Kernel Modules.707server # [ 44.953507] EXT4-fs (vda): re-mounted 63604480-4f93-41e8-a470-d5daf7d13198.708server # [ 44.979641] systemd[1]: Finished Remount Root and Kernel File Systems.709server # [ 45.103463] systemd[1]: Mounting FUSE Control File System...710server # [ 45.198230] systemd[1]: Starting Firewall...711server # [ 45.342499] systemd[1]: Starting Flush Journal to Persistent Storage...712server # [ 45.344089] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore713server # [ 45.502767] systemd-oomd[337]: No swap; memory pressure usage will be degraded714server # [ 45.529083] systemd[1]: Starting Load/Save OS Random Seed...715server # [ 45.699801] systemd[1]: Starting Apply Kernel Variables...716server # [ 45.939350] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...717server # [ 45.956034] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki718server # [ 46.077181] systemd-journald[334]: Received client request to flush runtime journal.719server # [ 46.631356] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.720server # [ 46.671508] systemd[1]: Mounted FUSE Control File System.721server # [ 46.708006] systemd[1]: Finished Flush Journal to Persistent Storage.722server # [ 47.048214] systemd[1]: Finished Load/Save OS Random Seed.723server # [ 47.065765] systemd[1]: Reached target First Boot Complete.724server # [ 47.602808] systemd[1]: Finished Apply Kernel Variables.725server # [ 47.866850] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.726server # [ 47.937151] systemd[1]: Starting Create Static Device Nodes in /dev...727server # [ 48.742005] systemd[1]: Finished Create Static Device Nodes in /dev.728server # [ 48.763487] systemd[1]: Reached target Preparation for Local File Systems.729server # [ 48.805712] systemd[1]: Mounting /run/wrappers...730server # [ 48.882108] systemd[1]: Starting Rule-based Manager for Device Events and Files...731server # [ 49.356893] systemd[1]: Mounted /run/wrappers.732server # [ 49.389063] systemd[1]: Reached target Local File Systems.733server # [ 49.443864] systemd[1]: Listening on Boot Loader Control Service Socket.734server # [ 49.517186] systemd[1]: Starting register-nix-paths.service...735server # [ 49.662213] systemd[1]: Starting Create SUID/SGID Wrappers...736server # [ 49.666767] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.737server # [ 49.865104] systemd[1]: Starting Save Transient machine-id to Disk...738server # [ 50.157344] systemd[1]: Starting Create System Files and Directories...739server # [ 51.409375] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.740server # [ 51.427930] systemd[1]: Finished Save Transient machine-id to Disk.741server # [ 52.859434] systemd[1]: Finished Create System Files and Directories.742server # [ 53.069122] systemd[1]: Starting Rebuild Journal Catalog...743server # [ 53.263321] systemd[1]: Starting Record System Boot/Shutdown in UTMP...744server # [ 54.631664] systemd[1]: Finished Record System Boot/Shutdown in UTMP.745server # [ 55.755267] systemd[1]: Finished Rebuild Journal Catalog.746server # [ 55.877366] systemd[1]: Starting Update is Completed...747server # [ 56.696908] systemd[1]: Finished Update is Completed.748server: Guest root shell did not produce any data yet...749server: To debug, enter the VM and run 'systemctl status backdoor.service'.750server # [ 61.265485] systemd-udevd[385]: Using default interface naming scheme 'v260'.751server # [ 62.166514] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.752server # [ 62.213631] systemd[1]: Finished Create SUID/SGID Wrappers.753server # [ 62.234083] systemd[1]: suid-sgid-wrappers.service: Consumed 3.116s CPU time over 12.517s wall clock time, 5.3M memory peak.754server # [ 63.472519] systemd[1]: Started Rule-based Manager for Device Events and Files.755server # [ 65.045931] mousedev: PS/2 mouse device common for all mice756server # [ 64.977353] systemd[1]: Finished register-nix-paths.service.757server # [ 65.922745] systemd[1]: Finished Firewall.758server # [ 68.721392] systemd[1]: Finished Coldplug All udev Devices.759server # [ 68.736139] systemd[1]: Reached target System Initialization.760server # [ 68.740709] systemd[1]: Started Discard unused filesystem blocks once a week.761server # [ 68.746895] systemd[1]: Started Daily Cleanup of Temporary Directories.762server # [ 68.754597] systemd[1]: Reached target Timer Units.763server # [ 68.757307] systemd[1]: Listening on D-Bus System Message Bus Socket.764server # [ 68.763200] systemd[1]: Listening on Nix Daemon Socket.765server # [ 68.780489] systemd[1]: Listening on Hostname Service Socket.766server # [ 68.791969] systemd[1]: Reached target Socket Units.767server # [ 68.796101] systemd[1]: Reached target Basic System.768server # [ 68.807013] systemd[1]: Starting Import lastlog data into lastlog2 database...769server # [ 68.840913] systemd[1]: Starting Name Service Cache Daemon (nsncd)...770server # [ 68.953927] systemd[1]: Starting Post-Boot Actions...771server # [ 69.061044] systemd[1]: Started Reset console on configuration changes.772server # [ 69.299297] systemd[1]: Starting resolvconf update...773server # [ 69.917987] nsncd[591]: Oct 20 16:13:28.323 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"774server # [ 70.086427] systemd[1]: Starting D-Bus System Message Bus...775server # [ 70.107444] systemd[1]: Started Name Service Cache Daemon (nsncd).776server # [ 70.177332] systemd[1]: Finished Post-Boot Actions.777server # [ 70.352993] systemd[1]: Reached target Host and Network Name Lookups.778server # [ 70.355877] systemd[1]: Reached target User and Group Name Lookups.779server # [ 70.589614] systemd[1]: Starting User Login Management...780server # [ 70.676107] systemd[1]: Finished Import lastlog data into lastlog2 database.781server # [ 71.707487] dbus-broker-launch[608]: Looking up NSS user entry for 'systemd-timesync'...782server # [ 71.873154] dbus-broker-launch[608]: NSS returned no entry for 'systemd-timesync'783server # [ 71.874848] dbus-broker-launch[608]: Invalid user-name in /nix/store/vb4579dwh9ydjwd0ir98izga2y9mfbd8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"784server # [ 72.139104] systemd[1]: Started D-Bus System Message Bus.785server # [ 72.625337] systemd-logind[612]: New seat seat0.786server # [ 72.687706] dbus-broker-launch[608]: Ready787server # [ 72.745901] systemd[1]: Started User Login Management.788server # [ 72.844067] systemd[1]: Starting linger-users.service...789server # [ 73.400962] systemd[1]: linger-users.service: Deactivated successfully.790server # [ 73.409814] systemd[1]: Finished linger-users.service.791server # [ 73.423208] systemd-logind[612]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)792server # [ 73.489623] systemd[1]: Stopped target Host and Network Name Lookups.793server # [ 73.496546] systemd[1]: Stopping Host and Network Name Lookups...794server # [ 73.499526] systemd[1]: Stopped target User and Group Name Lookups.795server # [ 73.523638] systemd[1]: Stopping User and Group Name Lookups...796server # [ 73.536006] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...797server # [ 73.560737] systemd[1]: nscd.service: Deactivated successfully.798server # [ 73.573920] systemd[1]: Stopped Name Service Cache Daemon (nsncd).799server # [ 73.797178] systemd[1]: Starting Name Service Cache Daemon (nsncd)...800server # [ 74.507817] systemd[1]: Started Name Service Cache Daemon (nsncd).801server # [ 74.540155] nsncd[664]: Oct 20 16:13:32.974 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"802server # [ 74.546790] systemd[1]: Reached target Host and Network Name Lookups.803server # [ 74.554130] systemd[1]: Reached target User and Group Name Lookups.804server # [ 74.796995] systemd[1]: Finished resolvconf update.805server # [ 74.828321] systemd[1]: Reached target Preparation for Network.806server # [ 74.923913] systemd[1]: Starting DHCP Client...807server # [ 75.039343] systemd[1]: Starting Extra networking commands....808server # [ 77.523094] dhcpcd[713]: dhcpcd-10.3.1 starting809server # [ 77.757324] dhcpcd[750]: dev: loaded udev810server # [ 77.862139] dhcpcd[750]: no valid interfaces found811server # [ 77.870820] dhcpcd[750]: no valid interfaces found812server # [ 78.580550] systemd[1]: Finished Extra networking commands..813server # [ 78.590640] systemd[1]: Reached target Network.814server # [ 78.625561] systemd[1]: Starting PostgreSQL Database Server...815server # [ 78.701981] systemd[1]: Starting Permit User Sessions...816server # [ 79.177354] systemd[1]: Finished Permit User Sessions.817server # [ 79.248199] systemd[1]: Started Getty on tty1.818server # [ 79.263750] systemd[1]: Reached target Login Prompts.819server # [ 79.737304] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[789]: Initializing database at /var/lib/postgresql/data820server # [ 81.369748] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: The files belonging to this database system will be owned by user "postgres".821server # [ 81.378584] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: This user must also own the server process.822server # [ 81.433570] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: The database cluster will be initialized with locale "en_US.UTF-8".823server # [ 81.435057] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: The default database encoding has accordingly been set to "UTF8".824server # [ 81.437698] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: The default text search configuration will be set to "english".825server # [ 81.445169] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: Data page checksums are enabled.826server # [ 81.446749] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: fixing permissions on existing directory /var/lib/postgresql/data ... ok827server # [ 81.451117] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: creating subdirectories ... ok828server # [ 81.461067] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: selecting dynamic shared memory implementation ... posix829server # [ 82.391955] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: selecting default max_connections ... 100830server # [ 83.088230] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: selecting default shared_buffers ... 128MB831server: Guest root shell did not produce any data yet...832server: To debug, enter the VM and run 'systemctl status backdoor.service'.833server # [ 92.176629] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: selecting default time zone ... UTC834server # [ 92.226574] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: creating configuration files ... ok835server # [ 95.679190] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: running bootstrap script ... ok836server # [ 103.753689] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: performing post-bootstrap initialization ... ok837server # [ 106.445628] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: syncing data to disk ... ok838server # [ 106.450113] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: initdb: warning: enabling "trust" authentication for local connections839server # [ 106.454201] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: 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.840server # [ 106.455443] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: Success. You can now start the database server using:841server # [ 106.456922] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[790]: /nix/store/kmnd5gvx821z68z9nchjmhqasm8d9f2y-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start842server # [ 107.635178] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[789]: Validating PostgreSQL configuration...843server # [ 107.902885] dhcpcd[750]: timed out844server # [ 107.904768] dhcpcd[750]: timed out845server # [ 107.936571] systemd[1]: Started DHCP Client.846server # [ 108.013552] 9wk9h0k99xw5a7aqmz3wwff2zmxnyg3z-postgresql-init[993]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault847server # [ 108.398888] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3848server # [ 108.916125] postgres[1002]: 2026-10-20 16:14:07.389 UTC [1002] LOG: pgaudit extension initialized849server # [ 109.513166] postgres[1002]: 2026-10-20 16:14:07.991 UTC [1002] LOG: pgsodium primary server secret key loaded850server # [ 109.984261] postgres[1002]: 2026-10-20 16:14:08.459 UTC [1002] LOG: vault primary server secret key loaded851server # [ 110.274264] postgres[1002]: 2026-10-20 16:14:08.749 UTC [1002] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.3.0, 64-bit852server # [ 110.281806] postgres[1002]: 2026-10-20 16:14:08.760 UTC [1002] LOG: listening on IPv4 address "0.0.0.0", port 5432853server # [ 110.286755] postgres[1002]: 2026-10-20 16:14:08.762 UTC [1002] LOG: listening on IPv6 address "::", port 5432854server # [ 110.298420] postgres[1002]: 2026-10-20 16:14:08.774 UTC [1002] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"855server # [ 110.387355] postgres[1021]: 2026-10-20 16:14:08.842 UTC [1021] LOG: database system was shut down at 2026-10-20 16:14:02 UTC856server # [ 110.504579] postgres[1024]: 2026-10-20 16:14:08.977 UTC [1024] LOG: TimescaleDB background worker launcher connected to shared catalogs857server # [ 110.535427] postgres[1002]: 2026-10-20 16:14:09.007 UTC [1002] LOG: database system is ready to accept connections858server # [ 110.587721] postgres[1025]: 2026-10-20 16:14:09.053 UTC [1025] FATAL: role "postgres" does not exist859server # [ 110.630096] systemd[1]: Started PostgreSQL Database Server.860server # [ 110.663883] postgres[1026]: 2026-10-20 16:14:09.125 UTC [1026] LOG: pg_cron scheduler started861server # [ 110.679846] postgres[1002]: 2026-10-20 16:14:09.158 UTC [1002] LOG: background worker "pg_net 0.20.4 worker" (PID 1025) exited with exit code 1862server # [ 110.707739] systemd[1]: Starting Supabase Database Initialization...863server # [ 111.051333] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Waiting for PostgreSQL to be ready...864server # [ 111.614924] postgres[1046]: ::1 2026-10-20 16:14:10.078 UTC [1046] root@root FATAL: role "root" does not exist865server # [ 111.628951] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: PostgreSQL is ready866server # [ 111.631290] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Creating postgres role...867server # [ 111.741300] postgres[1050]: 2026-10-20 16:14:10.204 UTC [1050] FATAL: role "postgres" does not exist868server # [ 111.781811] postgres[1002]: 2026-10-20 16:14:10.256 UTC [1002] LOG: background worker "pg_net 0.20.4 worker" (PID 1050) exited with exit code 1869server # [ 112.007360] postgres[1053]: ::1 2026-10-20 16:14:10.473 UTC [1053] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN;870server # [ 112.026651] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1048]: CREATE ROLE871server # [ 112.271519] postgres[1057]: ::1 2026-10-20 16:14:10.735 UTC [1057] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres;872server # [ 112.286119] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1056]: ALTER DATABASE873server # [ 112.324112] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql874server # [ 112.604160] postgres[1059]: ::1 2026-10-20 16:14:11.068 UTC [1059] postgres@postgres LOG: statement: create publication supabase_realtime;875server # [ 112.638927] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: CREATE PUBLICATION876server # [ 112.647819] postgres[1059]: ::1 2026-10-20 16:14:11.113 UTC [1059] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls;877server # [ 112.654261] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: ALTER ROLE878server # [ 112.659851] postgres[1059]: ::1 2026-10-20 16:14:11.134 UTC [1059] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication;879server # [ 112.674091] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: CREATE ROLE880server # [ 112.678562] postgres[1059]: ::1 2026-10-20 16:14:11.157 UTC [1059] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls;881server # [ 112.687802] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: CREATE ROLE882server # [ 112.697939] postgres[1059]: ::1 2026-10-20 16:14:11.173 UTC [1059] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin;883server # [ 112.710555] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: GRANT ROLE884server # [ 112.712285] postgres[1059]: ::1 2026-10-20 16:14:11.188 UTC [1059] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin;885server # [ 112.725423] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: GRANT886server # [ 112.733479] postgres[1059]: ::1 2026-10-20 16:14:11.203 UTC [1059] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls;887server # [ 112.735885] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: CREATE ROLE888server # [ 112.745090] postgres[1059]: ::1 2026-10-20 16:14:11.214 UTC [1059] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user;889server # [ 112.746508] postgres[1059]: ::1 2026-10-20 16:14:11.222 UTC [1059] postgres@postgres LOG: statement: create schema if not exists extensions;890server # [ 112.755001] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: GRANT ROLE891server # [ 112.757846] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: CREATE SCHEMA892server # [ 112.760447] postgres[1059]: ::1 2026-10-20 16:14:11.233 UTC [1059] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions;893server # [ 115.366593] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: CREATE EXTENSION894server # [ 115.401739] postgres[1059]: ::1 2026-10-20 16:14:13.837 UTC [1059] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions;895server # [ 116.333007] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: CREATE EXTENSION896server # [ 116.339557] postgres[1059]: ::1 2026-10-20 16:14:14.818 UTC [1059] postgres@postgres LOG: statement: create role anon nologin noinherit;897server # [ 116.351979] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: CREATE ROLE898server # [ 116.357920] postgres[1059]: ::1 2026-10-20 16:14:14.835 UTC [1059] postgres@postgres LOG: statement: create role authenticated nologin noinherit;899server # [ 116.374086] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: CREATE ROLE900server # [ 116.377945] postgres[1059]: ::1 2026-10-20 16:14:14.849 UTC [1059] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls;901server # [ 116.383184] postgres[1059]: ::1 2026-10-20 16:14:14.861 UTC [1059] postgres@postgres LOG: statement: create user authenticator noinherit;902server # [ 116.390571] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: CREATE ROLE903server # [ 116.393128] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: CREATE ROLE904server # [ 116.405249] postgres[1059]: ::1 2026-10-20 16:14:14.868 UTC [1059] postgres@postgres LOG: statement: grant anon to authenticator;905server # [ 116.409090] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: GRANT ROLE906server # [ 116.411147] postgres[1059]: ::1 2026-10-20 16:14:14.880 UTC [1059] postgres@postgres LOG: statement: grant authenticated to authenticator;907server # [ 116.418201] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: GRANT ROLE908server # [ 116.422117] postgres[1059]: ::1 2026-10-20 16:14:14.898 UTC [1059] postgres@postgres LOG: statement: grant service_role to authenticator;909server # [ 116.427307] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: GRANT ROLE910server # [ 116.434388] postgres[1059]: ::1 2026-10-20 16:14:14.908 UTC [1059] postgres@postgres LOG: statement: grant supabase_admin to authenticator;911server # [ 116.438123] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: GRANT ROLE912server # [ 116.442502] postgres[1059]: ::1 2026-10-20 16:14:14.917 UTC [1059] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role;913server # [ 116.447947] postgres[1059]: ::1 2026-10-20 16:14:14.925 UTC [1059] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;914server # [ 116.454218] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: GRANT915server # [ 116.465558] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: ALTER DEFAULT PRIVILEGES916server # [ 116.467988] postgres[1059]: ::1 2026-10-20 16:14:14.945 UTC [1059] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;917server # [ 116.477162] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: ALTER DEFAULT PRIVILEGES918server # [ 116.482796] postgres[1059]: ::1 2026-10-20 16:14:14.959 UTC [1059] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;919server # [ 116.489496] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: ALTER DEFAULT PRIVILEGES920server # [ 116.498127] postgres[1059]: ::1 2026-10-20 16:14:14.973 UTC [1059] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role;921server # [ 116.504968] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: GRANT922server # [ 116.509164] postgres[1059]: ::1 2026-10-20 16:14:14.987 UTC [1059] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions;923server # [ 116.521061] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: ALTER ROLE924server # [ 116.525247] postgres[1059]: ::1 2026-10-20 16:14:15.002 UTC [1059] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all925server # [ 116.531363] postgres[1059]: on sequences to postgres, anon, authenticated, service_role;926server # [ 116.542665] postgres[1059]: ::1 2026-10-20 16:14:15.018 UTC [1059] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all927server # [ 116.548877] postgres[1059]: on tables to postgres, anon, authenticated, service_role;928server # [ 116.557051] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: ALTER DEFAULT PRIVILEGES929server # [ 116.565321] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: ALTER DEFAULT PRIVILEGES930server # [ 116.567074] postgres[1059]: ::1 2026-10-20 16:14:15.030 UTC [1059] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all931server # [ 116.573004] postgres[1059]: on functions to postgres, anon, authenticated, service_role;932server # [ 116.574982] postgres[1059]: ::1 2026-10-20 16:14:15.043 UTC [1059] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s';933server # [ 116.578609] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: ALTER DEFAULT PRIVILEGES934server # [ 116.583387] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: ALTER ROLE935server # [ 116.586097] postgres[1059]: ::1 2026-10-20 16:14:15.053 UTC [1059] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s';936server # [ 116.588044] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1058]: ALTER ROLE937server # [ 116.659123] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql938server # [ 116.915495] postgres[1082]: ::1 2026-10-20 16:14:15.383 UTC [1082] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;939server # [ 116.933459] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE SCHEMA940server # [ 116.938122] postgres[1082]: ::1 2026-10-20 16:14:15.409 UTC [1082] postgres@postgres LOG: statement: CREATE TABLE auth.users (941server # [ 116.946782] postgres[1082]: instance_id uuid NULL,942server # [ 116.949769] postgres[1082]: id uuid NOT NULL UNIQUE,943server # [ 116.951275] postgres[1082]: aud varchar(255) NULL,944server # [ 116.953187] postgres[1082]: "role" varchar(255) NULL,945server # [ 116.954922] postgres[1082]: email varchar(255) NULL UNIQUE,946server # [ 116.958561] postgres[1082]: encrypted_password varchar(255) NULL,947server # [ 116.960552] postgres[1082]: confirmed_at timestamptz NULL,948server # [ 116.965628] postgres[1082]: invited_at timestamptz NULL,949server # [ 116.967980] postgres[1082]: confirmation_token varchar(255) NULL,950server # [ 116.971571] postgres[1082]: confirmation_sent_at timestamptz NULL,951server # [ 116.975591] postgres[1082]: recovery_token varchar(255) NULL,952server # [ 116.979100] postgres[1082]: recovery_sent_at timestamptz NULL,953server # [ 116.983714] postgres[1082]: email_change_token varchar(255) NULL,954server # [ 116.987784] postgres[1082]: email_change varchar(255) NULL,955server # [ 116.990419] postgres[1082]: email_change_sent_at timestamptz NULL,956server # [ 116.992452] postgres[1082]: last_sign_in_at timestamptz NULL,957server # [ 116.995978] postgres[1082]: raw_app_meta_data jsonb NULL,958server # [ 116.999459] postgres[1082]: raw_user_meta_data jsonb NULL,959server # [ 117.001877] postgres[1082]: is_super_admin bool NULL,960server # [ 117.004070] postgres[1082]: created_at timestamptz NULL,961server # [ 117.010895] postgres[1082]: updated_at timestamptz NULL,962server # [ 117.024582] postgres[1082]: CONSTRAINT users_pkey PRIMARY KEY (id)963server # [ 117.031047] postgres[1082]: );964server # [ 117.123403] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE TABLE965server # [ 117.129320] postgres[1082]: ::1 2026-10-20 16:14:15.606 UTC [1082] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);966server # [ 117.179607] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE INDEX967server # [ 117.205618] postgres[1082]: ::1 2026-10-20 16:14:15.653 UTC [1082] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);968server # [ 117.240686] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE INDEX969server # [ 117.246066] postgres[1082]: ::1 2026-10-20 16:14:15.723 UTC [1082] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';970server # [ 117.263375] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: COMMENT971server # [ 117.270188] postgres[1082]: ::1 2026-10-20 16:14:15.745 UTC [1082] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens (972server # [ 117.274230] postgres[1082]: instance_id uuid NULL,973server # [ 117.285846] postgres[1082]: id bigserial NOT NULL,974server # [ 117.287861] postgres[1082]: "token" varchar(255) NULL,975server # [ 117.293764] postgres[1082]: user_id varchar(255) NULL,976server # [ 117.295246] postgres[1082]: revoked bool NULL,977server # [ 117.301608] postgres[1082]: created_at timestamptz NULL,978server # [ 117.303199] postgres[1082]: updated_at timestamptz NULL,979server # [ 117.305388] postgres[1082]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)980server # [ 117.309123] postgres[1082]: );981server # [ 117.426350] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE TABLE982server # [ 117.428597] postgres[1082]: ::1 2026-10-20 16:14:15.906 UTC [1082] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);983server # [ 117.472473] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE INDEX984server # [ 117.478118] postgres[1082]: ::1 2026-10-20 16:14:15.954 UTC [1082] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id);985server # [ 117.510567] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE INDEX986server # [ 117.515719] postgres[1082]: ::1 2026-10-20 16:14:15.992 UTC [1082] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);987server # [ 117.561988] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE INDEX988server # [ 117.570299] postgres[1082]: ::1 2026-10-20 16:14:16.047 UTC [1082] postgres@postgres LOG: statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.';989server # [ 117.579949] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: COMMENT990server # [ 117.581700] postgres[1082]: ::1 2026-10-20 16:14:16.060 UTC [1082] postgres@postgres LOG: statement: CREATE TABLE auth.instances (991server # [ 117.587618] postgres[1082]: id uuid NOT NULL,992server # [ 117.593058] postgres[1082]: uuid uuid NULL,993server # [ 117.594464] postgres[1082]: raw_base_config text NULL,994server # [ 117.597684] postgres[1082]: created_at timestamptz NULL,995server # [ 117.601699] postgres[1082]: updated_at timestamptz NULL,996server # [ 117.606884] postgres[1082]: CONSTRAINT instances_pkey PRIMARY KEY (id)997server # [ 117.608185] postgres[1082]: );998server # [ 117.669502] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE TABLE999server # [ 117.677924] postgres[1082]: ::1 2026-10-20 16:14:16.157 UTC [1082] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';1000server # [ 117.690865] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: COMMENT1001server # [ 117.702236] postgres[1082]: ::1 2026-10-20 16:14:16.176 UTC [1082] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries (1002server # [ 117.705774] postgres[1082]: instance_id uuid NULL,1003server # [ 117.706755] postgres[1082]: id uuid NOT NULL,1004server # [ 117.707746] postgres[1082]: payload json NULL,1005server # [ 117.709436] postgres[1082]: created_at timestamptz NULL,1006server # [ 117.714189] postgres[1082]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)1007server # [ 117.716450] postgres[1082]: );1008server # [ 117.797036] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE TABLE1009server # [ 117.801834] postgres[1082]: ::1 2026-10-20 16:14:16.276 UTC [1082] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);1010server # [ 117.835751] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE INDEX1011server # [ 117.844800] postgres[1082]: ::1 2026-10-20 16:14:16.323 UTC [1082] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';1012server # [ 117.859580] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: COMMENT1013server # [ 117.862269] postgres[1082]: ::1 2026-10-20 16:14:16.340 UTC [1082] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations (1014server # [ 117.863958] postgres[1082]: "version" varchar(255) NOT NULL,1015server # [ 117.866354] postgres[1082]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")1016server # [ 117.868949] postgres[1082]: );1017server # [ 117.909483] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE TABLE1018server # [ 117.931887] postgres[1082]: ::1 2026-10-20 16:14:16.383 UTC [1082] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';1019server # [ 117.963872] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: COMMENT1020server # [ 117.981897] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: INSERT 0 71021server # [ 117.992446] postgres[1082]: ::1 2026-10-20 16:14:16.459 UTC [1082] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$1022server # [ 117.995751] postgres[1082]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;1023server # [ 118.000524] postgres[1082]: $$ language sql stable;1024server # [ 118.014773] postgres[1082]: ::1 2026-10-20 16:14:16.489 UTC [1082] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$1025server # [ 118.018405] postgres[1082]: select nullif(current_setting('request.jwt.claim.role', true), '')::text;1026server # [ 118.029459] postgres[1082]: $$ language sql stable;1027server # [ 118.041808] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE FUNCTION1028server # [ 118.054987] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE FUNCTION1029server # [ 118.057793] postgres[1082]: ::1 2026-10-20 16:14:16.510 UTC [1082] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$1030server # [ 118.060510] postgres[1082]: select nullif(current_setting('request.jwt.claim.email', true), '')::text;1031server # [ 118.065083] postgres[1082]: $$ language sql stable;1032server # [ 118.069240] postgres[1082]: ::1 2026-10-20 16:14:16.535 UTC [1082] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;1033server # [ 118.072039] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE FUNCTION1034server # [ 118.075518] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: GRANT1035server # [ 118.077842] postgres[1082]: ::1 2026-10-20 16:14:16.557 UTC [1082] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1036server # [ 118.100092] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: CREATE ROLE1037server # [ 118.106356] postgres[1082]: ::1 2026-10-20 16:14:16.581 UTC [1082] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1038server # [ 118.120399] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: GRANT1039server # [ 118.125691] postgres[1082]: ::1 2026-10-20 16:14:16.601 UTC [1082] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1040server # [ 118.131903] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: GRANT1041server # [ 118.137878] postgres[1082]: ::1 2026-10-20 16:14:16.617 UTC [1082] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1042server # [ 118.144335] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: GRANT1043server # [ 118.151213] postgres[1082]: ::1 2026-10-20 16:14:16.624 UTC [1082] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth";1044server # [ 118.157968] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: ALTER ROLE1045server # [ 118.163592] postgres[1082]: ::1 2026-10-20 16:14:16.638 UTC [1082] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin;1046server # [ 118.181001] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: ALTER TABLE1047server # [ 118.182834] postgres[1082]: ::1 2026-10-20 16:14:16.658 UTC [1082] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;1048server # [ 118.199736] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: ALTER TABLE1049server # [ 118.201969] postgres[1082]: ::1 2026-10-20 16:14:16.680 UTC [1082] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;1050server # [ 118.214878] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: ALTER TABLE1051server # [ 118.221950] postgres[1082]: ::1 2026-10-20 16:14:16.695 UTC [1082] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;1052server # [ 118.227135] postgres[1082]: ::1 2026-10-20 16:14:16.704 UTC [1082] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;1053server # [ 118.231246] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: ALTER TABLE1054server # [ 118.242766] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1081]: ALTER TABLE1055server # [ 118.291971] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql1056server # [ 118.557150] postgres[1104]: ::1 2026-10-20 16:14:17.029 UTC [1104] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;1057server # [ 118.581891] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1103]: CREATE SCHEMA1058server # [ 118.586458] postgres[1104]: ::1 2026-10-20 16:14:17.057 UTC [1104] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1059server # [ 118.595319] postgres[1104]: ::1 2026-10-20 16:14:17.071 UTC [1104] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage";1060server # [ 118.598298] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1103]: CREATE ROLE1061server # [ 118.601891] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1103]: ALTER ROLE1062server # [ 118.605268] postgres[1104]: ::1 2026-10-20 16:14:17.082 UTC [1104] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;1063server # [ 118.613163] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1103]: GRANT1064server # [ 118.658874] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1103]: DO1065server # [ 118.711857] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql1066server: Guest root shell did not produce any data yet...1067server: To debug, enter the VM and run 'systemctl status backdoor.service'.1068server # [ 119.033178] postgres[1109]: ::1 2026-10-20 16:14:17.492 UTC [1109] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;1069server # [ 119.056767] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: ALTER ROLE1070server # [ 119.066796] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: ALTER ROLE1071server # [ 119.074781] postgres[1109]: ::1 2026-10-20 16:14:17.528 UTC [1109] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;1072server # [ 119.085251] postgres[1109]: ::1 2026-10-20 16:14:17.540 UTC [1109] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()1073server # [ 119.087282] postgres[1109]: RETURNS event_trigger1074server # [ 119.090009] postgres[1109]: LANGUAGE plpgsql1075server # [ 119.092862] postgres[1109]: AS $$1076server # [ 119.100969] postgres[1109]: DECLARE1077server # [ 119.105604] postgres[1109]: schema_is_cron bool;1078server # [ 119.110097] postgres[1109]: BEGIN1079server # [ 119.114735] postgres[1109]: schema_is_cron = (1080server # [ 119.125395] postgres[1109]: SELECT n.nspname = 'cron'1081server # [ 119.127461] postgres[1109]: FROM pg_event_trigger_ddl_commands() AS ev1082server # [ 119.129849] postgres[1109]: LEFT JOIN pg_catalog.pg_namespace AS n1083server # [ 119.133847] postgres[1109]: ON ev.objid = n.oid1084server # [ 119.140482] postgres[1109]: );1085server # [ 119.146244] postgres[1109]:1086server # [ 119.147625] postgres[1109]: IF schema_is_cron1087server # [ 119.154845] postgres[1109]: THEN1088server # [ 119.156495] postgres[1109]: grant usage on schema cron to postgres with grant option;1089server # [ 119.161568] postgres[1109]:1090server # [ 119.166134] postgres[1109]: alter default privileges in schema cron grant all on tables to postgres with grant option;1091server # [ 119.174490] postgres[1109]: alter default privileges in schema cron grant all on functions to postgres with grant option;1092server # [ 119.184211] postgres[1109]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1093server # [ 119.186930] postgres[1109]:1094server # [ 119.189815] postgres[1109]: alter default privileges for user supabase_admin in schema cron grant all1095server # [ 119.195800] postgres[1109]: on sequences to postgres with grant option;1096server # [ 119.202327] postgres[1109]: alter default privileges for user supabase_admin in schema cron grant all1097server # [ 119.207623] postgres[1109]: on tables to postgres with grant option;1098server # [ 119.214250] postgres[1109]: alter default privileges for user supabase_admin in schema cron grant all1099server # [ 119.219509] postgres[1109]: on functions to postgres with grant option;1100server # [ 119.226550] postgres[1109]:1101server # [ 119.228150] postgres[1109]: grant all privileges on all tables in schema cron to postgres with grant option;1102server # [ 119.234786] postgres[1109]:1103server # [ 119.235930] postgres[1109]: END IF;1104server # [ 119.239491] postgres[1109]:1105server # [ 119.246869] postgres[1109]: END;1106server # [ 119.257445] postgres[1109]: $$;1107server # [ 119.261260] postgres[1109]: ::1 2026-10-20 16:14:17.567 UTC [1109] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')1108server # [ 119.262856] postgres[1109]: EXECUTE PROCEDURE extensions.grant_pg_cron_access();1109server # [ 119.264602] postgres[1109]: ::1 2026-10-20 16:14:17.580 UTC [1109] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';1110server # [ 119.266484] postgres[1109]: ::1 2026-10-20 16:14:17.592 UTC [1109] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()1111server # [ 119.274766] postgres[1109]: RETURNS event_trigger1112server # [ 119.276737] postgres[1109]: LANGUAGE plpgsql1113server # [ 119.279802] postgres[1109]: AS $$1114server # [ 119.285167] postgres[1109]: BEGIN1115server # [ 119.287571] postgres[1109]: IF EXISTS (1116server # [ 119.289739] postgres[1109]: SELECT 11117server # [ 119.293934] postgres[1109]: FROM pg_event_trigger_ddl_commands() AS ev1118server # [ 119.297915] postgres[1109]: JOIN pg_extension AS ext1119server # [ 119.301243] postgres[1109]: ON ev.objid = ext.oid1120server # [ 119.303724] postgres[1109]: WHERE ext.extname = 'pg_net'1121server # [ 119.310620] postgres[1109]: )1122server # [ 119.313489] postgres[1109]: THEN1123server # [ 119.317165] postgres[1109]: IF NOT EXISTS (1124server # [ 119.318732] postgres[1109]: SELECT 11125server # [ 119.324002] postgres[1109]: FROM pg_roles1126server # [ 119.329734] postgres[1109]: WHERE rolname = 'supabase_functions_admin'1127server # [ 119.337112] postgres[1109]: )1128server # [ 119.341338] postgres[1109]: THEN1129server # [ 119.345217] postgres[1109]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1130server # [ 119.354085] postgres[1109]: END IF;1131server # [ 119.361380] postgres[1109]:1132server # [ 119.365370] postgres[1109]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;1133server # [ 119.369581] postgres[1109]:1134server # [ 119.373562] postgres[1109]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1135server # [ 119.379877] postgres[1109]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1136server # [ 119.403057] postgres[1109]:1137server # [ 119.414652] postgres[1109]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1138server # [ 119.417443] postgres[1109]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1139server # [ 119.425778] postgres[1109]:1140server # [ 119.435740] postgres[1109]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1141server # [ 119.445722] postgres[1109]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1142server # [ 119.452568] postgres[1109]:1143server # [ 119.462441] postgres[1109]: GRANT EXECUTE ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) TO supabase_functions_admin, postgres, anon, authenticated, service_role;1144server # [ 119.476999] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: CREATE FUNCTION1145server # [ 119.480124] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: CREATE EVENT TRIGGER1146server # [ 119.487054] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: COMMENT1147server # [ 119.493174] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: CREATE FUNCTION1148server # [ 119.497761] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: COMMENT1149server # [ 119.509895] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: DO1150server # [ 119.516287] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: CREATE ROLE1151server # [ 119.518940] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: GRANT1152server # [ 119.519668] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: GRANT1153server # [ 119.524273] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: GRANT1154server # [ 119.532435] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: GRANT1155server # [ 119.543710] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: GRANT1156server # [ 119.549445] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: GRANT1157server # [ 119.557210] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: GRANT1158server # [ 119.559379] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: GRANT1159server # [ 119.562235] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: GRANT1160server # [ 119.566418] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1106]: DO1161server # [ 119.568255] postgres[1109]: 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;1162server # [ 119.579461] postgres[1109]: END IF;1163server # [ 119.587792] postgres[1109]: END;1164server # [ 119.589442] postgres[1109]: $$;1165server # [ 119.591143] postgres[1109]: ::1 2026-10-20 16:14:17.607 UTC [1109] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';1166server # [ 119.592562] postgres[1109]: ::1 2026-10-20 16:14:17.649 UTC [1109] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;1167server # [ 119.600599] postgres[1109]: ::1 2026-10-20 16:14:17.659 UTC [1109] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user;1168server # [ 119.607216] postgres[1109]: ::1 2026-10-20 16:14:17.673 UTC [1109] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user;1169server # [ 119.613332] postgres[1109]: ::1 2026-10-20 16:14:17.683 UTC [1109] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;1170server # [ 119.614762] postgres[1109]: ::1 2026-10-20 16:14:17.697 UTC [1109] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;1171server # [ 119.618777] postgres[1109]: ::1 2026-10-20 16:14:17.710 UTC [1109] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;1172server # [ 119.624285] postgres[1109]: ::1 2026-10-20 16:14:17.715 UTC [1109] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;1173server # [ 119.626741] postgres[1109]: ::1 2026-10-20 16:14:17.727 UTC [1109] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;1174server # [ 119.630379] postgres[1109]: ::1 2026-10-20 16:14:17.741 UTC [1109] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;1175server # [ 119.635636] postgres[1109]: ::1 2026-10-20 16:14:17.776 UTC [1109] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;1176server # [ 119.647934] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running pgbouncer auth schema...1177server # [ 119.656925] systemd[1]: Starting Virtual Console Setup...1178server # [ 119.825070] postgres[1112]: ::1 2026-10-20 16:14:18.290 UTC [1112] postgres@postgres LOG: statement: CREATE USER pgbouncer;1179server # [ 119.852045] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1110]: CREATE ROLE1180server # [ 119.863917] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1110]: REVOKE1181server # [ 119.875343] postgres[1112]: ::1 2026-10-20 16:14:18.309 UTC [1112] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;1182server # [ 119.894679] postgres[1112]: ::1 2026-10-20 16:14:18.325 UTC [1112] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;1183server # [ 119.974222] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1110]: CREATE SCHEMA1184server # [ 119.978227] postgres[1112]: ::1 2026-10-20 16:14:18.456 UTC [1112] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)1185server # [ 119.985800] postgres[1112]: RETURNS TABLE(username TEXT, password TEXT) AS1186server # [ 119.989943] postgres[1112]: $$1187server # [ 119.997049] postgres[1112]: BEGIN1188server # [ 120.003499] postgres[1112]: RAISE WARNING 'PgBouncer auth request: %', p_usename;1189server # [ 120.005525] postgres[1112]:1190server # [ 120.006581] postgres[1112]: RETURN QUERY1191server # [ 120.009343] postgres[1112]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow1192server # [ 120.018364] postgres[1112]: WHERE usename = p_usename;1193server # [ 120.019856] postgres[1112]: END;1194server # [ 120.023357] postgres[1112]: $$ LANGUAGE plpgsql1195server # [ 120.037511] postgres[1112]: SET search_path = ''1196server # [ 120.048925] postgres[1112]: SECURITY DEFINER;1197server # [ 120.056164] postgres[1112]: ::1 2026-10-20 16:14:18.495 UTC [1112] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;1198server # [ 120.070745] postgres[1112]: ::1 2026-10-20 16:14:18.513 UTC [1112] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;1199server # [ 120.079962] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1110]: CREATE FUNCTION1200server # [ 120.105864] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1110]: REVOKE1201server # [ 120.118462] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1110]: GRANT1202server # [ 120.137635] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running stat extension...1203server # [ 120.435314] postgres[1115]: ::1 2026-10-20 16:14:18.885 UTC [1115] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions;1204server # [ 120.464160] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1113]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping1205server # [ 120.476743] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1113]: CREATE SCHEMA1206server # [ 120.481437] postgres[1115]: ::1 2026-10-20 16:14:18.959 UTC [1115] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;1207server # [ 122.099848] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1113]: CREATE EXTENSION1208server # [ 122.179988] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql1209server # [ 122.769121] postgres[1125]: ::1 2026-10-20 16:14:21.227 UTC [1125] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres;1210server # [ 122.799771] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1123]: GRANT1211server # [ 122.807521] postgres[1125]: ::1 2026-10-20 16:14:21.273 UTC [1125] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres;1212server # [ 122.824330] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1123]: GRANT1213server # [ 122.845750] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1123]: GRANT1214server # [ 122.851191] postgres[1125]: ::1 2026-10-20 16:14:21.305 UTC [1125] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres;1215server # [ 122.858975] postgres[1125]: ::1 2026-10-20 16:14:21.321 UTC [1125] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;1216server # [ 122.897007] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1123]: GRANT1217server # [ 122.914358] postgres[1125]: ::1 2026-10-20 16:14:21.389 UTC [1125] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;1218server # [ 122.939203] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1123]: GRANT1219server # [ 122.958996] postgres[1125]: ::1 2026-10-20 16:14:21.414 UTC [1125] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;1220server # [ 122.970262] postgres[1125]: ::1 2026-10-20 16:14:21.435 UTC [1125] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;1221server # [ 122.979479] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1123]: GRANT1222server # [ 122.983037] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1123]: GRANT1223server # [ 122.995921] postgres[1125]: ::1 2026-10-20 16:14:21.446 UTC [1125] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;1224server # [ 123.004522] postgres[1125]: ::1 2026-10-20 16:14:21.467 UTC [1125] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;1225server # [ 123.022767] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1123]: GRANT1226server # [ 123.059632] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1123]: GRANT1227server # [ 123.107829] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1123]: DO1228server # [ 123.122425] postgres[1125]: ::1 2026-10-20 16:14:21.591 UTC [1125] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;1229server # [ 123.142124] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1123]: ALTER ROLE1230server # [ 123.227016] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql1231server # [ 123.831234] postgres[1138]: ::1 2026-10-20 16:14:22.282 UTC [1138] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1232server # [ 123.858470] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: GRANT1233server # [ 123.873946] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: GRANT1234server # [ 123.889703] postgres[1138]: ::1 2026-10-20 16:14:22.328 UTC [1138] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1235server # [ 123.898535] postgres[1138]: ::1 2026-10-20 16:14:22.354 UTC [1138] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1236server # [ 123.908020] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: GRANT1237server # [ 123.918947] postgres[1138]: ::1 2026-10-20 16:14:22.377 UTC [1138] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;1238server # [ 123.922742] postgres[1138]: ::1 2026-10-20 16:14:22.394 UTC [1138] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;1239server # [ 123.933009] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: ALTER TABLE1240server # [ 123.952186] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: ALTER TABLE1241server # [ 123.961017] postgres[1138]: ::1 2026-10-20 16:14:22.435 UTC [1138] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;1242server # [ 123.968823] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: ALTER TABLE1243server # [ 123.975132] postgres[1138]: ::1 2026-10-20 16:14:22.452 UTC [1138] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;1244server # [ 123.998730] postgres[1138]: ::1 2026-10-20 16:14:22.465 UTC [1138] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;1245server # [ 124.017298] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: ALTER TABLE1246server # [ 124.025510] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: ALTER TABLE1247server # [ 124.035000] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: GRANT1248server # [ 124.042110] postgres[1138]: ::1 2026-10-20 16:14:22.479 UTC [1138] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres;1249server # [ 124.043937] postgres[1138]: ::1 2026-10-20 16:14:22.491 UTC [1138] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;1250server # [ 124.058685] postgres[1138]: ::1 2026-10-20 16:14:22.517 UTC [1138] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;1251server # [ 124.071050] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: GRANT1252server # [ 124.074989] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: GRANT1253server # [ 124.082111] postgres[1138]: ::1 2026-10-20 16:14:22.542 UTC [1138] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;1254server # [ 124.093917] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: GRANT1255server # [ 124.098778] postgres[1138]: ::1 2026-10-20 16:14:22.578 UTC [1138] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user;1256server # [ 124.135650] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: ALTER DEFAULT PRIVILEGES1257server # [ 124.155680] postgres[1138]: ::1 2026-10-20 16:14:22.625 UTC [1138] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1258server # [ 124.175645] postgres[1138]: ::1 2026-10-20 16:14:22.646 UTC [1138] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user;1259server # [ 124.194797] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: ALTER DEFAULT PRIVILEGES1260server # [ 124.195870] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1134]: ALTER DEFAULT PRIVILEGES1261server # [ 124.268302] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql1262server # [ 124.825413] postgres[1140]: ::1 2026-10-20 16:14:23.291 UTC [1140] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime;1263server # [ 124.869281] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1139]: CREATE SCHEMA1264server # [ 124.912948] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql1265server # [ 124.979054] systemd-vconsole-setup[1111]: Configuration of first virtual console was skipped, ignoring remaining ones.1266server # [ 125.042995] systemd[1]: Finished Virtual Console Setup.1267server # [ 125.215817] postgres[1143]: ::1 2026-10-20 16:14:23.692 UTC [1143] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres;1268server # [ 125.238992] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1141]: GRANT1269server # [ 125.242484] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1141]: GRANT1270server # [ 125.245304] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1141]: GRANT1271server # [ 125.250448] postgres[1143]: ::1 2026-10-20 16:14:23.711 UTC [1143] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;1272server # [ 125.252570] postgres[1143]: ::1 2026-10-20 16:14:23.716 UTC [1143] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;1273server # [ 125.262500] postgres[1143]: ::1 2026-10-20 16:14:23.719 UTC [1143] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;1274server # [ 125.281730] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1141]: GRANT1275server # [ 125.299043] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql1276server # [ 125.596026] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1144]: DO1277server # [ 125.605984] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1144]: DO1278server # [ 125.617305] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1144]: DO1279server # [ 125.654411] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql1280server # [ 126.055530] postgres[1153]: ::1 2026-10-20 16:14:24.510 UTC [1153] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user;1281server # [ 126.111826] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1146]: ALTER DEFAULT PRIVILEGES1282server # [ 126.117088] postgres[1153]: ::1 2026-10-20 16:14:24.557 UTC [1153] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1283server # [ 126.125196] postgres[1153]: ::1 2026-10-20 16:14:24.576 UTC [1153] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user;1284server # [ 126.132024] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1146]: ALTER DEFAULT PRIVILEGES1285server # [ 126.143042] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1146]: ALTER DEFAULT PRIVILEGES1286server # [ 126.177298] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql1287server # [ 126.570234] postgres[1164]: ::1 2026-10-20 16:14:25.023 UTC [1164] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';1288server # [ 126.590446] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1160]: ALTER ROLE1289server # [ 126.634985] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql1290server # [ 126.955129] postgres[1171]: ::1 2026-10-20 16:14:25.427 UTC [1171] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1291server # [ 126.970126] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1292server # [ 126.978751] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: DROP EVENT TRIGGER1293server # [ 126.985917] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1294server # [ 126.995541] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: DROP FUNCTION1295server # [ 126.997209] postgres[1171]: ::1 2026-10-20 16:14:25.444 UTC [1171] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1296server # [ 127.002664] postgres[1171]: ::1 2026-10-20 16:14:25.455 UTC [1171] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1297server # [ 127.009264] postgres[1171]: DECLARE1298server # [ 127.013115] postgres[1171]: cmd record;1299server # [ 127.018398] postgres[1171]: BEGIN1300server # [ 127.022876] postgres[1171]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1301server # [ 127.027600] postgres[1171]: LOOP1302server # [ 127.037632] postgres[1171]: IF cmd.command_tag IN (1303server # [ 127.039196] postgres[1171]: 'CREATE SCHEMA', 'ALTER SCHEMA'1304server # [ 127.041945] postgres[1171]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1305server # [ 127.045427] postgres[1171]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1306server # [ 127.048199] postgres[1171]: , 'CREATE VIEW', 'ALTER VIEW'1307server # [ 127.056898] postgres[1171]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1308server # [ 127.058739] postgres[1171]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1309server # [ 127.063451] postgres[1171]: , 'CREATE TRIGGER'1310server # [ 127.065924] postgres[1171]: , 'CREATE TYPE'1311server # [ 127.073112] postgres[1171]: , 'CREATE RULE'1312server # [ 127.085291] postgres[1171]: , 'COMMENT'1313server # [ 127.086776] postgres[1171]: )1314server # [ 127.087566] postgres[1171]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1315server # [ 127.094750] postgres[1171]: AND cmd.schema_name is distinct from 'pg_temp'1316server # [ 127.097297] postgres[1171]: THEN1317server # [ 127.103662] postgres[1171]: NOTIFY pgrst, 'reload schema';1318server # [ 127.111017] postgres[1171]: END IF;1319server # [ 127.117235] postgres[1171]: END LOOP;1320server # [ 127.120230] postgres[1171]: END; $$ LANGUAGE plpgsql;1321server # [ 127.130119] postgres[1171]: ::1 2026-10-20 16:14:25.487 UTC [1171] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1322server # [ 127.141276] postgres[1171]: DECLARE1323server # [ 127.142613] postgres[1171]: obj record;1324server # [ 127.143138] postgres[1171]: BEGIN1325server # [ 127.143646] postgres[1171]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1326server # [ 127.152729] postgres[1171]: LOOP1327server # [ 127.156028] postgres[1171]: IF obj.object_type IN (1328server # [ 127.158657] postgres[1171]: 'schema'1329server # [ 127.167046] postgres[1171]: , 'table'1330server # [ 127.169796] postgres[1171]: , 'foreign table'1331server # [ 127.171485] postgres[1171]: , 'view'1332server # [ 127.172240] postgres[1171]: , 'materialized view'1333server # [ 127.174535] postgres[1171]: , 'function'1334server # [ 127.175786] postgres[1171]: , 'trigger'1335server # [ 127.176770] postgres[1171]: , 'type'1336server # [ 127.179157] postgres[1171]: , 'rule'1337server # [ 127.179969] postgres[1171]: )1338server # [ 127.181883] postgres[1171]: AND obj.is_temporary IS false -- no pg_temp objects1339server # [ 127.183906] postgres[1171]: THEN1340server # [ 127.187002] postgres[1171]: NOTIFY pgrst, 'reload schema';1341server # [ 127.190209] postgres[1171]: END IF;1342server # [ 127.192183] postgres[1171]: END LOOP;1343server # [ 127.193622] postgres[1171]: END; $$ LANGUAGE plpgsql;1344server # [ 127.194634] postgres[1171]: ::1 2026-10-20 16:14:25.505 UTC [1171] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1345server # [ 127.196582] postgres[1171]: ::1 2026-10-20 16:14:25.511 UTC [1171] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1346server # [ 127.202590] postgres[1171]: ON ddl_command_end1347server # [ 127.205731] postgres[1171]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1348server # [ 127.213506] postgres[1171]: ::1 2026-10-20 16:14:25.526 UTC [1171] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1349server # [ 127.215741] postgres[1171]: ::1 2026-10-20 16:14:25.533 UTC [1171] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1350server # [ 127.218494] postgres[1171]: ON sql_drop1351server # [ 127.219885] postgres[1171]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1352server # [ 127.223883] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: CREATE FUNCTION1353server # [ 127.233252] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: CREATE FUNCTION1354server # [ 127.234425] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping1355server # [ 127.236136] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: DROP EVENT TRIGGER1356server # [ 127.238298] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: CREATE EVENT TRIGGER1357server # [ 127.239883] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping1358server # [ 127.243248] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: DROP EVENT TRIGGER1359server # [ 127.245504] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1170]: CREATE EVENT TRIGGER1360server # [ 127.247796] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql1361server # [ 127.938601] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1172]: DO1362server # [ 127.998096] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql1363server # [ 128.253147] postgres[1175]: ::1 2026-10-20 16:14:26.727 UTC [1175] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public;1364server # [ 128.314903] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: CREATE SCHEMA1365server # [ 128.324024] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping1366server # [ 128.333670] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: DROP FUNCTION1367server # [ 128.335389] postgres[1175]: ::1 2026-10-20 16:14:26.775 UTC [1175] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb);1368server # [ 128.339442] postgres[1175]: ::1 2026-10-20 16:14:26.785 UTC [1175] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1369server # [ 128.343680] postgres[1175]: "operationName" text default null,1370server # [ 128.350948] postgres[1175]: query text default null,1371server # [ 128.352066] postgres[1175]: variables jsonb default null,1372server # [ 128.359373] postgres[1175]: extensions jsonb default null1373server # [ 128.366547] postgres[1175]: )1374server # [ 128.370463] postgres[1175]: returns jsonb1375server # [ 128.373858] postgres[1175]: language plpgsql1376server # [ 128.377039] postgres[1175]: as $$1377server # [ 128.379579] postgres[1175]: DECLARE1378server # [ 128.381708] postgres[1175]: server_version float;1379server # [ 128.383263] postgres[1175]: BEGIN1380server # [ 128.385706] postgres[1175]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1381server # [ 128.389375] postgres[1175]:1382server # [ 128.390506] postgres[1175]: IF server_version >= 14 THEN1383server # [ 128.393161] postgres[1175]: RETURN jsonb_build_object(1384server # [ 128.395758] postgres[1175]: 'data', null::jsonb,1385server # [ 128.399019] postgres[1175]: 'errors', array['pg_graphql extension is not enabled.']1386server # [ 128.402463] postgres[1175]: );1387server # [ 128.403463] postgres[1175]: ELSE1388server # [ 128.407510] postgres[1175]: RETURN jsonb_build_object(1389server # [ 128.409924] postgres[1175]: 'data', null::jsonb,1390server # [ 128.412973] postgres[1175]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1391server # [ 128.415116] postgres[1175]: );1392server # [ 128.416941] postgres[1175]: END IF;1393server # [ 128.419161] postgres[1175]: END;1394server # [ 128.420374] postgres[1175]: $$;1395server # [ 128.422859] postgres[1175]: ::1 2026-10-20 16:14:26.810 UTC [1175] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;1396server # [ 128.426563] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: CREATE FUNCTION1397server # [ 128.428085] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: GRANT1398server # [ 128.431581] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: ALTER DEFAULT PRIVILEGES1399server # [ 128.434743] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: ALTER DEFAULT PRIVILEGES1400server # [ 128.436825] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: ALTER DEFAULT PRIVILEGES1401server # [ 128.438938] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: ALTER DEFAULT PRIVILEGES1402server # [ 128.441394] postgres[1175]: ::1 2026-10-20 16:14:26.826 UTC [1175] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;1403server # [ 128.443290] postgres[1175]: ::1 2026-10-20 16:14:26.841 UTC [1175] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;1404server # [ 128.446723] postgres[1175]: ::1 2026-10-20 16:14:26.861 UTC [1175] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;1405server # [ 128.449664] postgres[1175]: ::1 2026-10-20 16:14:26.877 UTC [1175] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1406server # [ 128.451877] postgres[1175]: on sequences to postgres, anon, authenticated, service_role;1407server # [ 128.453707] postgres[1175]: ::1 2026-10-20 16:14:26.895 UTC [1175] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1408server # [ 128.455111] postgres[1175]: on tables to postgres, anon, authenticated, service_role;1409server # [ 128.455716] postgres[1175]: ::1 2026-10-20 16:14:26.917 UTC [1175] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1410server # [ 128.458279] postgres[1175]: on functions to postgres, anon, authenticated, service_role;1411server # [ 128.459798] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: ALTER DEFAULT PRIVILEGES1412server # [ 128.462697] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: ALTER DEFAULT PRIVILEGES1413server # [ 128.467132] postgres[1175]: ::1 2026-10-20 16:14:26.937 UTC [1175] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()1414server # [ 128.471797] postgres[1175]: RETURNS event_trigger1415server # [ 128.475348] postgres[1175]: LANGUAGE plpgsql1416server # [ 128.478502] postgres[1175]: AS $func$1417server # [ 128.480542] postgres[1175]: DECLARE1418server # [ 128.482910] postgres[1175]: func_is_graphql_resolve bool;1419server # [ 128.485024] postgres[1175]: BEGIN1420server # [ 128.486556] postgres[1175]: func_is_graphql_resolve = (1421server # [ 128.490672] postgres[1175]: SELECT n.proname = 'resolve'1422server # [ 128.493967] postgres[1175]: FROM pg_event_trigger_ddl_commands() AS ev1423server # [ 128.495283] postgres[1175]: LEFT JOIN pg_catalog.pg_proc AS n1424server # [ 128.498510] postgres[1175]: ON ev.objid = n.oid1425server # [ 128.501277] postgres[1175]: );1426server # [ 128.502397] postgres[1175]:1427server # [ 128.503513] postgres[1175]: IF func_is_graphql_resolve1428server # [ 128.506011] postgres[1175]: THEN1429server # [ 128.506957] postgres[1175]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1430server # [ 128.509469] postgres[1175]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1431server # [ 128.510714] postgres[1175]:1432server # [ 128.511847] postgres[1175]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1433server # [ 128.513605] postgres[1175]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1434server # [ 128.514697] postgres[1175]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1435server # [ 128.515972] postgres[1175]:1436server # [ 128.518591] postgres[1175]: DROP FUNCTION IF EXISTS graphql_public.graphql;1437server # [ 128.519611] postgres[1175]: create or replace function graphql_public.graphql(1438server # [ 128.521961] postgres[1175]: "operationName" text default null,1439server # [ 128.523196] postgres[1175]: query text default null,1440server # [ 128.524145] postgres[1175]: variables jsonb default null,1441server # [ 128.526490] postgres[1175]: extensions jsonb default null1442server # [ 128.528926] postgres[1175]: )1443server # [ 128.530346] postgres[1175]: returns jsonb1444server # [ 128.531773] postgres[1175]: language sql1445server # [ 128.534210] postgres[1175]: as $$1446server # [ 128.535076] postgres[1175]: SELECT graphql.resolve(query, coalesce(variables, '{}'));1447server # [ 128.537700] postgres[1175]: $$;1448server # [ 128.538934] postgres[1175]:1449server # [ 128.539636] postgres[1175]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1450server # [ 128.541084] postgres[1175]: END IF;1451server # [ 128.541990] postgres[1175]:1452server # [ 128.542953] postgres[1175]: END;1453server # [ 128.546129] postgres[1175]: $func$;1454server # [ 128.547907] postgres[1175]: ::1 2026-10-20 16:14:26.982 UTC [1175] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;1455server # [ 128.557489] postgres[1175]: ::1 2026-10-20 16:14:26.994 UTC [1175] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')1456server # [ 128.561542] postgres[1175]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access();1457server # [ 128.565176] postgres[1175]: ::1 2026-10-20 16:14:27.019 UTC [1175] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';1458server # [ 128.572760] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: CREATE FUNCTION1459server # [ 128.576085] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping1460server # [ 128.581545] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: DROP EVENT TRIGGER1461server # [ 128.585120] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: CREATE EVENT TRIGGER1462server # [ 128.589720] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: COMMENT1463server # [ 128.591240] postgres[1175]: ::1 2026-10-20 16:14:27.039 UTC [1175] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1464server # [ 128.593307] postgres[1175]: RETURNS event_trigger1465server # [ 128.598131] postgres[1175]: LANGUAGE plpgsql1466server # [ 128.605987] postgres[1175]: AS $func$1467server # [ 128.608982] postgres[1175]: DECLARE1468server # [ 128.614328] postgres[1175]: graphql_is_dropped bool;1469server # [ 128.615520] postgres[1175]: BEGIN1470server # [ 128.618310] postgres[1175]: graphql_is_dropped = (1471server # [ 128.625075] postgres[1175]: SELECT ev.schema_name = 'graphql_public'1472server # [ 128.626626] postgres[1175]: FROM pg_event_trigger_dropped_objects() AS ev1473server # [ 128.629850] postgres[1175]: WHERE ev.schema_name = 'graphql_public'1474server # [ 128.638132] postgres[1175]: );1475server # [ 128.639264] postgres[1175]:1476server # [ 128.640234] postgres[1175]: IF graphql_is_dropped1477server # [ 128.642267] postgres[1175]: THEN1478server # [ 128.648207] postgres[1175]: create or replace function graphql_public.graphql(1479server # [ 128.655461] postgres[1175]: "operationName" text default null,1480server # [ 128.673496] postgres[1175]: query text default null,1481server # [ 128.678863] postgres[1175]: variables jsonb default null,1482server # [ 128.686769] postgres[1175]: extensions jsonb default null1483server # [ 128.699027] postgres[1175]: )1484server # [ 128.705845] postgres[1175]: returns jsonb1485server # [ 128.706779] postgres[1175]: language plpgsql1486server # [ 128.707426] postgres[1175]: as $$1487server # [ 128.707883] postgres[1175]: DECLARE1488server # [ 128.714924] postgres[1175]: server_version float;1489server # [ 128.723993] postgres[1175]: BEGIN1490server # [ 128.737690] postgres[1175]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1491server # [ 128.742555] postgres[1175]:1492server # [ 128.745434] postgres[1175]: IF server_version >= 14 THEN1493server # [ 128.760960] postgres[1175]: RETURN jsonb_build_object(1494server # [ 128.767238] postgres[1175]: 'data', null::jsonb,1495server # [ 128.769802] postgres[1175]: 'errors', array['pg_graphql extension is not enabled.']1496server # [ 128.776889] postgres[1175]: );1497server # [ 128.779850] postgres[1175]: ELSE1498server # [ 128.785363] postgres[1175]: RETURN jsonb_build_object(1499server # [ 128.788544] postgres[1175]: 'data', null::jsonb,1500server # [ 128.791349] postgres[1175]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1501server # [ 128.797841] postgres[1175]: );1502server # [ 128.799855] postgres[1175]: END IF;1503server # [ 128.803897] postgres[1175]: END;1504server # [ 128.810761] postgres[1175]: $$;1505server # [ 128.814463] postgres[1175]: END IF;1506server # [ 128.816202] postgres[1175]:1507server # [ 128.819303] postgres[1175]: END;1508server # [ 128.825698] postgres[1175]: $func$;1509server # [ 128.829928] postgres[1175]: ::1 2026-10-20 16:14:27.086 UTC [1175] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;1510server # [ 128.838136] postgres[1175]: ::1 2026-10-20 16:14:27.094 UTC [1175] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')1511server # [ 128.841246] postgres[1175]: EXECUTE PROCEDURE extensions.set_graphql_placeholder();1512server # [ 128.843015] postgres[1175]: ::1 2026-10-20 16:14:27.105 UTC [1175] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';1513server # [ 128.851410] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: CREATE FUNCTION1514server # [ 128.855211] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping1515server # [ 128.861648] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: DROP EVENT TRIGGER1516server # [ 128.863201] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: CREATE EVENT TRIGGER1517server # [ 128.867135] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1174]: COMMENT1518server # [ 128.874209] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql1519server # [ 129.116975] postgres[1185]: ::1 2026-10-20 16:14:27.588 UTC [1185] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1520server # [ 129.144754] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1181]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1521server # [ 129.162341] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1181]: DROP EVENT TRIGGER1522server # [ 129.170925] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1181]: 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, skipping1523server # [ 129.178857] postgres[1185]: ::1 2026-10-20 16:14:27.621 UTC [1185] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1524server # [ 129.192771] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1181]: DROP FUNCTION1525server # [ 129.200784] postgres[1185]: ::1 2026-10-20 16:14:27.678 UTC [1185] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1526server # [ 129.206285] postgres[1185]: DECLARE1527server # [ 129.217753] postgres[1185]: cmd record;1528server # [ 129.219991] postgres[1185]: BEGIN1529server # [ 129.228992] postgres[1185]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1530server # [ 129.234330] postgres[1185]: LOOP1531server # [ 129.242055] postgres[1185]: IF cmd.command_tag IN (1532server # [ 129.248847] postgres[1185]: 'CREATE SCHEMA', 'ALTER SCHEMA'1533server # [ 129.250514] postgres[1185]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1534server # [ 129.251896] postgres[1185]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1535server # [ 129.253597] postgres[1185]: , 'CREATE VIEW', 'ALTER VIEW'1536server # [ 129.255115] postgres[1185]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1537server # [ 129.257185] postgres[1185]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1538server # [ 129.258628] postgres[1185]: , 'CREATE TRIGGER'1539server # [ 129.260826] postgres[1185]: , 'CREATE TYPE', 'ALTER TYPE'1540server # [ 129.262366] postgres[1185]: , 'CREATE RULE'1541server # [ 129.263879] postgres[1185]: , 'COMMENT'1542server # [ 129.267578] postgres[1185]: )1543server # [ 129.270360] postgres[1185]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1544server # [ 129.271965] postgres[1185]: AND cmd.schema_name is distinct from 'pg_temp'1545server # [ 129.273093] postgres[1185]: THEN1546server # [ 129.277127] postgres[1185]: NOTIFY pgrst, 'reload schema';1547server # [ 129.278353] postgres[1185]: END IF;1548server # [ 129.280001] postgres[1185]: END LOOP;1549server # [ 129.281711] postgres[1185]: END; $$ LANGUAGE plpgsql;1550server # [ 129.319456] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1181]: CREATE FUNCTION1551server # [ 129.325810] postgres[1185]: ::1 2026-10-20 16:14:27.799 UTC [1185] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1552server # [ 129.330339] postgres[1185]: DECLARE1553server # [ 129.332082] postgres[1185]: obj record;1554server # [ 129.338332] postgres[1185]: BEGIN1555server # [ 129.339258] postgres[1185]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1556server # [ 129.345128] postgres[1185]: LOOP1557server # [ 129.346290] postgres[1185]: IF obj.object_type IN (1558server # [ 129.347915] postgres[1185]: 'schema'1559server # [ 129.361407] postgres[1185]: , 'table'1560server # [ 129.362731] postgres[1185]: , 'foreign table'1561server # [ 129.363532] postgres[1185]: , 'view'1562server # [ 129.369392] postgres[1185]: , 'materialized view'1563server # [ 129.376949] postgres[1185]: , 'function'1564server # [ 129.378585] postgres[1185]: , 'trigger'1565server # [ 129.382599] postgres[1185]: , 'type'1566server # [ 129.390466] postgres[1185]: , 'rule'1567server # [ 129.391917] postgres[1185]: )1568server # [ 129.394792] postgres[1185]: AND obj.is_temporary IS false -- no pg_temp objects1569server # [ 129.401041] postgres[1185]: THEN1570server # [ 129.402470] postgres[1185]: NOTIFY pgrst, 'reload schema';1571server # [ 129.403270] postgres[1185]: END IF;1572server # [ 129.405392] postgres[1185]: END LOOP;1573server # [ 129.406909] postgres[1185]: END; $$ LANGUAGE plpgsql;1574server # [ 129.414346] postgres[1185]: ::1 2026-10-20 16:14:27.837 UTC [1185] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1575server # [ 129.417321] postgres[1185]: ::1 2026-10-20 16:14:27.853 UTC [1185] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1576server # [ 129.425011] postgres[1185]: ON ddl_command_end1577server # [ 129.433751] postgres[1185]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1578server # [ 129.437670] postgres[1185]: ::1 2026-10-20 16:14:27.870 UTC [1185] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1579server # [ 129.447920] postgres[1185]: ::1 2026-10-20 16:14:27.881 UTC [1185] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1580server # [ 129.462766] postgres[1185]: ON sql_drop1581server # [ 129.463546] postgres[1185]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1582server # [ 129.464241] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1181]: CREATE FUNCTION1583server # [ 129.469735] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1181]: DROP EVENT TRIGGER1584server # [ 129.474917] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1181]: CREATE EVENT TRIGGER1585server # [ 129.483252] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1181]: DROP EVENT TRIGGER1586server # [ 129.489974] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1181]: CREATE EVENT TRIGGER1587server # [ 129.506249] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql1588server # [ 129.807526] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1589server # [ 129.819144] postgres[1199]: ::1 2026-10-20 16:14:28.283 UTC [1199] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;1590server # [ 129.835027] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1192]: ALTER ROLE1591server # [ 129.869213] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql1592server # [ 130.100177] postgres[1201]: ::1 2026-10-20 16:14:28.573 UTC [1201] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1593server # [ 130.105512] postgres[1201]: returns event_trigger1594server # [ 130.106595] postgres[1201]: language plpgsql1595server # [ 130.107506] postgres[1201]: AS $func$1596server # [ 130.107965] postgres[1201]: DECLARE1597server # [ 130.110632] postgres[1201]: func_is_graphql_resolve bool;1598server # [ 130.111956] postgres[1201]: BEGIN1599server # [ 130.113791] postgres[1201]: func_is_graphql_resolve = (1600server # [ 130.115227] postgres[1201]: SELECT n.proname = 'resolve'1601server # [ 130.117104] postgres[1201]: FROM pg_event_trigger_ddl_commands() AS ev1602server # [ 130.118921] postgres[1201]: LEFT JOIN pg_catalog.pg_proc AS n1603server # [ 130.119915] postgres[1201]: ON ev.objid = n.oid1604server # [ 130.121569] postgres[1201]: );1605server # [ 130.122431] postgres[1201]:1606server # [ 130.124949] postgres[1201]: IF func_is_graphql_resolve1607server # [ 130.125883] postgres[1201]: THEN1608server # [ 130.131288] postgres[1201]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1609server # [ 130.134723] postgres[1201]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1610server # [ 130.136162] postgres[1201]:1611server # [ 130.137303] postgres[1201]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1612server # [ 130.138302] postgres[1201]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1613server # [ 130.139230] postgres[1201]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1614server # [ 130.145667] postgres[1201]:1615server # [ 130.146599] postgres[1201]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1616server # [ 130.147563] postgres[1201]: DROP FUNCTION IF EXISTS graphql_public.graphql;1617server # [ 130.148990] postgres[1201]: create or replace function graphql_public.graphql(1618server # [ 130.149753] postgres[1201]: "operationName" text default null,1619server # [ 130.150585] postgres[1201]: query text default null,1620server # [ 130.151582] postgres[1201]: variables jsonb default null,1621server # [ 130.152050] postgres[1201]: extensions jsonb default null1622server # [ 130.153899] postgres[1201]: )1623server # [ 130.154847] postgres[1201]: returns jsonb1624server # [ 130.156988] postgres[1201]: language sql1625server # [ 130.163296] postgres[1201]: as $$1626server # [ 130.165157] postgres[1201]: -- This changed1627server # [ 130.166007] postgres[1201]: select graphql.resolve(1628server # [ 130.166775] postgres[1201]: query := query,1629server # [ 130.167220] postgres[1201]: variables := coalesce(variables, '{}'),1630server # [ 130.168052] postgres[1201]: "operationName" := "operationName",1631server # [ 130.169531] postgres[1201]: extensions := extensions1632server # [ 130.170516] postgres[1201]: );1633server # [ 130.171319] postgres[1201]: $$;1634server # [ 130.173359] postgres[1201]:1635server # [ 130.174219] postgres[1201]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1636server # [ 130.176217] postgres[1201]: END IF;1637server # [ 130.179129] postgres[1201]:1638server # [ 130.182222] postgres[1201]: END;1639server # [ 130.183911] postgres[1201]: $func$;1640server # [ 130.198426] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1200]: CREATE FUNCTION1641server # [ 130.206480] postgres[1201]: ::1 2026-10-20 16:14:28.674 UTC [1201] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1642server # [ 130.213413] postgres[1201]: RETURNS event_trigger1643server # [ 130.214836] postgres[1201]: LANGUAGE plpgsql1644server # [ 130.218569] postgres[1201]: AS $func$1645server # [ 130.221037] postgres[1201]: DECLARE1646server # [ 130.224947] postgres[1201]: graphql_is_dropped bool;1647server # [ 130.225976] postgres[1201]: BEGIN1648server # [ 130.226916] postgres[1201]: graphql_is_dropped = (1649server # [ 130.229695] postgres[1201]: SELECT ev.schema_name = 'graphql_public'1650server # [ 130.232975] postgres[1201]: FROM pg_event_trigger_dropped_objects() AS ev1651server # [ 130.237800] postgres[1201]: WHERE ev.schema_name = 'graphql_public'1652server # [ 130.241339] postgres[1201]: );1653server # [ 130.245885] postgres[1201]:1654server # [ 130.250384] postgres[1201]: IF graphql_is_dropped1655server # [ 130.252179] postgres[1201]: THEN1656server # [ 130.258407] postgres[1201]: create or replace function graphql_public.graphql(1657server # [ 130.269354] postgres[1201]: "operationName" text default null,1658server # [ 130.270625] postgres[1201]: query text default null,1659server # [ 130.273290] postgres[1201]: variables jsonb default null,1660server # [ 130.277388] postgres[1201]: extensions jsonb default null1661server # [ 130.282432] postgres[1201]: )1662server # [ 130.283519] postgres[1201]: returns jsonb1663server # [ 130.286098] postgres[1201]: language plpgsql1664server # [ 130.288852] postgres[1201]: as $$1665server # [ 130.292002] postgres[1201]: DECLARE1666server # [ 130.297219] postgres[1201]: server_version float;1667server # [ 130.303481] postgres[1201]: BEGIN1668server # [ 130.310939] postgres[1201]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1669server # [ 130.318872] postgres[1201]:1670server # [ 130.325882] postgres[1201]: IF server_version >= 14 THEN1671server # [ 130.329200] postgres[1201]: RETURN jsonb_build_object(1672server # [ 130.334564] postgres[1201]: 'errors', jsonb_build_array(1673server # [ 130.337824] postgres[1201]: jsonb_build_object(1674server # [ 130.343551] postgres[1201]: 'message', 'pg_graphql extension is not enabled.'1675server # [ 130.349077] postgres[1201]: )1676server # [ 130.353944] postgres[1201]: )1677server # [ 130.361842] postgres[1201]: );1678server # [ 130.363769] postgres[1201]: ELSE1679server # [ 130.367576] postgres[1201]: RETURN jsonb_build_object(1680server # [ 130.370203] postgres[1201]: 'errors', jsonb_build_array(1681server # [ 130.374152] postgres[1201]: jsonb_build_object(1682server # [ 130.376098] postgres[1201]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1683server # [ 130.378178] postgres[1201]: )1684server # [ 130.379765] postgres[1201]: )1685server # [ 130.381454] postgres[1201]: );1686server # [ 130.382870] postgres[1201]: END IF;1687server # [ 130.385062] postgres[1201]: END;1688server # [ 130.387073] postgres[1201]: $$;1689server # [ 130.390645] postgres[1201]: END IF;1690server # [ 130.393541] postgres[1201]:1691server # [ 130.397571] postgres[1201]: END;1692server # [ 130.399286] postgres[1201]: $func$;1693server # [ 130.401911] postgres[1201]: ::1 2026-10-20 16:14:28.699 UTC [1201] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1694server # [ 130.406732] postgres[1201]: "operationName" text default null,1695server # [ 130.409073] postgres[1201]: query text default null,1696server # [ 130.419106] postgres[1201]: variables jsonb default null,1697server # [ 130.422837] postgres[1201]: extensions jsonb default null1698server # [ 130.426636] postgres[1201]: )1699server # [ 130.429006] postgres[1201]: returns jsonb1700server # [ 130.430709] postgres[1201]: language plpgsql1701server # [ 130.432794] postgres[1201]: as $$1702server # [ 130.435240] postgres[1201]: DECLARE1703server # [ 130.436475] postgres[1201]: server_version float;1704server # [ 130.437429] postgres[1201]: BEGIN1705server # [ 130.438974] postgres[1201]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1706server # [ 130.441296] postgres[1201]:1707server # [ 130.442856] postgres[1201]: IF server_version >= 14 THEN1708server # [ 130.445296] postgres[1201]: RETURN jsonb_build_object(1709server # [ 130.446723] postgres[1201]: 'errors', jsonb_build_array(1710server # [ 130.447689] postgres[1201]: jsonb_build_object(1711server # [ 130.450657] postgres[1201]: 'message', 'pg_graphql extension is not enabled.'1712server # [ 130.451624] postgres[1201]: )1713server # [ 130.453539] postgres[1201]: )1714server # [ 130.454674] postgres[1201]: );1715server # [ 130.455402] postgres[1201]: ELSE1716server # [ 130.456984] postgres[1201]: RETURN jsonb_build_object(1717server # [ 130.457839] postgres[1201]: 'errors', jsonb_build_array(1718server # [ 130.459551] postgres[1201]: jsonb_build_object(1719server # [ 130.462099] postgres[1201]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1720server # [ 130.464255] postgres[1201]: )1721server # [ 130.466709] postgres[1201]: )1722server # [ 130.467238] postgres[1201]: );1723server # [ 130.467744] postgres[1201]: END IF;1724server # [ 130.470101] postgres[1201]: END;1725server # [ 130.471726] postgres[1201]: $$;1726server # [ 130.473769] postgres[1201]: ::1 2026-10-20 16:14:28.737 UTC [1201] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1727server # [ 130.474987] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1200]: CREATE FUNCTION1728server # [ 130.477842] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1200]: CREATE FUNCTION1729server # [ 130.479776] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1200]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping1730server # [ 130.481896] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1200]: DROP EXTENSION1731server # [ 131.880936] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1200]: DO1732server # [ 131.928149] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql1733server # [ 132.309399] postgres[1222]: ::1 2026-10-20 16:14:30.782 UTC [1222] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres;1734server # [ 132.332189] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1214]: GRANT ROLE1735server # [ 132.376705] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql1736server # [ 132.611797] postgres[1225]: ::1 2026-10-20 16:14:31.086 UTC [1225] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1737server # [ 132.618549] postgres[1225]: returns event_trigger1738server # [ 132.619786] postgres[1225]: language plpgsql1739server # [ 132.623850] postgres[1225]: AS $func$1740server # [ 132.627495] postgres[1225]: DECLARE1741server # [ 132.629514] postgres[1225]: func_is_graphql_resolve bool;1742server # [ 132.633704] postgres[1225]: BEGIN1743server # [ 132.637111] postgres[1225]: func_is_graphql_resolve = (1744server # [ 132.642080] postgres[1225]: SELECT n.proname = 'resolve'1745server # [ 132.643538] postgres[1225]: FROM pg_event_trigger_ddl_commands() AS ev1746server # [ 132.645229] postgres[1225]: LEFT JOIN pg_catalog.pg_proc AS n1747server # [ 132.649069] postgres[1225]: ON ev.objid = n.oid1748server # [ 132.650317] postgres[1225]: );1749server # [ 132.653192] postgres[1225]:1750server # [ 132.658191] postgres[1225]: IF func_is_graphql_resolve1751server # [ 132.660885] postgres[1225]: THEN1752server # [ 132.666243] postgres[1225]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1753server # [ 132.667230] postgres[1225]: DROP FUNCTION IF EXISTS graphql_public.graphql;1754server # [ 132.667781] postgres[1225]: create or replace function graphql_public.graphql(1755server # [ 132.671174] postgres[1225]: "operationName" text default null,1756server # [ 132.672900] postgres[1225]: query text default null,1757server # [ 132.676898] postgres[1225]: variables jsonb default null,1758server # [ 132.677959] postgres[1225]: extensions jsonb default null1759server # [ 132.679019] postgres[1225]: )1760server # [ 132.683846] postgres[1225]: returns jsonb1761server # [ 132.685480] postgres[1225]: language sql1762server # [ 132.689324] postgres[1225]: as $$1763server # [ 132.692951] postgres[1225]: select graphql.resolve(1764server # [ 132.697039] postgres[1225]: query := query,1765server # [ 132.698313] postgres[1225]: variables := coalesce(variables, '{}'),1766server # [ 132.704867] postgres[1225]: "operationName" := "operationName",1767server # [ 132.706200] postgres[1225]: extensions := extensions1768server # [ 132.707495] postgres[1225]: );1769server # [ 132.713381] postgres[1225]: $$;1770server # [ 132.715151] postgres[1225]:1771server # [ 132.715706] postgres[1225]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1772server # [ 132.720966] postgres[1225]: -- function in the extension so we need to grant permissions on existing entities AND1773server # [ 132.722637] postgres[1225]: -- update default permissions to any others that are created after `graphql.resolve`1774server # [ 132.727447] postgres[1225]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1775server # [ 132.737769] postgres[1225]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1776server # [ 132.741539] postgres[1225]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1777server # [ 132.749360] postgres[1225]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1778server # [ 132.751976] postgres[1225]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1779server # [ 132.754872] postgres[1225]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1780server # [ 132.756054] postgres[1225]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1781server # [ 132.764888] postgres[1225]: END IF;1782server # [ 132.768991] postgres[1225]:1783server # [ 132.770842] postgres[1225]: END;1784server # [ 132.775977] postgres[1225]: $func$;1785server # [ 132.779418] postgres[1225]: ::1 2026-10-20 16:14:31.146 UTC [1225] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1786server # [ 132.795578] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1224]: CREATE FUNCTION1787server # [ 132.801582] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1224]: DROP EXTENSION1788server # [ 133.925515] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1224]: DO1789server # [ 133.955059] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql1790server # [ 134.990389] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1226]: DO1791server # [ 135.613703] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1226]: DO1792server # [ 135.656091] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql1793server # [ 135.911177] postgres[1249]: ::1 2026-10-20 16:14:34.385 UTC [1249] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s';1794server # [ 135.923472] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1248]: ALTER ROLE1795server # [ 135.962510] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql1796server # [ 136.225300] postgres[1251]: ::1 2026-10-20 16:14:34.696 UTC [1251] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator;1797server # [ 136.232457] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1250]: REVOKE ROLE1798server # [ 136.285170] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql1799server # [ 138.175027] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1800server # [ 138.290866] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1252]: DO1801server # [ 138.331475] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql1802server # [ 138.715463] postgres[1275]: ::1 2026-10-20 16:14:37.166 UTC [1275] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres;1803server # [ 138.766996] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1270]: GRANT ROLE1804server # [ 138.789768] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql1805server # [ 139.034585] 8021q: 802.1Q VLAN Support v1.81806server # [ 139.247997] postgres[1280]: ::1 2026-10-20 16:14:37.714 UTC [1280] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option;1807server # [ 139.294627] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1278]: GRANT1808server # [ 139.298273] postgres[1280]: ::1 2026-10-20 16:14:37.773 UTC [1280] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option;1809server # [ 139.366119] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1278]: GRANT1810server # [ 139.371790] postgres[1280]: ::1 2026-10-20 16:14:37.847 UTC [1280] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option;1811server # [ 139.380888] postgres[1280]: ::1 2026-10-20 16:14:37.854 UTC [1280] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;1812server # [ 139.382958] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1278]: GRANT1813server # [ 139.397482] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1278]: ALTER DEFAULT PRIVILEGES1814server # [ 139.400452] postgres[1280]: ::1 2026-10-20 16:14:37.880 UTC [1280] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;1815server # [ 139.428459] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1278]: ALTER DEFAULT PRIVILEGES1816server # [ 139.435663] postgres[1280]: ::1 2026-10-20 16:14:37.913 UTC [1280] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;1817server # [ 139.458611] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1278]: ALTER DEFAULT PRIVILEGES1818server # [ 139.510357] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql1819server # [ 139.781975] cfg80211: Loading compiled-in X.509 certificates for regulatory database1820server # [ 139.941783] postgres[1283]: ::1 2026-10-20 16:14:38.397 UTC [1283] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres;1821server # [ 139.982813] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1281]: GRANT ROLE1822server # [ 140.002891] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql1823server # [ 140.102464] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1824server # [ 140.116331] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1825server # [ 140.146255] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21826server # [ 140.146873] cfg80211: failed to load regulatory.db1827server # [ 140.279342] postgres[1288]: ::1 2026-10-20 16:14:38.751 UTC [1288] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin;1828server # [ 140.313527] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1285]: GRANT ROLE1829server # [ 140.324931] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql1830server # [ 140.600171] postgres[1290]: ::1 2026-10-20 16:14:39.068 UTC [1290] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit;1831server # [ 140.618912] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1289]: ALTER ROLE1832server # [ 140.623126] postgres[1290]: ::1 2026-10-20 16:14:39.090 UTC [1290] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit;1833server # [ 140.625688] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1289]: ALTER ROLE1834server # [ 140.630804] postgres[1290]: ::1 2026-10-20 16:14:39.107 UTC [1290] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit;1835server # [ 140.644286] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1289]: ALTER ROLE1836server # [ 140.681038] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1289]: DO1837server # [ 140.747648] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql1838server # [ 141.082828] postgres[1297]: ::1 2026-10-20 16:14:39.548 UTC [1297] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin;1839server # [ 141.106624] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1291]: GRANT ROLE1840server # [ 141.110461] postgres[1297]: ::1 2026-10-20 16:14:39.577 UTC [1297] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin;1841server # [ 141.120064] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1291]: REVOKE ROLE1842server # [ 141.170365] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql1843server # [ 141.513944] postgres[1307]: ::1 2026-10-20 16:14:39.972 UTC [1307] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1844server # [ 141.522433] postgres[1307]: returns event_trigger1845server # [ 141.530483] postgres[1307]: language plpgsql1846server # [ 141.537508] postgres[1307]: AS $func$1847server # [ 141.539478] postgres[1307]: DECLARE1848server # [ 141.541144] postgres[1307]: func_is_graphql_resolve bool;1849server # [ 141.545284] postgres[1307]: BEGIN1850server # [ 141.550835] postgres[1307]: func_is_graphql_resolve = (1851server # [ 141.557330] postgres[1307]: SELECT n.proname = 'resolve'1852server # [ 141.559246] postgres[1307]: FROM pg_event_trigger_ddl_commands() AS ev1853server # [ 141.566257] postgres[1307]: LEFT JOIN pg_catalog.pg_proc AS n1854server # [ 141.567257] postgres[1307]: ON ev.objid = n.oid1855server # [ 141.568807] postgres[1307]: );1856server # [ 141.569687] postgres[1307]:1857server # [ 141.575372] postgres[1307]: IF func_is_graphql_resolve1858server # [ 141.581705] postgres[1307]: THEN1859server # [ 141.582753] postgres[1307]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1860server # [ 141.587939] postgres[1307]: DROP FUNCTION IF EXISTS graphql_public.graphql;1861server # [ 141.589819] postgres[1307]: create or replace function graphql_public.graphql(1862server # [ 141.591446] postgres[1307]: "operationName" text default null,1863server # [ 141.592621] postgres[1307]: query text default null,1864server # [ 141.595704] postgres[1307]: variables jsonb default null,1865server # [ 141.603031] postgres[1307]: extensions jsonb default null1866server # [ 141.605594] postgres[1307]: )1867server # [ 141.611365] postgres[1307]: returns jsonb1868server # [ 141.612271] postgres[1307]: language sql1869server # [ 141.614524] postgres[1307]: as $$1870server # [ 141.615421] postgres[1307]: select graphql.resolve(1871server # [ 141.619120] postgres[1307]: query := query,1872server # [ 141.629314] postgres[1307]: variables := coalesce(variables, '{}'),1873server # [ 141.630633] postgres[1307]: "operationName" := "operationName",1874server # [ 141.631717] postgres[1307]: extensions := extensions1875server # [ 141.633384] postgres[1307]: );1876server # [ 141.634962] postgres[1307]: $$;1877server # [ 141.641786] postgres[1307]:1878server # [ 141.642966] postgres[1307]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1879server # [ 141.644136] postgres[1307]: -- function in the extension so we need to grant permissions on existing entities AND1880server # [ 141.646209] postgres[1307]: -- update default permissions to any others that are created after `graphql.resolve`1881server # [ 141.649696] postgres[1307]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1882server # [ 141.651861] postgres[1307]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1883server # [ 141.657735] postgres[1307]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1884server # [ 141.659147] postgres[1307]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1885server # [ 141.664826] postgres[1307]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1886server # [ 141.667173] postgres[1307]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1887server # [ 141.670837] postgres[1307]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1888server # [ 141.677746] postgres[1307]:1889server # [ 141.681140] postgres[1307]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles1890server # [ 141.682808] postgres[1307]: grant usage on schema graphql_public to postgres with grant option;1891server # [ 141.694479] postgres[1307]: grant usage on schema graphql to postgres with grant option;1892server # [ 141.697311] postgres[1307]: END IF;1893server # [ 141.701885] postgres[1307]:1894server # [ 141.708003] postgres[1307]: END;1895server # [ 141.711137] postgres[1307]: $func$;1896server # [ 141.719546] postgres[1307]: ::1 2026-10-20 16:14:40.085 UTC [1307] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1897server # [ 141.735095] (udev-worker)[1293]: Network interface NamePolicy= disabled on kernel command line.1898server # [ 141.759915] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1302]: CREATE FUNCTION1899server # [ 141.762850] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1302]: DROP EXTENSION1900server # [ 141.778987] (udev-worker)[1294]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1901server # [ 141.789221] (udev-worker)[1294]: Network interface NamePolicy= disabled on kernel command line.1902server # [ 142.791538] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1903server # [ 142.861391] systemd[1]: Started backdoor.service.1904server # [ 143.138637] systemd[1]: Condition check resulted in Virtio network device being skipped.1905server # [ 143.246870] systemd[1]: Starting Address configuration of eth1...1906server # [ 143.422092] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1302]: DO1907server # [ 143.487303] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql1908server # [ 144.116337] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1323]: DO1909server # [ 144.171441] postgres[1327]: ::1 2026-10-20 16:14:42.601 UTC [1327] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger1910server # [ 144.180309] postgres[1327]: LANGUAGE plpgsql1911server # [ 144.193572] postgres[1327]: AS $$1912server # [ 144.194665] postgres[1327]: BEGIN1913server # [ 144.196296] postgres[1327]: IF EXISTS (1914server # connecting to host...1915server # [ 144.204033] postgres[1327]: SELECT1916server # [ 144.210808] postgres[1327]: FROM pg_event_trigger_ddl_commands() AS ev1917server # [ 144.217559] postgres[1327]: JOIN pg_extension AS ext1918server # [ 144.226772] postgres[1327]: ON ev.objid = ext.oid1919server # [ 144.240635] postgres[1327]: WHERE ext.extname = 'pg_cron'1920server # [ 144.254588] postgres[1327]: )1921server # [ 144.257419] postgres[1327]: THEN1922server # [ 144.270395] postgres[1327]: grant usage on schema cron to postgres with grant option;1923server # [ 144.280206] postgres[1327]:1924server # [ 144.302481] postgres[1327]: alter default privileges in schema cron grant all on tables to postgres with grant option;1925server # [ 144.303389] postgres[1327]: alter default privileges in schema cron grant all on functions to postgres with grant option;1926server # [ 144.304078] postgres[1327]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1927server # [ 144.315916] postgres[1327]:1928server # [ 144.334315] postgres[1327]: alter default privileges for user supabase_admin in schema cron grant all1929server # [ 144.349205] postgres[1327]: on sequences to postgres with grant option;1930server # [ 144.352309] postgres[1327]: alter default privileges for user supabase_admin in schema cron grant all1931server # [ 144.370151] postgres[1327]: on tables to postgres with grant option;1932server # [ 144.371202] postgres[1327]: alter default privileges for user supabase_admin in schema cron grant all1933server # [ 144.381686] postgres[1327]: on functions to postgres with grant option;1934server # [ 144.383223] postgres[1327]:1935server # [ 144.392326] postgres[1327]: grant all privileges on all tables in schema cron to postgres with grant option;1936server # [ 144.405090] postgres[1327]: revoke all on table cron.job from postgres;1937server # [ 144.407582] postgres[1327]: grant select on table cron.job to postgres with grant option;1938server # [ 144.423656] postgres[1327]: END IF;1939server # [ 144.443668] postgres[1327]: END;1940server # [ 144.455552] postgres[1327]: $$;1941server # [ 144.465713] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1323]: CREATE FUNCTION1942server # [ 144.467024] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1323]: DROP EVENT TRIGGER1943server # [ 144.467920] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1323]: ALTER FUNCTION1944server # [ 144.498226] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1323]: CREATE EVENT TRIGGER1945server # [ 144.538121] postgres[1327]: ::1 2026-10-20 16:14:42.853 UTC [1327] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access;1946server # [ 144.545107] postgres[1327]: ::1 2026-10-20 16:14:42.893 UTC [1327] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;1947server # [ 144.546516] postgres[1327]: ::1 2026-10-20 16:14:42.924 UTC [1327] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end1948server # [ 144.547852] postgres[1327]: WHEN TAG IN ('CREATE EXTENSION')1949server # [ 144.651786] 8021q: adding VLAN 0 to HW filter on device eth01950server # [ 144.585660] postgres[1327]: EXECUTE FUNCTION extensions.grant_pg_cron_access();1951server # [ 144.623670] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql1952server # [ 144.683081] dhcpcd[750]: eth0: waiting for carrier1953server # [ 144.691283] dhcpcd[750]: eth0: carrier acquired1954server: Guest shell says: b'Spawning backdoor root shell...\n'1955server: connected to guest root shell1956server: (connecting took 145.99 seconds)1957server: (finished: waiting for the VM to finish booting, in 145.99 seconds)1958server # [ 144.941078] 8021q: adding VLAN 0 to HW filter on device eth11959server # [ 144.986519] dhcpcd[750]: DUID 00:01:00:01:32:6a:4f:f3:52:54:00:12:34:561960server # [ 145.006688] dhcpcd[750]: eth0: IAID 00:12:34:561961server # [ 145.007897] dhcpcd[750]: eth0: adding address fe80::5054:ff:fe12:34561962server # [ 145.201960] network-addresses-eth1-start[1321]: adding address 192.168.1.1/24... done1963server # [ 145.264184] postgres[1340]: ::1 2026-10-20 16:14:43.708 UTC [1340] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s';1964server # [ 145.302350] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1336]: ALTER ROLE1965server # [ 145.347608] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql1966server # [ 145.483718] network-addresses-eth1-start[1321]: adding address 2001:db8:1::1/64... done1967server # [ 145.653181] dhcpcd[750]: eth0: soliciting a DHCP lease1968server # [ 145.693370] dhcpcd[750]: eth0: offered 10.0.2.15 from 10.0.2.21969server # [ 145.705132] dhcpcd[750]: eth0: probing address 10.0.2.15/241970server # [ 145.859142] systemd[1]: Finished Address configuration of eth1.1971server # [ 145.955063] postgres[1350]: ::1 2026-10-20 16:14:44.423 UTC [1350] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin;1972server # [ 146.002920] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1346]: ALTER FUNCTION1973server # [ 146.003855] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1346]: ALTER FUNCTION1974server # [ 146.019912] postgres[1350]: ::1 2026-10-20 16:14:44.471 UTC [1350] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;1975server # [ 146.049622] postgres[1350]: ::1 2026-10-20 16:14:44.481 UTC [1350] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;1976server # [ 146.077028] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1346]: ALTER FUNCTION1977server # [ 146.093766] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql1978server # [ 146.390935] postgres[1353]: ::1 2026-10-20 16:14:44.864 UTC [1353] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres;1979server # [ 146.431318] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1352]: GRANT ROLE1980server # [ 146.462799] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql1981server # [ 147.058850] dhcpcd[750]: eth0: soliciting an IPv6 router1982server # [ 147.069793] dhcpcd[750]: eth0: Router Advertisement from fe80::21983server # [ 147.075737] dhcpcd[750]: eth0: adding address fec0::5054:ff:fe12:3456/641984server # [ 147.085203] dhcpcd[750]: eth0: adding route to fec0::/641985server # [ 147.089864] dhcpcd[750]: eth0: adding default route via fe80::21986server # [ 147.358675] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1354]: DO1987server # [ 147.417610] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql1988server # [ 147.978437] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1356]: DO1989server # [ 147.998900] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1356]: DO1990server # [ 148.055119] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql1991server # [ 148.483602] postgres[1382]: ::1 2026-10-20 16:14:46.955 UTC [1382] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none;1992server # [ 148.530866] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1376]: ALTER ROLE1993server # [ 148.541636] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1376]: ALTER ROLE1994server # [ 148.543017] postgres[1382]: ::1 2026-10-20 16:14:46.978 UTC [1382] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none;1995server # [ 148.551746] postgres[1382]: ::1 2026-10-20 16:14:47.013 UTC [1382] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none;1996server # [ 148.566216] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1376]: ALTER ROLE1997server # [ 148.650158] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql1998server # [ 149.190960] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1385]: DO1999server # [ 149.257243] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql2000server # [ 149.770839] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1391]: DO2001server # [ 149.827359] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql2002server # [ 149.867881] dhcpcd[750]: eth0: leased 10.0.2.15 for 86400 seconds2003server # [ 149.881212] dhcpcd[750]: eth0: adding route to 10.0.2.0/242004server # [ 149.891105] dhcpcd[750]: eth0: adding default route via 10.0.2.22005server # [ 150.546668] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1393]: CREATE FUNCTION2006server # [ 150.549016] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1393]: DO2007server # [ 150.592551] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql2008server # [ 151.198580] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1405]: ALTER FUNCTION2009server # [ 151.253610] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1405]: GRANT2010server # [ 151.328817] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql2011server # [ 151.784380] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1421]: DROP EVENT TRIGGER2012server # [ 151.841868] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1421]: ALTER FUNCTION2013server # [ 151.859279] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1421]: CREATE EVENT TRIGGER2014server # [ 151.900826] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql2015server # [ 152.640072] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1435]: DO2016server # [ 152.705365] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql2017server # [ 153.461502] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1456]: CREATE FUNCTION2018server # [ 153.471003] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1456]: GRANT2019server # [ 153.522093] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql2020server # [ 153.979645] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1483]: REVOKE ROLE2021server # [ 154.045302] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1483]: DO2022server # [ 154.059874] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1483]: DO2023server # [ 154.072859] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1483]: REVOKE ROLE2024server # [ 154.088928] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1483]: REVOKE2025server # [ 154.129475] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1483]: DO2026server # [ 154.221609] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql2027server # [ 154.689799] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1489]: DO2028server # [ 154.715544] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql2029server # [ 155.108013] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1493]: DO2030server # [ 155.145924] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql2031server # [ 155.474949] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1495]: DO2032server # [ 155.514185] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql2033server # [ 155.782162] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1497]: ALTER ROLE2034server # [ 155.828888] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql2035server # [ 156.212794] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1499]: GRANT ROLE2036server # [ 156.222009] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1499]: DO2037server # [ 156.265488] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql2038server # [ 156.864505] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1514]: GRANT2039server # [ 156.953827] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql2040server # [ 157.513270] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1527]: CREATE FUNCTION2041server # [ 157.525516] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1527]: REVOKE2042server # [ 157.550221] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1527]: REVOKE2043server # [ 157.577329] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1527]: GRANT2044server # [ 157.609853] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql2045server # [ 157.954529] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1529]: DO2046server # [ 158.025111] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql2047server # [ 158.520329] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1531]: ALTER ROLE2048server # [ 158.534562] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql2049server # [ 159.012000] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1537]: DROP EXTENSION2050server # [ 159.071867] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql2051server # [ 159.442415] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1539]: CREATE FUNCTION2052server # [ 159.449539] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1539]: DROP EVENT TRIGGER2053server # [ 159.463498] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1539]: CREATE EVENT TRIGGER2054server # [ 159.515794] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql2055server # [ 159.933647] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1541]: DO2056server # [ 159.958995] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1541]: CREATE FUNCTION2057server # [ 160.029570] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql2058server # [ 160.594421] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1562]: CREATE FUNCTION2059server # [ 160.601783] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1562]: CREATE FUNCTION2060server # [ 160.666240] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql2061server # [ 161.331851] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1569]: CREATE FUNCTION2062server # [ 161.337548] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1569]: CREATE FUNCTION2063server # [ 161.390946] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1569]: CREATE FUNCTION2064server # [ 161.438701] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1569]: CREATE FUNCTION2065server # [ 161.446688] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1569]: CREATE FUNCTION2066server # [ 161.465995] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1569]: CREATE FUNCTION2067server # [ 161.516893] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Running postgresql schema...2068server # [ 161.851567] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER DATABASE2069server # [ 161.865986] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER DATABASE2070server # [ 162.010102] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER ROLE2071server # [ 162.127875] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER ROLE2072server # [ 162.209433] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER ROLE2073server # [ 162.280853] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER ROLE2074server # [ 162.375408] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER ROLE2075server # [ 162.434831] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER ROLE2076server # [ 162.521455] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER ROLE2077server # [ 162.581574] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER ROLE2078server # [ 162.641932] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER ROLE2079server # [ 162.651246] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1571]: ALTER ROLE2080server # [ 162.717988] dp3jxf6535qglmzy2zdw1v37z2gdbf3x-supabase-db-init[1029]: Database initialization complete2081server # [ 162.747777] systemd[1]: Finished Supabase Database Initialization.2082server # [ 162.767026] systemd[1]: Reached target Multi-User System.2083server # [ 162.774409] systemd[1]: Startup finished in 2.715s (kernel) + 27.065s (initrd) + 2min 12.992s (userspace) = 2min 42.773s.2084server: (finished: waiting for unit supabase-db-init.service, in 165.50 seconds)2085subtest: Prepare Regression Scenario2086server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS wrappers;" 2087server # NOTICE: extension "wrappers" does not exist, skipping2088server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS wrappers;" , in 0.59 seconds)2089server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION wrappers WITH VERSION '0.6.3' CASCADE;" 2090server # [ 167.586855] systemd-logind[612]: Watching system buttons on /dev/input/event0 (gpio-keys)2091server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION wrappers WITH VERSION '0.6.3' CASCADE;" , in 3.61 seconds)2092server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'wrappers';" 2093server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'wrappers';" , in 0.70 seconds)2094server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "2095 CREATE EXTENSION postgres_fdw;2096 CREATE SERVER wrappers_upgrade_test FOREIGN DATA WRAPPER postgres_fdw2097 OPTIONS (host 'localhost');2098 " 2099server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "2100 CREATE EXTENSION postgres_fdw;2101 CREATE SERVER wrappers_upgrade_test FOREIGN DATA WRAPPER postgres_fdw2102 OPTIONS (host 'localhost');2103 " , in 1.89 seconds)2104server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT 1 FROM pg_foreign_server WHERE srvname = 'wrappers_upgrade_test';" 2105server: (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.60 seconds)2106server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION supabase_vault;" 2107server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION supabase_vault;" , in 0.75 seconds)2108server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT 1 FROM pg_extension WHERE extname = 'supabase_vault';" 2109server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT 1 FROM pg_extension WHERE extname = 'supabase_vault';" , in 0.78 seconds)2110(finished: subtest: Prepare Regression Scenario, in 8.92 seconds)2111subtest: Check Patch Wrappers Without Vault2112server: must succeed: /nix/store/nbclddlcvc5iyam218hw4crb5lkqrsjs-pg_upgrade_scripts/complete.sh execute_wrappers_patch2113server: (finished: must succeed: /nix/store/nbclddlcvc5iyam218hw4crb5lkqrsjs-pg_upgrade_scripts/complete.sh execute_wrappers_patch, in 1.43 seconds)2114(finished: subtest: Check Patch Wrappers Without Vault, in 1.43 seconds)2115(finished: run the VM test script, in 175.99 seconds)2116test script finished in 176.49s2117cleanup2118kill QemuMachine (pid 13)2119server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/76jq0mngg7m8zv5yjz1qgg0xspzi8x2w-python3-3.13.15/bin/python3.13)2120(finished: cleanup, in 0.05 seconds)