vm-test-run-plv8
checks.aarch64-linux.ext-plv8
· build #522
· 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: QEMU running (pid 13)14server # Formatting '/build/vm-state-server/tmp.9SeL0gChAQ', fmt=raw size=107374182415server # mke2fs 1.47.4 (6-Mar-2025)16server # Discarding device blocks: 0/262144 done17server # Creating filesystem with 262144 4k blocks and 65536 inodes18server # Filesystem UUID: 74f22a02-e308-44ef-af3d-2b879216f0d319server # Superblock backups stored on blocks:20server # 32768, 98304, 163840, 22937621server # 22server # Allocating group tables: 0/8 done23server # Writing inode tables: 0/8 done24server # Creating journal (8192 blocks): done25(finished: start all VMs, in 0.23 seconds)26server # Writing superblocks and filesystem accounting information: 0/8 done27server: waiting for unit supabase-db-init.service28server: waiting for the VM to finish booting29server # 30server # Virtualisation disk image created.31server # qemu-system-aarch64: Could not access KVM kernel module: No such file or directory32server # qemu-system-aarch64: failed to initialize kvm: No such file or directory33server # qemu-system-aarch64: falling back to tcg34server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]35server # [ 0.000000] Linux version 6.18.59 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Oct 26 15:09:28 UTC 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 s186968 r8192 d116136 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/4lgsdqa4kzhnxq63cg19y9hfdrywzpjg-nixos-system-server-test/init regInfo=/nix/store/2zjgg82m7gkmk697axzrsg22rahdi6fh-closure-info/registration console=ttyAMA0,115200n8 console=tty068server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/2zjgg82m7gkmk697axzrsg22rahdi6fh-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 74992 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 @100b10000 (indirect, esz 8, psz 64K, shr 1)102server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b20000 (flat, esz 8, psz 64K, shr 1)103server # [ 0.000000] GICv3: using LPI property table @0x0000000100b30000104server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b40000105server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.106server # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns107server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).108server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns109server # [ 0.000049] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns110server # [ 0.004682] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)111server # [ 0.017134] Console: colour dummy device 80x25112server # [ 0.018750] printk: legacy console [tty0] enabled113server # [ 0.025068] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)114server # [ 0.025513] pid_max: default: 32768 minimum: 301115server # [ 0.028765] LSM: initializing lsm=capability,landlock,yama,bpf,ima116server # [ 0.031130] landlock: Up and running.117server # [ 0.031233] Yama: becoming mindful.118server # [ 0.034877] LSM support for eBPF active119server # [ 0.038657] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)120server # [ 0.038922] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)121server # [ 0.084647] rcu: Hierarchical SRCU implementation.122server # [ 0.084756] rcu: Max phase no-delay instances is 1000.123server # [ 0.086061] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level124server # [ 0.094318] fsl-mc MSI: its@8080000 domain created125server # [ 0.097174] EFI services will not be available.126server # [ 0.099179] smp: Bringing up secondary CPUs ...127server # [ 0.106172] Detected PIPT I-cache on CPU1128server # [ 0.107916] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000129server # [ 0.108623] GICv3: CPU1: using allocated LPI pending table @0x0000000100b50000130server # [ 0.110263] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]131server # [ 0.114775] smp: Brought up 1 node, 2 CPUs132server # [ 0.115015] SMP: Total of 2 processors activated.133server # [ 0.115080] CPU: All CPU(s) started at EL1134server # [ 0.115404] CPU features: detected: Branch Target Identification135server # [ 0.115517] CPU features: detected: 32-bit EL0 Support136server # [ 0.115569] CPU features: detected: 32-bit EL1 Support137server # [ 0.115606] CPU features: detected: ARMv8.4 Translation Table Level138server # [ 0.115668] CPU features: detected: Instruction cache invalidation not required for I/D coherence139server # [ 0.115742] CPU features: detected: Data cache clean to the PoU not required for I/D coherence140server # [ 0.115829] CPU features: detected: Common not Private translations141server # [ 0.115875] CPU features: detected: CRC32 instructions142server # [ 0.115913] CPU features: detected: Data cache clean to Point of Deep Persistence143server # [ 0.115947] CPU features: detected: Data cache clean to Point of Persistence144server # [ 0.115982] CPU features: detected: Data independent timing control (DIT)145server # [ 0.116016] CPU features: detected: E0PD146server # [ 0.116041] CPU features: detected: Enhanced Counter Virtualization147server # [ 0.116075] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)148server # [ 0.116113] CPU features: detected: Enhanced Privileged Access Never149server # [ 0.116149] CPU features: detected: Enhanced Virtualization Traps150server # [ 0.116176] CPU features: detected: Fine Grained Traps151server # [ 0.116201] CPU features: detected: Guarded Control Stack (GCS)152server # [ 0.116263] CPU features: detected: Generic authentication (IMP DEF algorithm)153server # [ 0.116356] CPU features: detected: RCpc load-acquire (LDAPR)154server # [ 0.116411] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)155server # [ 0.116444] CPU features: detected: LSE atomic instructions156server # [ 0.116470] CPU features: detected: Memory Copy and Memory Set instructions157server # [ 0.116500] CPU features: detected: Privileged Access Never158server # [ 0.116545] CPU features: detected: PMUv3159server # [ 0.116571] CPU features: detected: SCTLR2160server # [ 0.116593] CPU features: detected: RAS Extension Support161server # [ 0.116650] CPU features: detected: RASv1p1 Extension Support162server # [ 0.116680] CPU features: detected: Random Number Generator163server # [ 0.116709] CPU features: detected: Speculation barrier (SB)164server # [ 0.116742] CPU features: detected: Stage-2 Force Write-Back165server # [ 0.116772] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality166server # [ 0.116805] CPU features: detected: TLB range maintenance instructions167server # [ 0.116837] CPU features: detected: WFx with timeout168server # [ 0.116946] CPU features: detected: Scalable Matrix Extension169server # [ 0.116981] CPU features: detected: FA64170server # [ 0.117007] CPU features: detected: SME2171server # [ 0.117033] CPU features: detected: Speculative Store Bypassing Safe (SSBS)172server # [ 0.117067] CPU features: detected: Scalable Vector Extension173server # [ 0.125976] alternatives: applying system-wide alternatives174server # [ 0.142737] CPU features: detected: Hardware dirty bit management on CPU0-1175server # [ 0.143518] SVE: maximum available vector length 256 bytes per vector176server # [ 0.143610] SVE: default vector length 64 bytes per vector177server # [ 0.144744] SME: minimum available vector length 16 bytes per vector178server # [ 0.144791] SME: maximum available vector length 256 bytes per vector179server # [ 0.144832] SME: default vector length 32 bytes per vector180server # [ 0.161190] Memory: 3904032K/4194304K available (24384K kernel code, 7094K rwdata, 26604K rodata, 4736K init, 1103K bss, 241760K reserved, 32768K cma-reserved)181server # [ 0.188299] devtmpfs: initialized182server # [ 0.222530] posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear)183server # [ 0.222911] futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear).184server # [ 0.226126] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL185server # [ 0.226221] 0 pages in range for non-PLT usage186server # [ 0.226265] 508240 pages in range for PLT usage187server # [ 0.229491] pinctrl core: initialized pinctrl subsystem188server # [ 0.243334] DMI not present or invalid.189server # [ 0.263617] NET: Registered PF_NETLINK/PF_ROUTE protocol family190server # [ 0.275442] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations191server # [ 0.276515] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations192server # [ 0.277692] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations193server # [ 0.278029] audit: initializing netlink subsys (disabled)194server # [ 0.280270] audit: type=2000 audit(0.196:1): state=initialized audit_enabled=0 res=1195server # [ 0.287083] thermal_sys: Registered thermal governor 'fair_share'196server # [ 0.287140] thermal_sys: Registered thermal governor 'bang_bang'197server # [ 0.287206] thermal_sys: Registered thermal governor 'step_wise'198server # [ 0.287236] thermal_sys: Registered thermal governor 'user_space'199server # [ 0.287264] thermal_sys: Registered thermal governor 'power_allocator'200server # [ 0.288359] cpuidle: using governor ladder201server # [ 0.288651] cpuidle: using governor menu202server # [ 0.290886] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.203server # [ 0.291665] ASID allocator initialised with 65536 entries204server # [ 0.298903] Serial: AMBA PL011 UART driver205server # [ 0.361754] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1206server # [ 0.363137] printk: console [ttyAMA0] enabled207server # [ 0.416583] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages208server # [ 0.416821] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page209server # [ 0.416868] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages210server # [ 0.416901] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page211server # [ 0.416938] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages212server # [ 0.416974] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page213server # [ 0.417013] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages214server # [ 0.417049] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page215server # [ 0.441019] fbcon: Taking over console216server # [ 0.441979] ACPI: Interpreter disabled.217server # [ 0.455135] iommu: Default domain type: Translated218server # [ 0.455227] iommu: DMA domain TLB invalidation policy: strict mode219server # [ 0.460254] SCSI subsystem initialized220server # [ 0.470280] usbcore: registered new interface driver usbfs221server # [ 0.470607] usbcore: registered new interface driver hub222server # [ 0.470794] usbcore: registered new device driver usb223server # [ 0.474573] pps_core: LinuxPPS API ver. 1 registered224server # [ 0.474631] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>225server # [ 0.474724] PTP clock support registered226server # [ 0.475184] EDAC MC: Ver: 3.0.0227server # [ 0.478315] scmi_core: SCMI protocol bus registered228server # [ 0.487876] FPGA manager framework229server # [ 0.499744] vgaarb: loaded230server # [ 0.504089] clocksource: Switched to clocksource arch_sys_counter231server # [ 0.524344] VFS: Disk quotas dquot_6.6.0232server # [ 0.524884] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)233server # [ 0.527781] netfs: FS-Cache loaded234server # [ 0.529625] pnp: PnP ACPI: disabled235server # [ 0.572814] NET: Registered PF_INET protocol family236server # [ 0.574139] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)237server # [ 0.687195] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)238server # [ 0.687401] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)239server # [ 0.687572] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)240server # [ 0.689933] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)241server # [ 0.690350] TCP: Hash tables configured (established 32768 bind 32768)242server # [ 0.692256] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)243server # [ 0.692614] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)244server # [ 0.693005] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)245server # [ 0.697252] NET: Registered PF_UNIX/PF_LOCAL protocol family246server # [ 0.697678] NET: Registered PF_XDP protocol family247server # [ 0.697859] PCI: CLS 0 bytes, default 64248server # [ 0.701739] kvm [1]: HYP mode not available249server # [ 0.707808] Trying to unpack rootfs image as initramfs...250server # [ 0.948333] Initialise system trusted keyrings251server # [ 0.951190] workingset: timestamp_bits=42 max_order=20 bucket_order=0252server # [ 0.960685] squashfs: version 4.0 (2009/01/31) Phillip Lougher253server # [ 0.961739] 9p: Installing v9fs 9p2000 file system support254server # [ 1.033882] Key type asymmetric registered255server # [ 1.034321] Asymmetric key parser 'x509' registered256server # [ 1.034809] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)257server # [ 1.037972] io scheduler mq-deadline registered258server # [ 1.038073] io scheduler kyber registered259server # [ 1.089842] pl061_gpio 9030000.pl061: PL061 GPIO chip registered260server # [ 1.097628] ledtrig-cpu: registered to indicate activity on CPUs261server # [ 1.103885] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:262server # [ 1.106052] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000263server # [ 1.106743] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000264server # [ 1.106887] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000265server # [ 1.107761] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits266server # [ 1.111417] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]267server # [ 1.116008] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00268server # [ 1.118229] pci_bus 0000:00: root bus resource [bus 00-ff]269server # [ 1.118411] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]270server # [ 1.118494] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]271server # [ 1.118540] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]272server # [ 1.122342] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint273server # [ 1.129750] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint274server # [ 1.130090] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]275server # [ 1.130213] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]276server # [ 1.130279] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]277server # [ 1.130368] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]278server # [ 1.130937] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint279server # [ 1.131090] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]280server # [ 1.131136] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]281server # [ 1.131178] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]282server # [ 1.131690] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint283server # [ 1.131776] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]284server # [ 1.138060] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]285server # [ 1.138158] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]286server # [ 1.138884] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint287server # [ 1.139014] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]288server # [ 1.139063] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]289server # [ 1.139114] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]290server # [ 1.139586] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint291server # [ 1.139673] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]292server # [ 1.139711] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]293server # [ 1.139752] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]294server # [ 1.140244] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint295server # [ 1.140344] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]296server # [ 1.140382] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]297server # [ 1.140422] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298server # [ 1.140851] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint299server # [ 1.140935] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]300server # [ 1.140972] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]301server # [ 1.141012] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]302server # [ 1.141051] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]303server # [ 1.141504] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint304server # [ 1.141593] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]305server # [ 1.141635] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]306server # [ 1.142073] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint307server # [ 1.142156] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]308server # [ 1.142197] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]309server # [ 1.142689] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint310server # [ 1.142775] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]311server # [ 1.151558] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint312server # [ 1.153006] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]313server # [ 1.153083] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]314server # [ 1.153129] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]315server # [ 1.153732] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint316server # [ 1.153838] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]317server # [ 1.153878] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]318server # [ 1.153920] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]319server # [ 1.158731] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned320server # [ 1.158949] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned321server # [ 1.159315] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned322server # [ 1.159731] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned323server # [ 1.161290] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned324server # [ 1.161371] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned325server # [ 1.161572] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned326server # [ 1.161631] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned327server # [ 1.161692] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned328server # [ 1.161757] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned329server # [ 1.161816] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned330server # [ 1.161875] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned331server # [ 1.162275] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned332server # [ 1.162471] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned333server # [ 1.162635] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned334server # [ 1.162731] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned335server # [ 1.162949] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned336server # [ 1.163082] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned337server # [ 1.163129] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned338server # [ 1.163174] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned339server # [ 1.163224] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned340server # [ 1.163268] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned341server # [ 1.163310] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned342server # [ 1.163352] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned343server # [ 1.163394] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned344server # [ 1.163445] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned345server # [ 1.163503] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned346server # [ 1.163543] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned347server # [ 1.163583] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned348server # [ 1.163623] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned349server # [ 1.163663] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned350server # [ 1.163702] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned351server # [ 1.163742] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned352server # [ 1.163781] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned353server # [ 1.173368] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]354server # [ 1.173466] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]355server # [ 1.173508] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]356server # [ 1.175194] pci 0000:00:0a.0: enabling device (0000 -> 0002)357server # [ 1.273640] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)358server # [ 1.278674] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)359server # [ 1.283401] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)360server # [ 1.290233] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)361server # [ 1.295439] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)362server # [ 1.299541] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)363server # [ 1.305331] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)364server # [ 1.311293] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)365server # [ 1.316663] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)366server # [ 1.320924] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)367server # [ 1.325999] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)368server # [ 1.350329] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled369server # [ 1.364521] msm_serial: driver initialized370server # [ 1.365398] SuperH (H)SCI(F) driver initialized371server # [ 1.365824] STM32 USART driver initialized372server # [ 1.433341] loop: module loaded373server # [ 1.434028] virtio_blk virtio5: 2/0/0 default/read/poll queues374server # [ 1.438735] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)375server # [ 1.454338] megasas: 07.734.00.00-rc1376server # [ 1.461116] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]377server # [ 1.463673] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000378server # [ 1.464094] Intel/Sharp Extended Query Table at 0x0031379server # [ 1.466611] Using buffer write method380server # [ 1.467374] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]381server # [ 1.469257] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000382server # [ 1.469371] Intel/Sharp Extended Query Table at 0x0031383server # [ 1.470391] Using buffer write method384server # [ 1.470548] Concatenating MTD devices:385server # [ 1.470592] (0): "0.flash"386server # [ 1.470625] (1): "0.flash"387server # [ 1.470656] into device "0.flash"388server # [ 1.776900] Freeing initrd memory: 25348K389server # [ 1.897754] tun: Universal TUN/TAP device driver, 1.6390server # [ 1.913344] thunder_xcv, ver 1.0391server # [ 1.913551] thunder_bgx, ver 1.0392server # [ 1.913693] nicpf, ver 1.0393server # [ 1.916986] e1000: Intel(R) PRO/1000 Network Driver394server # [ 1.917037] e1000: Copyright (c) 1999-2006 Intel Corporation.395server # [ 1.917200] e1000e: Intel(R) PRO/1000 Network Driver396server # [ 1.917230] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.397server # [ 1.917388] igb: Intel(R) Gigabit Ethernet Network Driver398server # [ 1.917423] igb: Copyright (c) 2007-2014 Intel Corporation.399server # [ 1.917555] igbvf: Intel(R) Gigabit Virtual Function Network Driver400server # [ 1.917587] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.401server # [ 1.918286] sky2: driver version 1.30402server # [ 1.932189] ehci-pci 0000:00:0a.0: EHCI Host Controller403server # [ 1.932623] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1404server # [ 1.934021] usbcore: registered new interface driver usb-storage405server # [ 1.934503] usbcore: registered new interface driver usbserial_generic406server # [ 1.934590] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000407server # [ 1.934732] usbserial: USB Serial support registered for generic408server # [ 1.937758] hv_vmbus: registering driver hyperv_keyboard409server # [ 1.947602] rtc-pl031 9010000.pl031: registered as rtc0410server # [ 1.948140] rtc-pl031 9010000.pl031: setting system clock to 2026-10-31T19:36:54 UTC (1793475414)411server # [ 1.949966] i2c_dev: i2c /dev entries driver412server # [ 1.955388] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00413server # [ 1.964502] hub 1-0:1.0: USB hub found414server # [ 1.965315] hub 1-0:1.0: 6 ports detected415server # [ 1.970033] sdhci: Secure Digital Host Controller Interface driver416server # [ 1.970111] sdhci: Copyright(c) Pierre Ossman417server # [ 1.971806] Synopsys Designware Multimedia Card Interface Driver418server # [ 1.974396] sdhci-pltfm: SDHCI platform and OF driver helper419server # [ 1.985888] hid: raw HID events driver (C) Jiri Kosina420server # [ 1.987946] usbcore: registered new interface driver usbhid421server # [ 1.988011] usbhid: USB HID core driver422server # [ 1.999451] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available423server # [ 2.009209] drop_monitor: Initializing network drop monitor service424server # [ 2.010484] NET: Registered PF_INET6 protocol family425server # [ 2.020355] Segment Routing with IPv6426server # [ 2.020589] In-situ OAM (IOAM) with IPv6427server # [ 2.021100] NET: Registered PF_PACKET protocol family428server # [ 2.022172] 9pnet: Installing 9P2000 support429server # [ 2.027715] Key type dns_resolver registered430server # [ 2.071383] registered taskstats version 1431server # [ 2.073852] Loading compiled-in X.509 certificates432server # [ 2.143080] Demotion targets for Node 0: null433server # [ 2.144237] Key type .fscrypt registered434server # [ 2.144290] Key type fscrypt-provisioning registered435server # [ 2.146701] ima: No TPM chip found, activating TPM-bypass!436server # [ 2.146797] ima: Allocated hash algorithm: sha1437server # [ 2.149247] ima: No architecture policies found438server # [ 2.159065] input: gpio-keys as /devices/platform/gpio-keys/input/input0439server # [ 2.229449] usb 1-1: new high-speed USB device number 2 using ehci-pci440server # [ 2.243265] clk: Disabling unused clocks441server # [ 2.243503] PM: genpd: Disabling unused power domains442server # [ 2.485972] 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.563073] 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.582854] Freeing unused kernel memory: 4736K445server # [ 2.584177] Run /init as init process446server # [ 2.690024] usb 1-2: new high-speed USB device number 3 using ehci-pci447server # [ 2.730303] systemd[1]: Successfully made /usr/ read-only.448server # [ 2.888519] 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.889357] 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.080655] systemd[1]: systemd 260.5 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)451server # [ 3.080925] systemd[1]: Detected virtualization qemu.452server # [ 3.083194] systemd[1]: Detected architecture arm64.453server # [ 3.083298] systemd[1]: Running in initrd.454server # [ 3.092661] systemd[1]: Initializing machine ID from random generator.455server # [ 3.095517] systemd[1]: Hostname set to <server>.456server # [ 3.743254] systemd[1]: Queued start job for default target Initrd Default Target.457server # [ 3.791839] systemd[1]: Created slice Slice /system/modprobe.458server # [ 3.795319] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.459server # [ 3.796656] systemd[1]: Expecting device /dev/disk/by-label/nixos...460server # [ 3.797725] systemd[1]: Reached target Path Units.461server # [ 3.798197] systemd[1]: Reached target Slice Units.462server # [ 3.798648] systemd[1]: Reached target Swaps.463server # [ 3.798857] systemd[1]: Reached target Timer Units.464server # [ 3.801788] systemd[1]: Listening on D-Bus System Message Bus Socket.465server # [ 3.806187] systemd[1]: Listening on Journal Socket (/dev/log).466server # [ 3.807507] systemd[1]: Listening on Journal Sockets.467server # [ 3.808433] systemd[1]: Listening on udev Control Socket.468server # [ 3.809035] systemd[1]: Listening on udev Kernel Socket.469server # [ 3.809212] systemd[1]: Reached target Socket Units.470server # [ 3.843663] systemd[1]: Starting Create List of Static Device Nodes...471server # [ 3.866293] systemd[1]: Starting Load Kernel Module 9pnet_virtio...472server # [ 3.866999] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs473server # [ 3.890113] systemd[1]: Mounting Kernel Configuration File System...474server # [ 3.942931] systemd[1]: Starting Journal Service...475server # [ 3.965306] systemd[1]: Starting Load Kernel Modules...476server # [ 3.967041] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki477server # [ 3.997201] systemd[1]: Starting Coldplug All udev Devices...478server # [ 4.055554] systemd[1]: Finished Create List of Static Device Nodes.479server # [ 4.099305] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.480server # [ 4.136499] systemd[1]: Finished Load Kernel Module 9pnet_virtio.481server # [ 4.140458] systemd[1]: Mounted Kernel Configuration File System.482server # [ 4.223527] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...483server # [ 4.278061] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.484server # [ 4.305173] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev485server # [ 4.341277] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0486server # [ 4.341983] [drm] features: -virgl +edid -resource_blob -host_visible487server # [ 4.342006] [drm] features: -context_init488server # [ 4.343961] [drm] number of scanouts: 1489server # [ 4.344029] [drm] number of cap sets: 0490server # [ 4.364274] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic491server # [ 4.364417] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0492server # [ 4.541769] Console: switching to colour frame buffer device 160x50493server # [ 4.563085] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device494server # [ 4.633216] systemd[1]: Finished Load Kernel Modules.495server # [ 4.677519] systemd[1]: Starting Apply Kernel Variables...496server # [ 4.713230] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.497server # [ 4.750200] systemd-journald[81]: Collecting audit messages is disabled.498server # [ 4.776227] systemd[1]: Starting Create Static Device Nodes in /dev...499server # [ 4.952676] systemd[1]: Finished Apply Kernel Variables.500server # [ 5.049559] systemd[1]: Finished Create Static Device Nodes in /dev.501server # [ 5.067069] systemd[1]: Reached target Preparation for Local File Systems.502server # [ 5.070814] systemd[1]: Reached target Local File Systems.503server # [ 5.101367] systemd[1]: Starting Rule-based Manager for Device Events and Files...504server # [ 5.690407] systemd[1]: Started Journal Service.505server # [ 5.575342] systemd-modules-load[82]: Using 2 probe threads506server # [ 5.594233] systemd-modules-load[82]: Module 'virtio_balloon' is built in507server # [ 5.598679] systemd-modules-load[82]: Module 'virtio_console' is built in508server # [ 5.611202] systemd-modules-load[82]: Inserted module 'dm_mod'509server # [ 5.615167] systemd-modules-load[82]: Module 'virtio_rng' is built in510server # [ 5.623499] systemd-modules-load[82]: Inserted module 'virtio_gpu'511server # [ 5.639942] systemd-udevd[89]: Using default interface naming scheme 'v260'.512server # [ 5.647916] systemd[1]: Starting Create System Files and Directories...513server # [ 5.874157] systemd[1]: Finished Create System Files and Directories.514server # [ 5.997689] systemd[1]: Started Rule-based Manager for Device Events and Files.515server # [ 6.477501] systemd[1]: Starting Virtual Console Setup...516server # [ 6.755810] systemd-vconsole-setup[111]: Configuration of first virtual console was skipped, ignoring remaining ones.517server # [ 6.777653] systemd[1]: Finished Virtual Console Setup.518server # [ 10.417582] systemd[1]: Finished Coldplug All udev Devices.519server # [ 10.420044] systemd[1]: Reached target System Initialization.520server # [ 10.425918] systemd[1]: Reached target Basic System.521server # [ 12.701393] (udev-worker)[128]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.522server # [ 12.737880] (udev-worker)[124]: Network interface NamePolicy= disabled on kernel command line.523server # [ 12.746623] (udev-worker)[128]: Network interface NamePolicy= disabled on kernel command line.524server # [ 13.205114] systemd[1]: Found device /dev/disk/by-label/nixos.525server # [ 13.206942] systemd[1]: Reached target Initrd Root Device.526server # [ 13.211119] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...527server # [ 13.505903] systemd-fsck[139]: nixos: clean, 12/65536 files, 13019/262144 blocks528server # [ 13.547494] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.529server # [ 13.572843] systemd[1]: Mounting /sysroot...530server # [ 13.965619] EXT4-fs (vda): mounted filesystem 74f22a02-e308-44ef-af3d-2b879216f0d3 r/w with ordered data mode. Quota mode: none.531server # [ 13.863575] systemd[1]: Mounted /sysroot.532server # [ 13.875669] systemd[1]: Reached target Initrd Root File System.533server # [ 13.919788] systemd[1]: Mounting /sysroot/nix/.ro-store...534server # [ 13.967642] systemd[1]: Mounting /sysroot/nix/.rw-store...535server # [ 14.045873] systemd[1]: Mounting /sysroot/run...536server # [ 14.122910] systemd[1]: Mounting /sysroot/tmp/shared...537server # [ 14.188990] systemd[1]: Mounting /sysroot/tmp/xchg...538server # [ 14.245877] systemd[1]: Starting Mountpoints Configured in the Real Root...539server # [ 14.323721] systemd[1]: Mounted /sysroot/nix/.ro-store.540server # [ 14.369835] systemd[1]: Mounted /sysroot/nix/.rw-store.541server # [ 14.469109] systemd[1]: Mounted /sysroot/run.542server # [ 14.470794] systemd[1]: Mounted /sysroot/tmp/shared.543server # [ 14.545273] systemd-sysroot-fstab-check[152]: /sysroot should be mounted in the initrd, will request daemon-reload.544server # [ 14.547295] systemd[1]: Mounted /sysroot/tmp/xchg.545server # [ 14.581407] systemd[1]: Starting rw-sysroot-nix-store.service...546server # [ 14.586964] systemd[1]: Reload requested from client PID 152 ('systemd-sysroot') (unit initrd-parse-etc.service)...547server # [ 14.589571] systemd[1]: Reloading...548server # [ 15.739508] systemd[1]: Reloading finished in 1142 ms.549server # [ 15.825259] systemd-sysroot-fstab-check[152]: Requesting initrd-fs.target/start/replace...550server # [ 15.833274] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.551server # [ 15.836696] systemd[1]: Finished rw-sysroot-nix-store.service.552server # [ 15.855997] systemd-sysroot-fstab-check[152]: Requesting swap.target/start/replace...553server # [ 15.890228] systemd[1]: initrd-parse-etc.service: Deactivated successfully.554server # [ 15.895184] systemd[1]: Finished Mountpoints Configured in the Real Root.555server # [ 15.899226] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.556server # [ 15.945496] systemd[1]: Starting rw-sysroot-nix-store.service...557server # [ 16.065656] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.558server # [ 16.075525] systemd[1]: Finished rw-sysroot-nix-store.service.559server # [ 16.112349] systemd[1]: Mounting /sysroot/nix/store...560server # [ 16.479743] systemd[1]: Mounted /sysroot/nix/store.561server # [ 16.502610] systemd[1]: Reached target Initrd File Systems.562server # [ 16.541372] systemd[1]: Starting Find NixOS closure...563server # [ 16.590216] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...564server # [ 16.908564] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.565server # [ 16.933531] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.566server # [ 17.241018] systemd[1]: Finished Find NixOS closure.567server # [ 17.248020] systemd[1]: Reached target Initrd Default Target.568server # [ 17.270254] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...569server # [ 17.502378] systemd[1]: initrd-cleanup.service: Deactivated successfully.570server # [ 17.506367] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.571server # [ 17.524905] systemd[1]: Stopped target Initrd Default Target.572server # [ 17.526591] systemd[1]: Stopped target Basic System.573server # [ 17.531519] systemd[1]: Stopped target Initrd Root Device.574server # [ 17.541313] systemd[1]: Stopped target Path Units.575server # [ 17.543503] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.576server # [ 17.548063] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.577server # [ 17.554060] systemd[1]: Stopped target Slice Units.578server # [ 17.559233] systemd[1]: Stopped target Socket Units.579server # [ 17.561956] systemd[1]: Stopped target System Initialization.580server # [ 17.565540] systemd[1]: Stopped target Swaps.581server # [ 17.569665] systemd[1]: Stopped target Timer Units.582server # [ 17.571798] systemd[1]: dbus.socket: Deactivated successfully.583server # [ 17.574000] systemd[1]: Closed D-Bus System Message Bus Socket.584server # [ 17.576584] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.585server # [ 17.578227] systemd[1]: Stopped Find NixOS closure.586server # [ 17.579156] systemd[1]: Starting Load Kernel Module 9pnet_virtio...587server # [ 17.598735] systemd[1]: Starting rw-sysroot-nix-store.service...588server # [ 17.607337] systemd[1]: systemd-sysctl.service: Deactivated successfully.589server # [ 17.614510] systemd[1]: Stopped Apply Kernel Variables.590server # [ 17.624295] systemd[1]: systemd-modules-load.service: Deactivated successfully.591server # [ 17.634077] systemd[1]: Stopped Load Kernel Modules.592server # [ 17.637980] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.593server # [ 17.643589] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.594server # [ 17.651172] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.595server # [ 17.653304] systemd[1]: Stopped Create System Files and Directories.596server # [ 17.656742] systemd[1]: Stopped target Local File Systems.597server # [ 17.661838] systemd[1]: Stopped target Preparation for Local File Systems.598server # [ 17.664937] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.599server # [ 17.669549] systemd[1]: Stopped Coldplug All udev Devices.600server # [ 17.673377] systemd[1]: systemd-udev-trigger.service: Consumed 5.381s CPU time over 13.805s wall clock time, 9.5M memory peak.601server # [ 17.681459] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.602server # [ 17.684797] systemd[1]: Stopped Virtual Console Setup.603server # [ 17.740957] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.604server # [ 17.748530] systemd[1]: Finished Load Kernel Module 9pnet_virtio.605server # [ 17.795346] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.606server # [ 17.797891] systemd[1]: Finished rw-sysroot-nix-store.service.607server # [ 18.098101] systemd[1]: systemd-udevd.service: Deactivated successfully.608server # [ 18.102665] systemd[1]: Stopped Rule-based Manager for Device Events and Files.609server # [ 18.103904] systemd[1]: systemd-udevd.service: Consumed 8.946s CPU time over 13.127s wall clock time, 24.6M memory peak.610server # [ 18.109382] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.611server # [ 18.113348] systemd[1]: Closed udev Control Socket.612server # [ 18.126816] systemd[1]: Starting Cleanup udev Database...613server # [ 18.133174] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.614server # [ 18.136099] systemd[1]: Stopped Create Static Device Nodes in /dev.615server # [ 18.139349] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.616server # [ 18.142333] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.617server # [ 18.144989] systemd[1]: kmod-static-nodes.service: Deactivated successfully.618server # [ 18.149985] systemd[1]: Stopped Create List of Static Device Nodes.619server # [ 18.285957] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.620server # [ 18.290378] systemd[1]: Finished Cleanup udev Database.621server # [ 18.301989] systemd[1]: Reached target Switch Root.622server # [ 18.317520] systemd[1]: Starting NixOS Activation...623server # [ 20.140183] initrd-nixos-activation-start[219]: booting system configuration /nix/store/4lgsdqa4kzhnxq63cg19y9hfdrywzpjg-nixos-system-server-test624server # [ 20.815195] initrd-nixos-activation-start[219]: running activation script...625server # [ 25.153506] initrd-nixos-activation-start[242]: setting up /etc...626server # [ 27.655011] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.627server # [ 27.659160] systemd[1]: Finished NixOS Activation.628server # [ 27.660112] systemd[1]: initrd-nixos-activation.service: Consumed 4.791s CPU time over 9.336s wall clock time, 22.6M memory peak.629server # [ 27.680870] systemd[1]: Starting Switch Root...630server # [ 27.819846] systemd[1]: Switching root.631server # [ 28.118286] systemd-journald[81]: Received SIGTERM from PID 1 (systemd).632server: Guest root shell did not produce any data yet...633server: To debug, enter the VM and run 'systemctl status backdoor.service'.634server # [ 30.310875] systemd[1]: systemd 260.5 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)635server # [ 30.313362] systemd[1]: Detected virtualization qemu.636server # [ 30.315396] systemd[1]: Detected architecture arm64.637server # [ 30.318233] systemd[1]: Detected first boot.638server # [ 30.354728] systemd[1]: Initializing machine ID from random generator.639server # [ 31.665018] systemd[1]: bpf-restrict-fs: LSM BPF program attached640server # [ 33.068273] systemd[1]: Applying preset policy.641server # [ 37.498106] systemd[1]: Populated /etc with preset unit settings.642server # [ 42.486628] systemd[1]: initrd-switch-root.service: Deactivated successfully.643server # [ 42.496726] systemd[1]: Stopped initrd-switch-root.service.644server # [ 42.527115] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.645server # [ 42.546251] systemd[1]: Created slice Slice /system/getty.646server # [ 42.562325] systemd[1]: Created slice User and Session Slice.647server # [ 42.569876] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.648server # [ 42.575125] systemd[1]: Started Forward Password Requests to Wall Directory Watch.649server # [ 42.581320] systemd[1]: Expecting device /dev/hvc0...650server # [ 42.585789] systemd[1]: Expecting device /dev/ttyAMA0...651server # [ 42.590003] systemd[1]: Reached target Local Encrypted Volumes.652server # [ 42.594514] systemd[1]: Stopped target initrd-fs.target.653server # [ 42.599446] systemd[1]: Stopped target initrd-root-fs.target.654server # [ 42.604774] systemd[1]: Stopped target initrd-switch-root.target.655server # [ 42.608643] systemd[1]: Reached target Virtual Machines and Containers.656server # [ 42.613494] systemd[1]: Reached target Path Units.657server # [ 42.616415] systemd[1]: Reached target Remote File Systems.658server # [ 42.622047] systemd[1]: Reached target Slice Units.659server # [ 42.626726] systemd[1]: Reached target Swaps.660server # [ 42.668608] systemd[1]: Listening on Process Core Dump Socket.661server # [ 42.698823] systemd[1]: Listening on Credential Encryption/Decryption.662server # [ 42.745150] systemd[1]: Starting Journal Log Access Socket...663server # [ 42.758043] systemd[1]: Listening on Journal Audit Socket.664server # [ 42.771999] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.665server # [ 42.780964] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki666server # [ 42.790663] systemd[1]: Listening on udev Control Socket.667server # [ 42.835125] systemd[1]: Mounting Huge Pages File System...668server # [ 42.877467] systemd[1]: Mounting POSIX Message Queue File System...669server # [ 42.946791] systemd[1]: Mounting Kernel Debug File System...670server # [ 43.037773] systemd[1]: Mounting Kernel Trace File System...671server # [ 43.193396] systemd[1]: Starting Create List of Static Device Nodes...672server # [ 43.287639] systemd[1]: Starting Load Kernel Module 9pnet_virtio...673server # [ 43.332750] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs674server # [ 43.606258] systemd[1]: Mounting Kernel Configuration File System...675server # [ 43.642741] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm676server # [ 43.686869] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore677server # [ 43.787350] systemd[1]: Starting Load Kernel Module fuse...678server # [ 43.834178] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67679server # [ 44.093949] systemd[1]: Starting Journal Service...680server # [ 44.173201] systemd[1]: Starting Load Kernel Modules...681server # [ 44.242379] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...682server # [ 44.370678] systemd[1]: Starting Remount Root and Kernel File Systems...683server # [ 44.398364] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki684server # [ 44.625166] fuse: init (API version 7.45)685server # [ 44.726544] systemd[1]: Starting Coldplug All udev Devices...686server # [ 45.330419] systemd[1]: Listening on Journal Log Access Socket.687server # [ 45.346865] systemd[1]: Mounted Huge Pages File System.688server # [ 45.363292] systemd[1]: Mounted POSIX Message Queue File System.689server # [ 45.382692] systemd[1]: Mounted Kernel Debug File System.690server # [ 45.410918] systemd[1]: Mounted Kernel Trace File System.691server # [ 45.427344] systemd[1]: Finished Create List of Static Device Nodes.692server # [ 45.442389] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.693server # [ 45.454219] systemd[1]: Finished Load Kernel Module 9pnet_virtio.694server # [ 45.469266] systemd[1]: Mounted Kernel Configuration File System.695server # [ 45.474312] systemd[1]: modprobe@fuse.service: Deactivated successfully.696server # [ 45.485374] systemd[1]: Finished Load Kernel Module fuse.697server # [ 45.507250] systemd[1]: Finished Load Kernel Modules.698server # [ 45.560837] EXT4-fs (vda): re-mounted 74f22a02-e308-44ef-af3d-2b879216f0d3.699server # [ 45.561494] systemd[1]: Mounting FUSE Control File System...700server # [ 45.610004] systemd[1]: Starting Firewall...701server # [ 45.687690] systemd[1]: Starting Apply Kernel Variables...702server # [ 45.861775] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...703server # [ 45.863565] systemd-journald[313]: Collecting audit messages is enabled.704server # [ 46.013660] systemd[1]: Finished Remount Root and Kernel File Systems.705server # [ 46.047751] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore706server # [ 46.207254] systemd[1]: Starting Load/Save OS Random Seed...707server # [ 46.147340] systemd[1]: Queued start job for default target Multi-User System.708server # [ 46.294227] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki709server # [ 46.178986] systemd[1]: systemd-journald.service: Deactivated successfully.710server # [ 46.190607] systemd[1]: systemd-journald.service: Consumed 1.301s CPU time over 38.460s wall clock time, 9.8M memory peak.711server # [ 46.211471] systemd-modules-load[314]: Using 2 probe threads712server # [ 46.223218] systemd-modules-load[314]: Module 'atkbd' is built in713server # [ 46.237652] systemd-modules-load[314]: Module 'loop' is built in714server # [ 46.279986] systemd-oomd[315]: No swap; memory pressure usage will be degraded715server # [ 46.553702] systemd[1]: Started Journal Service.716server # [ 46.841508] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.717server # [ 47.327401] systemd[1]: Mounted FUSE Control File System.718server # [ 47.490501] systemd[1]: Finished Apply Kernel Variables.719server # [ 47.575128] systemd[1]: Finished Load/Save OS Random Seed.720server # [ 47.959541] systemd[1]: Reached target First Boot Complete.721server # [ 48.030025] systemd[1]: Starting Flush Journal to Persistent Storage...722server # [ 48.241303] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.723server # [ 48.445792] systemd[1]: Starting Create Static Device Nodes in /dev...724server # [ 48.733780] systemd-journald[313]: Received client request to flush runtime journal.725server # [ 49.254966] systemd[1]: Finished Flush Journal to Persistent Storage.726server # [ 49.494638] systemd[1]: Finished Create Static Device Nodes in /dev.727server # [ 49.524973] systemd[1]: Reached target Preparation for Local File Systems.728server # [ 49.574841] systemd[1]: Mounting /run/wrappers...729server # [ 49.677101] systemd[1]: Starting Rule-based Manager for Device Events and Files...730server # [ 50.204929] systemd[1]: Mounted /run/wrappers.731server # [ 50.261630] systemd[1]: Reached target Local File Systems.732server # [ 50.319634] systemd[1]: Listening on Boot Loader Control Service Socket.733server # [ 50.386154] systemd[1]: Starting register-nix-paths.service...734server # [ 50.490230] systemd[1]: Starting Create SUID/SGID Wrappers...735server # [ 50.499956] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.736server # [ 50.725181] systemd[1]: Starting Save Transient machine-id to Disk...737server # [ 50.966615] systemd[1]: Starting Create System Files and Directories...738server # [ 52.475232] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.739server # [ 52.522722] systemd[1]: Finished Save Transient machine-id to Disk.740server # [ 54.164246] systemd[1]: Finished Create System Files and Directories.741server # [ 54.379572] systemd[1]: Starting Rebuild Journal Catalog...742server # [ 54.576695] systemd[1]: Starting Record System Boot/Shutdown in UTMP...743server # [ 56.170826] systemd[1]: Finished Record System Boot/Shutdown in UTMP.744server # [ 57.426829] systemd[1]: Finished Rebuild Journal Catalog.745server # [ 57.587423] systemd[1]: Starting Update is Completed...746server # [ 58.617587] systemd[1]: Finished Update is Completed.747server: Guest root shell did not produce any data yet...748server: To debug, enter the VM and run 'systemctl status backdoor.service'.749server # [ 63.273174] systemd-udevd[362]: Using default interface naming scheme 'v260'.750server # [ 63.653330] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.751server # [ 63.673795] systemd[1]: Finished Create SUID/SGID Wrappers.752server # [ 63.687761] systemd[1]: suid-sgid-wrappers.service: Consumed 3.191s CPU time over 13.158s wall clock time, 5.2M memory peak.753server # [ 65.171145] systemd[1]: Started Rule-based Manager for Device Events and Files.754server # [ 67.167961] systemd[1]: Finished register-nix-paths.service.755server # [ 68.629793] systemd[1]: Finished Firewall.756server # [ 69.251217] mousedev: PS/2 mouse device common for all mice757server # [ 71.978911] systemd[1]: Finished Coldplug All udev Devices.758server # [ 71.988041] systemd[1]: Reached target System Initialization.759server # [ 72.001014] systemd[1]: Started Discard unused filesystem blocks once a week.760server # [ 72.011975] systemd[1]: Started Daily Cleanup of Temporary Directories.761server # [ 72.019804] systemd[1]: Reached target Timer Units.762server # [ 72.031342] systemd[1]: Listening on D-Bus System Message Bus Socket.763server # [ 72.035556] systemd[1]: Listening on Nix Daemon Socket.764server # [ 72.044299] systemd[1]: Listening on Hostname Service Socket.765server # [ 72.058763] systemd[1]: Reached target Socket Units.766server # [ 72.069171] systemd[1]: Reached target Basic System.767server # [ 72.080833] systemd[1]: Starting Import lastlog data into lastlog2 database...768server # [ 72.143703] systemd[1]: Starting Name Service Cache Daemon (nsncd)...769server # [ 72.248259] systemd[1]: Starting Post-Boot Actions...770server # [ 72.367836] systemd[1]: Started Reset console on configuration changes.771server # [ 72.522439] systemd[1]: Starting resolvconf update...772server # [ 73.323842] systemd[1]: Starting D-Bus System Message Bus...773server # [ 73.377216] systemd[1]: Finished Post-Boot Actions.774server # [ 73.723140] nsncd[570]: Oct 31 19:38:06.337 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"775server # [ 73.734796] systemd[1]: Started Name Service Cache Daemon (nsncd).776server # [ 73.817718] systemd[1]: Finished Import lastlog data into lastlog2 database.777server # [ 73.841093] systemd[1]: Reached target Host and Network Name Lookups.778server # [ 73.846813] systemd[1]: Reached target User and Group Name Lookups.779server # [ 74.053000] systemd[1]: Starting User Login Management...780server # [ 75.282543] dbus-broker-launch[577]: Looking up NSS user entry for 'systemd-timesync'...781server # [ 75.504903] dbus-broker-launch[577]: NSS returned no entry for 'systemd-timesync'782server # [ 75.518020] dbus-broker-launch[577]: Invalid user-name in /nix/store/vwdpn7pp7wk0r49xcqdysw2qqzsvv94q-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"783server # [ 75.898773] systemd[1]: Started D-Bus System Message Bus.784server # [ 76.103657] systemd-logind[592]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)785server # [ 76.124494] systemd-logind[592]: New seat seat0.786server # [ 76.157469] systemd[1]: Started User Login Management.787server # [ 76.241746] systemd[1]: Starting linger-users.service...788server # [ 76.614417] dbus-broker-launch[577]: Ready789server # [ 76.893996] systemd[1]: linger-users.service: Deactivated successfully.790server # [ 76.902596] systemd[1]: Finished linger-users.service.791server # [ 77.018621] systemd[1]: Stopped target Host and Network Name Lookups.792server # [ 77.027071] systemd[1]: Stopping Host and Network Name Lookups...793server # [ 77.042948] systemd[1]: Stopped target User and Group Name Lookups.794server # [ 77.055937] systemd[1]: Stopping User and Group Name Lookups...795server # [ 77.073972] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...796server # [ 77.121688] systemd[1]: nscd.service: Deactivated successfully.797server # [ 77.129162] systemd[1]: Stopped Name Service Cache Daemon (nsncd).798server # [ 77.327402] systemd[1]: Starting Name Service Cache Daemon (nsncd)...799server # [ 78.083529] systemd[1]: Started Name Service Cache Daemon (nsncd).800server # [ 78.110722] systemd[1]: Reached target Host and Network Name Lookups.801server # [ 78.135219] nsncd[642]: Oct 31 19:38:10.746 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"802server # [ 78.138872] systemd[1]: Reached target User and Group Name Lookups.803server # [ 78.565317] systemd[1]: Finished resolvconf update.804server # [ 78.612669] systemd[1]: Reached target Preparation for Network.805server # [ 78.719190] systemd[1]: Starting DHCP Client...806server # [ 78.825978] systemd[1]: Starting Extra networking commands....807server # [ 81.370862] dhcpcd[692]: dhcpcd-10.3.1 starting808server # [ 81.586749] dhcpcd[729]: dev: loaded udev809server # [ 81.778073] dhcpcd[729]: no valid interfaces found810server # [ 81.786179] dhcpcd[729]: no valid interfaces found811server # [ 82.363671] systemd[1]: Finished Extra networking commands..812server # [ 82.369884] systemd[1]: Reached target Network.813server # [ 82.437391] systemd[1]: Starting PostgreSQL Database Server...814server # [ 82.502560] systemd[1]: Starting Permit User Sessions...815server # [ 83.002476] systemd[1]: Finished Permit User Sessions.816server # [ 83.095231] systemd[1]: Started Getty on tty1.817server # [ 83.119878] systemd[1]: Reached target Login Prompts.818server # [ 83.802390] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[769]: Initializing database at /var/lib/postgresql/data819server # [ 85.702088] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: The files belonging to this database system will be owned by user "postgres".820server # [ 85.709275] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: This user must also own the server process.821server # [ 85.802623] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: The database cluster will be initialized with locale "en_US.UTF-8".822server # [ 85.805785] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: The default database encoding has accordingly been set to "UTF8".823server # [ 85.810202] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: The default text search configuration will be set to "english".824server # [ 85.817761] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: Data page checksums are enabled.825server # [ 85.821653] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: fixing permissions on existing directory /var/lib/postgresql/data ... ok826server # [ 85.825039] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: creating subdirectories ... ok827server # [ 85.830234] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: selecting dynamic shared memory implementation ... posix828server # [ 86.807827] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: selecting default max_connections ... 100829server # [ 87.772818] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: selecting default shared_buffers ... 128MB830server: Guest root shell did not produce any data yet...831server: To debug, enter the VM and run 'systemctl status backdoor.service'.832server # [ 99.386256] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: selecting default time zone ... UTC833server # [ 99.423666] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: creating configuration files ... ok834server # [ 103.646746] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: running bootstrap script ... ok835server # [ 111.830385] dhcpcd[729]: timed out836server # [ 111.844742] dhcpcd[729]: timed out837server # [ 111.871512] systemd[1]: Started DHCP Client.838server # [ 114.002775] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: performing post-bootstrap initialization ... ok839server # [ 116.793912] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: syncing data to disk ... ok840server # [ 116.801413] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: initdb: warning: enabling "trust" authentication for local connections841server # [ 116.810029] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: initdb: hint: You can change this by editing pg_hba.conf or using the option -A, or --auth-local and --auth-host, the next time you run initdb.842server # [ 116.812743] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: Success. You can now start the database server using:843server # [ 116.815656] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[770]: /nix/store/as2nds8lpb4qfzhl3yshr0z6dkjwy99z-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start844server # [ 118.295192] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[769]: Validating PostgreSQL configuration...845server: Guest root shell did not produce any data yet...846server: To debug, enter the VM and run 'systemctl status backdoor.service'.847server # [ 119.026284] qd2lxz6xfbyr9hdf968bwnx0xdpmj37j-postgresql-init[1022]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault848server # [ 119.976952] postgres[1034]: 2026-10-31 19:38:52.650 UTC [1034] LOG: pgaudit extension initialized849server # [ 120.628979] postgres[1034]: 2026-10-31 19:38:53.315 UTC [1034] LOG: pgsodium primary server secret key loaded850server # [ 121.358597] postgres[1034]: 2026-10-31 19:38:54.007 UTC [1034] LOG: vault primary server secret key loaded851server # [ 122.039694] postgres[1034]: 2026-10-31 19:38:54.727 UTC [1034] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.3.0, 64-bit852server # [ 122.063884] postgres[1034]: 2026-10-31 19:38:54.747 UTC [1034] LOG: listening on IPv4 address "0.0.0.0", port 5432853server # [ 122.070409] postgres[1034]: 2026-10-31 19:38:54.750 UTC [1034] LOG: listening on IPv6 address "::", port 5432854server # [ 122.083419] postgres[1034]: 2026-10-31 19:38:54.770 UTC [1034] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"855server # [ 122.227937] postgres[1059]: 2026-10-31 19:38:54.908 UTC [1059] LOG: database system was shut down at 2026-10-31 19:38:46 UTC856server # [ 122.459074] postgres[1062]: 2026-10-31 19:38:55.141 UTC [1062] LOG: TimescaleDB background worker launcher connected to shared catalogs857server # [ 122.485863] postgres[1034]: 2026-10-31 19:38:55.150 UTC [1034] LOG: database system is ready to accept connections858server # [ 122.535228] postgres[1063]: 2026-10-31 19:38:55.173 UTC [1063] FATAL: role "postgres" does not exist859server # [ 122.562590] systemd[1]: Started PostgreSQL Database Server.860server # [ 122.628996] postgres[1034]: 2026-10-31 19:38:55.310 UTC [1034] LOG: background worker "pg_net 0.20.4 worker" (PID 1063) exited with exit code 1861server # [ 122.664667] systemd[1]: Starting Supabase Database Initialization...862server # [ 122.747974] postgres[1064]: 2026-10-31 19:38:55.428 UTC [1064] LOG: pg_cron scheduler started863server # [ 123.074599] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Waiting for PostgreSQL to be ready...864server # [ 123.683697] postgres[1071]: 2026-10-31 19:38:56.366 UTC [1071] FATAL: role "postgres" does not exist865server # [ 123.726878] postgres[1070]: ::1 2026-10-31 19:38:56.371 UTC [1070] root@root FATAL: role "root" does not exist866server # [ 123.761673] postgres[1034]: 2026-10-31 19:38:56.433 UTC [1034] LOG: background worker "pg_net 0.20.4 worker" (PID 1071) exited with exit code 1867server # [ 123.773945] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: PostgreSQL is ready868server # [ 123.783037] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Creating postgres role...869server # [ 124.218695] postgres[1073]: ::1 2026-10-31 19:38:56.886 UTC [1073] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN;870server # [ 124.274681] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1072]: CREATE ROLE871server # [ 124.749542] postgres[1084]: ::1 2026-10-31 19:38:57.397 UTC [1084] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres;872server # [ 124.819061] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1079]: ALTER DATABASE873server # [ 124.888578] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql874server # [ 125.401391] postgres[1095]: ::1 2026-10-31 19:38:58.052 UTC [1095] postgres@postgres LOG: statement: create publication supabase_realtime;875server # [ 125.472707] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: CREATE PUBLICATION876server # [ 125.487722] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: ALTER ROLE877server # [ 125.503235] postgres[1095]: ::1 2026-10-31 19:38:58.129 UTC [1095] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls;878server # [ 125.510894] postgres[1095]: ::1 2026-10-31 19:38:58.155 UTC [1095] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication;879server # [ 125.515006] postgres[1095]: ::1 2026-10-31 19:38:58.190 UTC [1095] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls;880server # [ 125.518910] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: CREATE ROLE881server # [ 125.523469] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: CREATE ROLE882server # [ 125.526181] postgres[1095]: ::1 2026-10-31 19:38:58.206 UTC [1095] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin;883server # [ 125.541687] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: GRANT ROLE884server # [ 125.547712] postgres[1095]: ::1 2026-10-31 19:38:58.233 UTC [1095] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin;885server # [ 125.563191] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: GRANT886server # [ 125.566454] postgres[1095]: ::1 2026-10-31 19:38:58.253 UTC [1095] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls;887server # [ 125.572854] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: CREATE ROLE888server # [ 125.582839] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: GRANT ROLE889server # [ 125.584095] postgres[1095]: ::1 2026-10-31 19:38:58.264 UTC [1095] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user;890server # [ 125.591332] postgres[1095]: ::1 2026-10-31 19:38:58.271 UTC [1095] postgres@postgres LOG: statement: create schema if not exists extensions;891server # [ 125.598458] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: CREATE SCHEMA892server # [ 125.605068] postgres[1095]: ::1 2026-10-31 19:38:58.286 UTC [1095] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions;893server # [ 128.335949] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: CREATE EXTENSION894server # [ 128.350972] postgres[1095]: ::1 2026-10-31 19:39:01.017 UTC [1095] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions;895server # [ 129.262683] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: CREATE EXTENSION896server # [ 129.268623] postgres[1095]: ::1 2026-10-31 19:39:01.950 UTC [1095] postgres@postgres LOG: statement: create role anon nologin noinherit;897server # [ 129.271532] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: CREATE ROLE898server # [ 129.273722] postgres[1095]: ::1 2026-10-31 19:39:01.959 UTC [1095] postgres@postgres LOG: statement: create role authenticated nologin noinherit;899server # [ 129.283593] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: CREATE ROLE900server # [ 129.286143] postgres[1095]: ::1 2026-10-31 19:39:01.973 UTC [1095] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls;901server # [ 129.295928] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: CREATE ROLE902server # [ 129.303493] postgres[1095]: ::1 2026-10-31 19:39:01.986 UTC [1095] postgres@postgres LOG: statement: create user authenticator noinherit;903server # [ 129.311108] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: CREATE ROLE904server # [ 129.313699] postgres[1095]: ::1 2026-10-31 19:39:01.998 UTC [1095] postgres@postgres LOG: statement: grant anon to authenticator;905server # [ 129.327985] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: GRANT ROLE906server # [ 129.330020] postgres[1095]: ::1 2026-10-31 19:39:02.017 UTC [1095] postgres@postgres LOG: statement: grant authenticated to authenticator;907server # [ 129.341299] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: GRANT ROLE908server # [ 129.354894] postgres[1095]: ::1 2026-10-31 19:39:02.030 UTC [1095] postgres@postgres LOG: statement: grant service_role to authenticator;909server # [ 129.358214] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: GRANT ROLE910server # [ 129.366093] postgres[1095]: ::1 2026-10-31 19:39:02.046 UTC [1095] postgres@postgres LOG: statement: grant supabase_admin to authenticator;911server # [ 129.371626] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: GRANT ROLE912server # [ 129.374134] postgres[1095]: ::1 2026-10-31 19:39:02.060 UTC [1095] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role;913server # [ 129.382244] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: GRANT914server # [ 129.387311] postgres[1095]: ::1 2026-10-31 19:39:02.074 UTC [1095] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;915server # [ 129.406739] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: ALTER DEFAULT PRIVILEGES916server # [ 129.410101] postgres[1095]: ::1 2026-10-31 19:39:02.095 UTC [1095] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;917server # [ 129.419484] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: ALTER DEFAULT PRIVILEGES918server # [ 129.421702] postgres[1095]: ::1 2026-10-31 19:39:02.107 UTC [1095] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;919server # [ 129.430188] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: ALTER DEFAULT PRIVILEGES920server # [ 129.431569] postgres[1095]: ::1 2026-10-31 19:39:02.118 UTC [1095] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role;921server # [ 129.439140] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: GRANT922server # [ 129.442286] postgres[1095]: ::1 2026-10-31 19:39:02.129 UTC [1095] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions;923server # [ 129.454089] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: ALTER ROLE924server # [ 129.464409] postgres[1095]: ::1 2026-10-31 19:39:02.142 UTC [1095] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all925server # [ 129.471042] postgres[1095]: on sequences to postgres, anon, authenticated, service_role;926server # [ 129.474771] postgres[1095]: ::1 2026-10-31 19:39:02.161 UTC [1095] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all927server # [ 129.478136] postgres[1095]: on tables to postgres, anon, authenticated, service_role;928server # [ 129.482590] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: ALTER DEFAULT PRIVILEGES929server # [ 129.487927] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: ALTER DEFAULT PRIVILEGES930server # [ 129.491629] postgres[1095]: ::1 2026-10-31 19:39:02.178 UTC [1095] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all931server # [ 129.493755] postgres[1095]: on functions to postgres, anon, authenticated, service_role;932server # [ 129.502830] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: ALTER DEFAULT PRIVILEGES933server # [ 129.507585] postgres[1095]: ::1 2026-10-31 19:39:02.194 UTC [1095] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s';934server # [ 129.520956] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: ALTER ROLE935server # [ 129.523069] postgres[1095]: ::1 2026-10-31 19:39:02.205 UTC [1095] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s';936server # [ 129.527962] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1089]: ALTER ROLE937server # [ 129.586705] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql938server # [ 129.900871] postgres[1120]: ::1 2026-10-31 19:39:02.582 UTC [1120] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;939server # [ 129.926914] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE SCHEMA940server # [ 129.933485] postgres[1120]: ::1 2026-10-31 19:39:02.610 UTC [1120] postgres@postgres LOG: statement: CREATE TABLE auth.users (941server # [ 129.934884] postgres[1120]: instance_id uuid NULL,942server # [ 129.942337] postgres[1120]: id uuid NOT NULL UNIQUE,943server # [ 129.946311] postgres[1120]: aud varchar(255) NULL,944server # [ 129.955927] postgres[1120]: "role" varchar(255) NULL,945server # [ 129.957716] postgres[1120]: email varchar(255) NULL UNIQUE,946server # [ 129.959334] postgres[1120]: encrypted_password varchar(255) NULL,947server # [ 129.970300] postgres[1120]: confirmed_at timestamptz NULL,948server # [ 129.973405] postgres[1120]: invited_at timestamptz NULL,949server # [ 129.982000] postgres[1120]: confirmation_token varchar(255) NULL,950server # [ 129.984990] postgres[1120]: confirmation_sent_at timestamptz NULL,951server # [ 129.989188] postgres[1120]: recovery_token varchar(255) NULL,952server # [ 130.000429] postgres[1120]: recovery_sent_at timestamptz NULL,953server # [ 130.007069] postgres[1120]: email_change_token varchar(255) NULL,954server # [ 130.013764] postgres[1120]: email_change varchar(255) NULL,955server # [ 130.022194] postgres[1120]: email_change_sent_at timestamptz NULL,956server # [ 130.029608] postgres[1120]: last_sign_in_at timestamptz NULL,957server # [ 130.031104] postgres[1120]: raw_app_meta_data jsonb NULL,958server # [ 130.037522] postgres[1120]: raw_user_meta_data jsonb NULL,959server # [ 130.038462] postgres[1120]: is_super_admin bool NULL,960server # [ 130.039965] postgres[1120]: created_at timestamptz NULL,961server # [ 130.044558] postgres[1120]: updated_at timestamptz NULL,962server # [ 130.046339] postgres[1120]: CONSTRAINT users_pkey PRIMARY KEY (id)963server # [ 130.048592] postgres[1120]: );964server # [ 130.243328] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE TABLE965server # [ 130.245700] postgres[1120]: ::1 2026-10-31 19:39:02.931 UTC [1120] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);966server # [ 130.312019] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE INDEX967server # [ 130.318860] postgres[1120]: ::1 2026-10-31 19:39:02.997 UTC [1120] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);968server # [ 130.381541] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE INDEX969server # [ 130.391003] postgres[1120]: ::1 2026-10-31 19:39:03.065 UTC [1120] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';970server # [ 130.413101] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: COMMENT971server # [ 130.421592] postgres[1120]: ::1 2026-10-31 19:39:03.098 UTC [1120] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens (972server # [ 130.424937] postgres[1120]: instance_id uuid NULL,973server # [ 130.435350] postgres[1120]: id bigserial NOT NULL,974server # [ 130.446635] postgres[1120]: "token" varchar(255) NULL,975server # [ 130.454849] postgres[1120]: user_id varchar(255) NULL,976server # [ 130.462599] postgres[1120]: revoked bool NULL,977server # [ 130.471480] postgres[1120]: created_at timestamptz NULL,978server # [ 130.478993] postgres[1120]: updated_at timestamptz NULL,979server # [ 130.487439] postgres[1120]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)980server # [ 130.500354] postgres[1120]: );981server # [ 130.653083] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE TABLE982server # [ 130.662311] postgres[1120]: ::1 2026-10-31 19:39:03.343 UTC [1120] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);983server # [ 130.723434] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE INDEX984server # [ 130.733709] postgres[1120]: ::1 2026-10-31 19:39:03.414 UTC [1120] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id);985server # [ 130.791463] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE INDEX986server # [ 130.804950] postgres[1120]: ::1 2026-10-31 19:39:03.481 UTC [1120] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);987server # [ 130.854295] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE INDEX988server # [ 130.862905] postgres[1120]: ::1 2026-10-31 19:39:03.547 UTC [1120] postgres@postgres LOG: statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.';989server # [ 130.882222] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: COMMENT990server # [ 130.892974] postgres[1120]: ::1 2026-10-31 19:39:03.578 UTC [1120] postgres@postgres LOG: statement: CREATE TABLE auth.instances (991server # [ 130.894437] postgres[1120]: id uuid NOT NULL,992server # [ 130.917911] postgres[1120]: uuid uuid NULL,993server # [ 130.921728] postgres[1120]: raw_base_config text NULL,994server # [ 130.929712] postgres[1120]: created_at timestamptz NULL,995server # [ 130.937085] postgres[1120]: updated_at timestamptz NULL,996server # [ 130.938515] postgres[1120]: CONSTRAINT instances_pkey PRIMARY KEY (id)997server # [ 130.942494] postgres[1120]: );998server # [ 131.007895] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE TABLE999server # [ 131.013790] postgres[1120]: ::1 2026-10-31 19:39:03.677 UTC [1120] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';1000server # [ 131.020210] postgres[1120]: ::1 2026-10-31 19:39:03.689 UTC [1120] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries (1001server # [ 131.039687] postgres[1120]: instance_id uuid NULL,1002server # [ 131.043135] postgres[1120]: id uuid NOT NULL,1003server # [ 131.045183] postgres[1120]: payload json NULL,1004server # [ 131.047720] postgres[1120]: created_at timestamptz NULL,1005server # [ 131.051037] postgres[1120]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)1006server # [ 131.054769] postgres[1120]: );1007server # [ 131.056325] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: COMMENT1008server # [ 131.105768] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE TABLE1009server # [ 131.113675] postgres[1120]: ::1 2026-10-31 19:39:03.795 UTC [1120] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);1010server # [ 131.149942] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE INDEX1011server # [ 131.157333] postgres[1120]: ::1 2026-10-31 19:39:03.842 UTC [1120] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';1012server # [ 131.173339] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: COMMENT1013server # [ 131.176891] postgres[1120]: ::1 2026-10-31 19:39:03.858 UTC [1120] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations (1014server # [ 131.181948] postgres[1120]: "version" varchar(255) NOT NULL,1015server # [ 131.186788] postgres[1120]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")1016server # [ 131.196212] postgres[1120]: );1017server # [ 131.225024] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE TABLE1018server # [ 131.233587] postgres[1120]: ::1 2026-10-31 19:39:03.915 UTC [1120] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';1019server # [ 131.241322] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: COMMENT1020server # [ 131.263672] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: INSERT 0 71021server # [ 131.269786] postgres[1120]: ::1 2026-10-31 19:39:03.955 UTC [1120] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$1022server # [ 131.277559] postgres[1120]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;1023server # [ 131.281354] postgres[1120]: $$ language sql stable;1024server # [ 131.288104] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE FUNCTION1025server # [ 131.294011] postgres[1120]: ::1 2026-10-31 19:39:03.978 UTC [1120] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$1026server # [ 131.295783] postgres[1120]: select nullif(current_setting('request.jwt.claim.role', true), '')::text;1027server # [ 131.304585] postgres[1120]: $$ language sql stable;1028server # [ 131.309251] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE FUNCTION1029server # [ 131.313215] postgres[1120]: ::1 2026-10-31 19:39:03.998 UTC [1120] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$1030server # [ 131.317443] postgres[1120]: select nullif(current_setting('request.jwt.claim.email', true), '')::text;1031server # [ 131.322681] postgres[1120]: $$ language sql stable;1032server # [ 131.328391] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE FUNCTION1033server # [ 131.332316] postgres[1120]: ::1 2026-10-31 19:39:04.019 UTC [1120] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;1034server # [ 131.347751] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: GRANT1035server # [ 131.350189] postgres[1120]: ::1 2026-10-31 19:39:04.035 UTC [1120] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1036server # [ 131.359890] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: CREATE ROLE1037server # [ 131.363141] postgres[1120]: ::1 2026-10-31 19:39:04.050 UTC [1120] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1038server # [ 131.373491] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: GRANT1039server # [ 131.376959] postgres[1120]: ::1 2026-10-31 19:39:04.061 UTC [1120] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1040server # [ 131.388572] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: GRANT1041server # [ 131.397532] postgres[1120]: ::1 2026-10-31 19:39:04.077 UTC [1120] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1042server # [ 131.399899] postgres[1120]: ::1 2026-10-31 19:39:04.086 UTC [1120] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth";1043server # [ 131.406145] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: GRANT1044server # [ 131.407076] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: ALTER ROLE1045server # [ 131.408626] postgres[1120]: ::1 2026-10-31 19:39:04.096 UTC [1120] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin;1046server # [ 131.420632] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: ALTER TABLE1047server # [ 131.426726] postgres[1120]: ::1 2026-10-31 19:39:04.108 UTC [1120] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;1048server # [ 131.434013] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: ALTER TABLE1049server # [ 131.437606] postgres[1120]: ::1 2026-10-31 19:39:04.123 UTC [1120] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;1050server # [ 131.447746] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: ALTER TABLE1051server # [ 131.455474] postgres[1120]: ::1 2026-10-31 19:39:04.136 UTC [1120] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;1052server # [ 131.462661] postgres[1120]: ::1 2026-10-31 19:39:04.146 UTC [1120] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;1053server # [ 131.469053] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: ALTER TABLE1054server # [ 131.474241] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1119]: ALTER TABLE1055server # [ 131.525661] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql1056server # [ 131.812778] postgres[1142]: ::1 2026-10-31 19:39:04.494 UTC [1142] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;1057server # [ 131.846799] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1141]: CREATE SCHEMA1058server # [ 131.849485] postgres[1142]: ::1 2026-10-31 19:39:04.515 UTC [1142] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1059server # [ 131.850490] postgres[1142]: ::1 2026-10-31 19:39:04.529 UTC [1142] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage";1060server # [ 131.860203] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1141]: CREATE ROLE1061server # [ 131.861880] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1141]: ALTER ROLE1062server # [ 131.862795] postgres[1142]: ::1 2026-10-31 19:39:04.548 UTC [1142] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;1063server # [ 131.881879] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1141]: GRANT1064server # [ 131.930651] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1141]: DO1065server # [ 131.993492] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql1066server # [ 132.275586] postgres[1144]: ::1 2026-10-31 19:39:04.958 UTC [1144] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;1067server # [ 132.292985] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: ALTER ROLE1068server # [ 132.298957] postgres[1144]: ::1 2026-10-31 19:39:04.982 UTC [1144] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;1069server # [ 132.306456] postgres[1144]: ::1 2026-10-31 19:39:04.991 UTC [1144] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()1070server # [ 132.313982] postgres[1144]: RETURNS event_trigger1071server # [ 132.315797] postgres[1144]: LANGUAGE plpgsql1072server # [ 132.318125] postgres[1144]: AS $$1073server # [ 132.321091] postgres[1144]: DECLARE1074server # [ 132.322083] postgres[1144]: schema_is_cron bool;1075server # [ 132.330551] postgres[1144]: BEGIN1076server # [ 132.333747] postgres[1144]: schema_is_cron = (1077server # [ 132.336795] postgres[1144]: SELECT n.nspname = 'cron'1078server # [ 132.345420] postgres[1144]: FROM pg_event_trigger_ddl_commands() AS ev1079server # [ 132.346762] postgres[1144]: LEFT JOIN pg_catalog.pg_namespace AS n1080server # [ 132.353314] postgres[1144]: ON ev.objid = n.oid1081server # [ 132.355860] postgres[1144]: );1082server # [ 132.358575] postgres[1144]:1083server # [ 132.361382] postgres[1144]: IF schema_is_cron1084server # [ 132.370029] postgres[1144]: THEN1085server # [ 132.371981] postgres[1144]: grant usage on schema cron to postgres with grant option;1086server # [ 132.374336] postgres[1144]:1087server # [ 132.375368] postgres[1144]: alter default privileges in schema cron grant all on tables to postgres with grant option;1088server # [ 132.377321] postgres[1144]: alter default privileges in schema cron grant all on functions to postgres with grant option;1089server # [ 132.379605] postgres[1144]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1090server # [ 132.381309] postgres[1144]:1091server # [ 132.382984] postgres[1144]: alter default privileges for user supabase_admin in schema cron grant all1092server # [ 132.387315] postgres[1144]: on sequences to postgres with grant option;1093server # [ 132.398326] postgres[1144]: alter default privileges for user supabase_admin in schema cron grant all1094server # [ 132.402332] postgres[1144]: on tables to postgres with grant option;1095server # [ 132.403966] postgres[1144]: alter default privileges for user supabase_admin in schema cron grant all1096server # [ 132.407091] postgres[1144]: on functions to postgres with grant option;1097server # [ 132.409995] postgres[1144]:1098server # [ 132.410829] postgres[1144]: grant all privileges on all tables in schema cron to postgres with grant option;1099server # [ 132.413264] postgres[1144]:1100server # [ 132.415622] postgres[1144]: END IF;1101server # [ 132.419178] postgres[1144]:1102server # [ 132.426405] postgres[1144]: END;1103server # [ 132.429140] postgres[1144]: $$;1104server # [ 132.432092] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: ALTER ROLE1105server # [ 132.433701] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: CREATE FUNCTION1106server # [ 132.435624] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: CREATE EVENT TRIGGER1107server # [ 132.437078] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: COMMENT1108server # [ 132.440948] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: CREATE FUNCTION1109server # [ 132.442434] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: COMMENT1110server # [ 132.443704] postgres[1144]: ::1 2026-10-31 19:39:05.029 UTC [1144] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')1111server # [ 132.445169] postgres[1144]: EXECUTE PROCEDURE extensions.grant_pg_cron_access();1112server # [ 132.448042] postgres[1144]: ::1 2026-10-31 19:39:05.050 UTC [1144] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';1113server # [ 132.450642] postgres[1144]: ::1 2026-10-31 19:39:05.063 UTC [1144] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()1114server # [ 132.452259] postgres[1144]: RETURNS event_trigger1115server # [ 132.453682] postgres[1144]: LANGUAGE plpgsql1116server # [ 132.454773] postgres[1144]: AS $$1117server # [ 132.455751] postgres[1144]: BEGIN1118server # [ 132.456992] postgres[1144]: IF EXISTS (1119server # [ 132.457746] postgres[1144]: SELECT 11120server # [ 132.458563] postgres[1144]: FROM pg_event_trigger_ddl_commands() AS ev1121server # [ 132.461176] postgres[1144]: JOIN pg_extension AS ext1122server # [ 132.462662] postgres[1144]: ON ev.objid = ext.oid1123server # [ 132.465216] postgres[1144]: WHERE ext.extname = 'pg_net'1124server # [ 132.469011] postgres[1144]: )1125server # [ 132.470357] postgres[1144]: THEN1126server # [ 132.474973] postgres[1144]: IF NOT EXISTS (1127server # [ 132.482294] postgres[1144]: SELECT 11128server # [ 132.486404] postgres[1144]: FROM pg_roles1129server # [ 132.487782] postgres[1144]: WHERE rolname = 'supabase_functions_admin'1130server # [ 132.489641] postgres[1144]: )1131server # [ 132.491073] postgres[1144]: THEN1132server # [ 132.492152] postgres[1144]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1133server # [ 132.494621] postgres[1144]: END IF;1134server # [ 132.495512] postgres[1144]:1135server # [ 132.497233] postgres[1144]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;1136server # [ 132.498959] postgres[1144]:1137server # [ 132.499836] postgres[1144]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1138server # [ 132.502031] postgres[1144]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1139server # [ 132.503658] postgres[1144]:1140server # [ 132.505733] postgres[1144]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1141server # [ 132.507714] postgres[1144]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1142server # [ 132.509826] postgres[1144]:1143server # [ 132.510926] postgres[1144]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1144server # [ 132.513371] postgres[1144]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1145server # [ 132.515810] postgres[1144]:1146server # [ 132.517725] postgres[1144]: 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;1147server # [ 132.518938] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: DO1148server # [ 132.520025] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: CREATE ROLE1149server # [ 132.521663] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: GRANT1150server # [ 132.522456] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: GRANT1151server # [ 132.523164] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: GRANT1152server # [ 132.524251] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: GRANT1153server # [ 132.526630] postgres[1144]: 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;1154server # [ 132.528285] postgres[1144]: END IF;1155server # [ 132.529538] postgres[1144]: END;1156server # [ 132.530479] postgres[1144]: $$;1157server # [ 132.534039] postgres[1144]: ::1 2026-10-31 19:39:05.081 UTC [1144] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';1158server # [ 132.537822] postgres[1144]: ::1 2026-10-31 19:39:05.122 UTC [1144] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;1159server # [ 132.541568] postgres[1144]: ::1 2026-10-31 19:39:05.145 UTC [1144] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user;1160server # [ 132.542924] postgres[1144]: ::1 2026-10-31 19:39:05.154 UTC [1144] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user;1161server # [ 132.550090] postgres[1144]: ::1 2026-10-31 19:39:05.166 UTC [1144] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;1162server # [ 132.552848] postgres[1144]: ::1 2026-10-31 19:39:05.175 UTC [1144] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;1163server # [ 132.555190] postgres[1144]: ::1 2026-10-31 19:39:05.208 UTC [1144] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;1164server # [ 132.559474] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: GRANT1165server # [ 132.560945] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: GRANT1166server # [ 132.562714] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: GRANT1167server # [ 132.564084] postgres[1144]: ::1 2026-10-31 19:39:05.214 UTC [1144] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;1168server # [ 132.566407] postgres[1144]: ::1 2026-10-31 19:39:05.225 UTC [1144] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;1169server # [ 132.569781] postgres[1144]: ::1 2026-10-31 19:39:05.230 UTC [1144] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;1170server # [ 132.574762] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: GRANT1171server # [ 132.582092] postgres[1144]: ::1 2026-10-31 19:39:05.265 UTC [1144] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;1172server # [ 132.630386] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: GRANT1173server # [ 132.651459] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1143]: DO1174server # [ 132.717488] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running pgbouncer auth schema...1175server # [ 133.034378] postgres[1146]: ::1 2026-10-31 19:39:05.701 UTC [1146] postgres@postgres LOG: statement: CREATE USER pgbouncer;1176server # [ 133.036964] postgres[1146]: ::1 2026-10-31 19:39:05.724 UTC [1146] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;1177server # [ 133.057212] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1145]: CREATE ROLE1178server # [ 133.062861] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1145]: REVOKE1179server # [ 133.069851] postgres[1146]: ::1 2026-10-31 19:39:05.744 UTC [1146] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;1180server # [ 133.136069] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1145]: CREATE SCHEMA1181server # [ 133.143705] postgres[1146]: ::1 2026-10-31 19:39:05.831 UTC [1146] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)1182server # [ 133.147086] postgres[1146]: RETURNS TABLE(username TEXT, password TEXT) AS1183server # [ 133.158201] postgres[1146]: $$1184server # [ 133.162365] postgres[1146]: BEGIN1185server # [ 133.166377] postgres[1146]: RAISE WARNING 'PgBouncer auth request: %', p_usename;1186server # [ 133.180615] postgres[1146]:1187server # [ 133.201350] postgres[1146]: RETURN QUERY1188server # [ 133.203703] postgres[1146]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow1189server # [ 133.205570] postgres[1146]: WHERE usename = p_usename;1190server # [ 133.206431] postgres[1146]: END;1191server # [ 133.213205] postgres[1146]: $$ LANGUAGE plpgsql1192server # [ 133.215940] postgres[1146]: SET search_path = ''1193server # [ 133.218629] postgres[1146]: SECURITY DEFINER;1194server # [ 133.222194] postgres[1146]: ::1 2026-10-31 19:39:05.857 UTC [1146] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;1195server # [ 133.224023] postgres[1146]: ::1 2026-10-31 19:39:05.893 UTC [1146] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;1196server # [ 133.233518] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1145]: CREATE FUNCTION1197server # [ 133.242214] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1145]: REVOKE1198server # [ 133.257591] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1145]: GRANT1199server # [ 133.277152] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running stat extension...1200server # [ 133.730027] postgres[1159]: ::1 2026-10-31 19:39:06.395 UTC [1159] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions;1201server # [ 133.741014] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1152]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping1202server # [ 133.773432] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1152]: CREATE SCHEMA1203server # [ 133.777317] postgres[1159]: ::1 2026-10-31 19:39:06.461 UTC [1159] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;1204server # [ 135.079762] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1152]: CREATE EXTENSION1205server # [ 135.146009] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql1206server # [ 135.401906] postgres[1170]: ::1 2026-10-31 19:39:08.082 UTC [1170] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres;1207server # [ 135.411989] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1169]: GRANT1208server # [ 135.414314] postgres[1170]: ::1 2026-10-31 19:39:08.097 UTC [1170] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres;1209server # [ 135.426635] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1169]: GRANT1210server # [ 135.428004] postgres[1170]: ::1 2026-10-31 19:39:08.114 UTC [1170] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres;1211server # [ 135.434815] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1169]: GRANT1212server # [ 135.438121] postgres[1170]: ::1 2026-10-31 19:39:08.122 UTC [1170] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;1213server # [ 135.445688] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1169]: GRANT1214server # [ 135.446893] postgres[1170]: ::1 2026-10-31 19:39:08.134 UTC [1170] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;1215server # [ 135.453972] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1169]: GRANT1216server # [ 135.457767] postgres[1170]: ::1 2026-10-31 19:39:08.142 UTC [1170] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;1217server # [ 135.463716] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1169]: GRANT1218server # [ 135.474267] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1169]: GRANT1219server # [ 135.475508] postgres[1170]: ::1 2026-10-31 19:39:08.153 UTC [1170] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;1220server # [ 135.477426] postgres[1170]: ::1 2026-10-31 19:39:08.155 UTC [1170] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;1221server # [ 135.487965] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1169]: GRANT1222server # [ 135.493340] postgres[1170]: ::1 2026-10-31 19:39:08.178 UTC [1170] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;1223server # [ 135.530843] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1169]: GRANT1224server # [ 135.555906] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1169]: DO1225server # [ 135.569427] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1169]: ALTER ROLE1226server # [ 135.581585] postgres[1170]: ::1 2026-10-31 19:39:08.246 UTC [1170] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;1227server # [ 135.618840] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql1228server # [ 135.943976] postgres[1172]: ::1 2026-10-31 19:39:08.615 UTC [1172] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1229server # [ 135.947991] postgres[1172]: ::1 2026-10-31 19:39:08.631 UTC [1172] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1230server # [ 135.956137] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: GRANT1231server # [ 135.981421] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: GRANT1232server # [ 135.985096] postgres[1172]: ::1 2026-10-31 19:39:08.666 UTC [1172] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1233server # [ 135.989394] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: GRANT1234server # [ 135.993605] postgres[1172]: ::1 2026-10-31 19:39:08.678 UTC [1172] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;1235server # [ 136.005046] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: ALTER TABLE1236server # [ 136.006341] postgres[1172]: ::1 2026-10-31 19:39:08.693 UTC [1172] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;1237server # [ 136.018403] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: ALTER TABLE1238server # [ 136.025597] postgres[1172]: ::1 2026-10-31 19:39:08.711 UTC [1172] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;1239server # [ 136.038537] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: ALTER TABLE1240server # [ 136.041663] postgres[1172]: ::1 2026-10-31 19:39:08.726 UTC [1172] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;1241server # [ 136.054483] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: ALTER TABLE1242server # [ 136.063483] postgres[1172]: ::1 2026-10-31 19:39:08.745 UTC [1172] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;1243server # [ 136.074897] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: ALTER TABLE1244server # [ 136.082148] postgres[1172]: ::1 2026-10-31 19:39:08.764 UTC [1172] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres;1245server # [ 136.094017] postgres[1172]: ::1 2026-10-31 19:39:08.781 UTC [1172] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;1246server # [ 136.096657] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: GRANT1247server # [ 136.119524] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: GRANT1248server # [ 136.122585] postgres[1172]: ::1 2026-10-31 19:39:08.809 UTC [1172] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;1249server # [ 136.141333] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: GRANT1250server # [ 136.144015] postgres[1172]: ::1 2026-10-31 19:39:08.829 UTC [1172] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;1251server # [ 136.162255] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: GRANT1252server # [ 136.164179] postgres[1172]: ::1 2026-10-31 19:39:08.850 UTC [1172] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user;1253server # [ 136.192933] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: ALTER DEFAULT PRIVILEGES1254server # [ 136.205902] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: ALTER DEFAULT PRIVILEGES1255server # [ 136.207523] postgres[1172]: ::1 2026-10-31 19:39:08.883 UTC [1172] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1256server # [ 136.210331] postgres[1172]: ::1 2026-10-31 19:39:08.891 UTC [1172] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user;1257server # [ 136.217082] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1171]: ALTER DEFAULT PRIVILEGES1258server # [ 136.300202] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql1259server # [ 136.751099] postgres[1184]: ::1 2026-10-31 19:39:09.410 UTC [1184] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime;1260server # [ 136.806848] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1179]: CREATE SCHEMA1261server # [ 136.829433] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql1262server # [ 137.255994] postgres[1194]: ::1 2026-10-31 19:39:09.938 UTC [1194] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres;1263server # [ 137.296997] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1187]: GRANT1264server # [ 137.313681] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1187]: GRANT1265server # [ 137.316725] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1187]: GRANT1266server # [ 137.322259] postgres[1194]: ::1 2026-10-31 19:39:09.981 UTC [1194] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;1267server # [ 137.338982] postgres[1194]: ::1 2026-10-31 19:39:09.989 UTC [1194] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;1268server # [ 137.343935] postgres[1194]: ::1 2026-10-31 19:39:09.996 UTC [1194] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;1269server # [ 137.358581] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1187]: GRANT1270server # [ 137.403027] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql1271server # [ 137.758279] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1197]: DO1272server # [ 137.771358] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1197]: DO1273server # [ 137.797586] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1197]: DO1274server # [ 137.847632] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql1275server # [ 138.172053] postgres[1200]: ::1 2026-10-31 19:39:10.850 UTC [1200] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user;1276server # [ 138.208780] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1199]: ALTER DEFAULT PRIVILEGES1277server # [ 138.211779] postgres[1200]: ::1 2026-10-31 19:39:10.886 UTC [1200] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1278server # [ 138.215086] postgres[1200]: ::1 2026-10-31 19:39:10.898 UTC [1200] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user;1279server # [ 138.218329] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1199]: ALTER DEFAULT PRIVILEGES1280server # [ 138.222693] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1199]: ALTER DEFAULT PRIVILEGES1281server # [ 138.267812] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql1282server # [ 138.582458] postgres[1202]: ::1 2026-10-31 19:39:11.262 UTC [1202] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';1283server # [ 138.604763] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1201]: ALTER ROLE1284server # [ 138.682155] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql1285server # [ 138.952746] postgres[1204]: ::1 2026-10-31 19:39:11.622 UTC [1204] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1286server # [ 138.954322] postgres[1204]: ::1 2026-10-31 19:39:11.633 UTC [1204] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1287server # [ 138.960502] postgres[1204]: ::1 2026-10-31 19:39:11.640 UTC [1204] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1288server # [ 138.966670] postgres[1204]: DECLARE1289server # [ 138.977787] postgres[1204]: cmd record;1290server # [ 138.982923] postgres[1204]: BEGIN1291server # [ 138.989345] postgres[1204]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1292server # [ 138.995134] postgres[1204]: LOOP1293server # [ 139.005468] postgres[1204]: IF cmd.command_tag IN (1294server # [ 139.009927] postgres[1204]: 'CREATE SCHEMA', 'ALTER SCHEMA'1295server # [ 139.011448] postgres[1204]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1296server # [ 139.019146] postgres[1204]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1297server # [ 139.026569] postgres[1204]: , 'CREATE VIEW', 'ALTER VIEW'1298server # [ 139.030097] postgres[1204]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1299server # [ 139.048904] postgres[1204]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1300server # [ 139.066452] postgres[1204]: , 'CREATE TRIGGER'1301server # [ 139.079575] postgres[1204]: , 'CREATE TYPE'1302server # [ 139.088740] postgres[1204]: , 'CREATE RULE'1303server # [ 139.096237] postgres[1204]: , 'COMMENT'1304server # [ 139.103965] postgres[1204]: )1305server # [ 139.111187] postgres[1204]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1306server # [ 139.116999] postgres[1204]: AND cmd.schema_name is distinct from 'pg_temp'1307server # [ 139.119473] postgres[1204]: THEN1308server # [ 139.121312] postgres[1204]: NOTIFY pgrst, 'reload schema';1309server # [ 139.123178] postgres[1204]: END IF;1310server # [ 139.126134] postgres[1204]: END LOOP;1311server # [ 139.127666] postgres[1204]: END; $$ LANGUAGE plpgsql;1312server # [ 139.131995] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1313server # [ 139.135362] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: DROP EVENT TRIGGER1314server # [ 139.137752] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1315server # [ 139.139728] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: DROP FUNCTION1316server # [ 139.141585] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: CREATE FUNCTION1317server # [ 139.143006] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: CREATE FUNCTION1318server # [ 139.145484] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping1319server # [ 139.146570] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: DROP EVENT TRIGGER1320server # [ 139.149219] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: CREATE EVENT TRIGGER1321server # [ 139.150562] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping1322server # [ 139.153145] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: DROP EVENT TRIGGER1323server # [ 139.157154] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1203]: CREATE EVENT TRIGGER1324server # [ 139.158953] postgres[1204]: ::1 2026-10-31 19:39:11.665 UTC [1204] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1325server # [ 139.160193] postgres[1204]: DECLARE1326server # [ 139.162817] postgres[1204]: obj record;1327server # [ 139.165508] postgres[1204]: BEGIN1328server # [ 139.166336] postgres[1204]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1329server # [ 139.169366] postgres[1204]: LOOP1330server # [ 139.172059] postgres[1204]: IF obj.object_type IN (1331server # [ 139.174483] postgres[1204]: 'schema'1332server # [ 139.176385] postgres[1204]: , 'table'1333server # [ 139.178336] postgres[1204]: , 'foreign table'1334server # [ 139.181502] postgres[1204]: , 'view'1335server # [ 139.185646] postgres[1204]: , 'materialized view'1336server # [ 139.187999] postgres[1204]: , 'function'1337server # [ 139.191175] postgres[1204]: , 'trigger'1338server # [ 139.194110] postgres[1204]: , 'type'1339server # [ 139.197343] postgres[1204]: , 'rule'1340server # [ 139.200154] postgres[1204]: )1341server # [ 139.203504] postgres[1204]: AND obj.is_temporary IS false -- no pg_temp objects1342server # [ 139.206064] postgres[1204]: THEN1343server # [ 139.208239] postgres[1204]: NOTIFY pgrst, 'reload schema';1344server # [ 139.209995] postgres[1204]: END IF;1345server # [ 139.212551] postgres[1204]: END LOOP;1346server # [ 139.215055] postgres[1204]: END; $$ LANGUAGE plpgsql;1347server # [ 139.219009] postgres[1204]: ::1 2026-10-31 19:39:11.674 UTC [1204] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1348server # [ 139.221558] postgres[1204]: ::1 2026-10-31 19:39:11.681 UTC [1204] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1349server # [ 139.223076] postgres[1204]: ON ddl_command_end1350server # [ 139.225457] postgres[1204]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1351server # [ 139.228467] postgres[1204]: ::1 2026-10-31 19:39:11.698 UTC [1204] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1352server # [ 139.232380] postgres[1204]: ::1 2026-10-31 19:39:11.702 UTC [1204] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1353server # [ 139.233676] postgres[1204]: ON sql_drop1354server # [ 139.236926] postgres[1204]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1355server # [ 139.241268] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql1356server # [ 140.410581] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1205]: DO1357server # [ 140.500876] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql1358server # [ 140.924116] postgres[1228]: ::1 2026-10-31 19:39:13.595 UTC [1228] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public;1359server # [ 140.978480] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: CREATE SCHEMA1360server # [ 140.986192] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping1361server # [ 140.988149] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: DROP FUNCTION1362server # [ 140.993461] postgres[1228]: ::1 2026-10-31 19:39:13.659 UTC [1228] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb);1363server # [ 140.999856] postgres[1228]: ::1 2026-10-31 19:39:13.669 UTC [1228] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1364server # [ 141.009508] postgres[1228]: "operationName" text default null,1365server # [ 141.011166] postgres[1228]: query text default null,1366server # [ 141.017231] postgres[1228]: variables jsonb default null,1367server # [ 141.021145] postgres[1228]: extensions jsonb default null1368server # [ 141.025015] postgres[1228]: )1369server # [ 141.031029] postgres[1228]: returns jsonb1370server # [ 141.041244] postgres[1228]: language plpgsql1371server # [ 141.042892] postgres[1228]: as $$1372server # [ 141.054430] postgres[1228]: DECLARE1373server # [ 141.061430] postgres[1228]: server_version float;1374server # [ 141.070483] postgres[1228]: BEGIN1375server # [ 141.077525] postgres[1228]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1376server # [ 141.085265] postgres[1228]:1377server # [ 141.091999] postgres[1228]: IF server_version >= 14 THEN1378server # [ 141.097187] postgres[1228]: RETURN jsonb_build_object(1379server # [ 141.101542] postgres[1228]: 'data', null::jsonb,1380server # [ 141.110693] postgres[1228]: 'errors', array['pg_graphql extension is not enabled.']1381server # [ 141.121181] postgres[1228]: );1382server # [ 141.122674] postgres[1228]: ELSE1383server # [ 141.130960] postgres[1228]: RETURN jsonb_build_object(1384server # [ 141.138094] postgres[1228]: 'data', null::jsonb,1385server # [ 141.140104] postgres[1228]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1386server # [ 141.144997] postgres[1228]: );1387server # [ 141.147824] postgres[1228]: END IF;1388server # [ 141.151277] postgres[1228]: END;1389server # [ 141.153022] postgres[1228]: $$;1390server # [ 141.154369] postgres[1228]: ::1 2026-10-31 19:39:13.694 UTC [1228] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;1391server # [ 141.155762] postgres[1228]: ::1 2026-10-31 19:39:13.719 UTC [1228] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;1392server # [ 141.158237] postgres[1228]: ::1 2026-10-31 19:39:13.745 UTC [1228] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;1393server # [ 141.163133] postgres[1228]: ::1 2026-10-31 19:39:13.759 UTC [1228] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;1394server # [ 141.167408] postgres[1228]: ::1 2026-10-31 19:39:13.770 UTC [1228] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1395server # [ 141.171722] postgres[1228]: on sequences to postgres, anon, authenticated, service_role;1396server # [ 141.177107] postgres[1228]: ::1 2026-10-31 19:39:13.786 UTC [1228] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1397server # [ 141.181236] postgres[1228]: on tables to postgres, anon, authenticated, service_role;1398server # [ 141.184305] postgres[1228]: ::1 2026-10-31 19:39:13.799 UTC [1228] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1399server # [ 141.189542] postgres[1228]: on functions to postgres, anon, authenticated, service_role;1400server # [ 141.194324] postgres[1228]: ::1 2026-10-31 19:39:13.812 UTC [1228] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()1401server # [ 141.198992] postgres[1228]: RETURNS event_trigger1402server # [ 141.201984] postgres[1228]: LANGUAGE plpgsql1403server # [ 141.208043] postgres[1228]: AS $func$1404server # [ 141.212053] postgres[1228]: DECLARE1405server # [ 141.215876] postgres[1228]: func_is_graphql_resolve bool;1406server # [ 141.222651] postgres[1228]: BEGIN1407server # [ 141.225516] postgres[1228]: func_is_graphql_resolve = (1408server # [ 141.229281] postgres[1228]: SELECT n.proname = 'resolve'1409server # [ 141.232251] postgres[1228]: FROM pg_event_trigger_ddl_commands() AS ev1410server # [ 141.238661] postgres[1228]: LEFT JOIN pg_catalog.pg_proc AS n1411server # [ 141.242975] postgres[1228]: ON ev.objid = n.oid1412server # [ 141.250131] postgres[1228]: );1413server # [ 141.254752] postgres[1228]:1414server # [ 141.260004] postgres[1228]: IF func_is_graphql_resolve1415server # [ 141.265172] postgres[1228]: THEN1416server # [ 141.267116] postgres[1228]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1417server # [ 141.271622] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: CREATE FUNCTION1418server # [ 141.275422] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: GRANT1419server # [ 141.292877] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: ALTER DEFAULT PRIVILEGES1420server # [ 141.299783] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: ALTER DEFAULT PRIVILEGES1421server # [ 141.319440] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: ALTER DEFAULT PRIVILEGES1422server # [ 141.326698] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: ALTER DEFAULT PRIVILEGES1423server # [ 141.330303] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: ALTER DEFAULT PRIVILEGES1424server # [ 141.343324] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: ALTER DEFAULT PRIVILEGES1425server # [ 141.351690] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: CREATE FUNCTION1426server # [ 141.355505] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping1427server # [ 141.362906] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: DROP EVENT TRIGGER1428server # [ 141.367807] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: CREATE EVENT TRIGGER1429server # [ 141.374406] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: COMMENT1430server # [ 141.381769] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: CREATE FUNCTION1431server # [ 141.385970] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping1432server # [ 141.394448] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: DROP EVENT TRIGGER1433server # [ 141.396589] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: CREATE EVENT TRIGGER1434server # [ 141.399716] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1225]: COMMENT1435server # [ 141.410335] postgres[1228]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1436server # [ 141.417120] postgres[1228]:1437server # [ 141.419284] postgres[1228]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1438server # [ 141.427063] postgres[1228]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1439server # [ 141.432791] postgres[1228]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1440server # [ 141.433859] postgres[1228]:1441server # [ 141.434369] postgres[1228]: DROP FUNCTION IF EXISTS graphql_public.graphql;1442server # [ 141.434817] postgres[1228]: create or replace function graphql_public.graphql(1443server # [ 141.435414] postgres[1228]: "operationName" text default null,1444server # [ 141.435947] postgres[1228]: query text default null,1445server # [ 141.445115] postgres[1228]: variables jsonb default null,1446server # [ 141.450419] postgres[1228]: extensions jsonb default null1447server # [ 141.451875] postgres[1228]: )1448server # [ 141.453560] postgres[1228]: returns jsonb1449server # [ 141.461404] postgres[1228]: language sql1450server # [ 141.471010] postgres[1228]: as $$1451server # [ 141.479226] postgres[1228]: SELECT graphql.resolve(query, coalesce(variables, '{}'));1452server # [ 141.482898] postgres[1228]: $$;1453server # [ 141.489250] postgres[1228]:1454server # [ 141.494675] postgres[1228]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1455server # [ 141.498452] postgres[1228]: END IF;1456server # [ 141.502572] postgres[1228]:1457server # [ 141.504154] postgres[1228]: END;1458server # [ 141.505633] postgres[1228]: $func$;1459server # [ 141.507825] postgres[1228]: ::1 2026-10-31 19:39:13.843 UTC [1228] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;1460server # [ 141.511445] postgres[1228]: ::1 2026-10-31 19:39:13.853 UTC [1228] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')1461server # [ 141.517227] postgres[1228]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access();1462server # [ 141.521196] postgres[1228]: ::1 2026-10-31 19:39:13.869 UTC [1228] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';1463server # [ 141.527349] postgres[1228]: ::1 2026-10-31 19:39:13.886 UTC [1228] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1464server # [ 141.529209] postgres[1228]: RETURNS event_trigger1465server # [ 141.530835] postgres[1228]: LANGUAGE plpgsql1466server # [ 141.535590] postgres[1228]: AS $func$1467server # [ 141.537221] postgres[1228]: DECLARE1468server # [ 141.539638] postgres[1228]: graphql_is_dropped bool;1469server # [ 141.545577] postgres[1228]: BEGIN1470server # [ 141.547038] postgres[1228]: graphql_is_dropped = (1471server # [ 141.549781] postgres[1228]: SELECT ev.schema_name = 'graphql_public'1472server # [ 141.551103] postgres[1228]: FROM pg_event_trigger_dropped_objects() AS ev1473server # [ 141.557294] postgres[1228]: WHERE ev.schema_name = 'graphql_public'1474server # [ 141.558667] postgres[1228]: );1475server # [ 141.564927] postgres[1228]:1476server # [ 141.581466] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql1477server # [ 141.585720] postgres[1228]: IF graphql_is_dropped1478server # [ 141.587482] postgres[1228]: THEN1479server # [ 141.589492] postgres[1228]: create or replace function graphql_public.graphql(1480server # [ 141.590968] postgres[1228]: "operationName" text default null,1481server # [ 141.592373] postgres[1228]: query text default null,1482server # [ 141.594467] postgres[1228]: variables jsonb default null,1483server # [ 141.595920] postgres[1228]: extensions jsonb default null1484server # [ 141.599134] postgres[1228]: )1485server # [ 141.601353] postgres[1228]: returns jsonb1486server # [ 141.602844] postgres[1228]: language plpgsql1487server # [ 141.604755] postgres[1228]: as $$1488server # [ 141.605863] postgres[1228]: DECLARE1489server # [ 141.608163] postgres[1228]: server_version float;1490server # [ 141.611353] postgres[1228]: BEGIN1491server # [ 141.614314] postgres[1228]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1492server # [ 141.617271] postgres[1228]:1493server # [ 141.618149] postgres[1228]: IF server_version >= 14 THEN1494server # [ 141.619331] postgres[1228]: RETURN jsonb_build_object(1495server # [ 141.621797] postgres[1228]: 'data', null::jsonb,1496server # [ 141.624614] postgres[1228]: 'errors', array['pg_graphql extension is not enabled.']1497server # [ 141.627009] postgres[1228]: );1498server # [ 141.629652] postgres[1228]: ELSE1499server # [ 141.630580] postgres[1228]: RETURN jsonb_build_object(1500server # [ 141.633206] postgres[1228]: 'data', null::jsonb,1501server # [ 141.637123] postgres[1228]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1502server # [ 141.641815] postgres[1228]: );1503server # [ 141.645537] postgres[1228]: END IF;1504server # [ 141.653443] postgres[1228]: END;1505server # [ 141.659349] postgres[1228]: $$;1506server # [ 141.661552] postgres[1228]: END IF;1507server # [ 141.665477] postgres[1228]:1508server # [ 141.667591] postgres[1228]: END;1509server # [ 141.670102] postgres[1228]: $func$;1510server # [ 141.670981] postgres[1228]: ::1 2026-10-31 19:39:13.926 UTC [1228] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;1511server # [ 141.674584] postgres[1228]: ::1 2026-10-31 19:39:13.934 UTC [1228] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')1512server # [ 141.678764] postgres[1228]: EXECUTE PROCEDURE extensions.set_graphql_placeholder();1513server # [ 141.681079] postgres[1228]: ::1 2026-10-31 19:39:13.943 UTC [1228] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';1514server # [ 141.764214] postgres[1230]: ::1 2026-10-31 19:39:14.447 UTC [1230] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1515server # [ 141.771420] postgres[1230]: ::1 2026-10-31 19:39:14.457 UTC [1230] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1516server # [ 141.779710] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1229]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1517server # [ 141.791872] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1229]: DROP EVENT TRIGGER1518server # [ 141.794392] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1229]: 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, skipping1519server # [ 141.796429] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1229]: DROP FUNCTION1520server # [ 141.803640] postgres[1230]: ::1 2026-10-31 19:39:14.483 UTC [1230] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1521server # [ 141.810188] postgres[1230]: DECLARE1522server # [ 141.811433] postgres[1230]: cmd record;1523server # [ 141.816711] postgres[1230]: BEGIN1524server # [ 141.821881] postgres[1230]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1525server # [ 141.825391] postgres[1230]: LOOP1526server # [ 141.829357] postgres[1230]: IF cmd.command_tag IN (1527server # [ 141.830581] postgres[1230]: 'CREATE SCHEMA', 'ALTER SCHEMA'1528server # [ 141.831533] postgres[1230]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1529server # [ 141.836848] postgres[1230]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1530server # [ 141.843706] postgres[1230]: , 'CREATE VIEW', 'ALTER VIEW'1531server # [ 141.845751] postgres[1230]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1532server # [ 141.849312] postgres[1230]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1533server # [ 141.851928] postgres[1230]: , 'CREATE TRIGGER'1534server # [ 141.857499] postgres[1230]: , 'CREATE TYPE', 'ALTER TYPE'1535server # [ 141.859026] postgres[1230]: , 'CREATE RULE'1536server # [ 141.861591] postgres[1230]: , 'COMMENT'1537server # [ 141.863580] postgres[1230]: )1538server # [ 141.866289] postgres[1230]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1539server # [ 141.867388] postgres[1230]: AND cmd.schema_name is distinct from 'pg_temp'1540server # [ 141.868861] postgres[1230]: THEN1541server # [ 141.869643] postgres[1230]: NOTIFY pgrst, 'reload schema';1542server # [ 141.870712] postgres[1230]: END IF;1543server # [ 141.871488] postgres[1230]: END LOOP;1544server # [ 141.872143] postgres[1230]: END; $$ LANGUAGE plpgsql;1545server # [ 141.874469] postgres[1230]: ::1 2026-10-31 19:39:14.551 UTC [1230] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1546server # [ 141.876214] postgres[1230]: DECLARE1547server # [ 141.877497] postgres[1230]: obj record;1548server # [ 141.878372] postgres[1230]: BEGIN1549server # [ 141.879064] postgres[1230]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1550server # [ 141.880299] postgres[1230]: LOOP1551server # [ 141.882541] postgres[1230]: IF obj.object_type IN (1552server # [ 141.883801] postgres[1230]: 'schema'1553server # [ 141.884563] postgres[1230]: , 'table'1554server # [ 141.887096] postgres[1230]: , 'foreign table'1555server # [ 141.889791] postgres[1230]: , 'view'1556server # [ 141.893259] postgres[1230]: , 'materialized view'1557server # [ 141.897127] postgres[1230]: , 'function'1558server # [ 141.901149] postgres[1230]: , 'trigger'1559server # [ 141.902478] postgres[1230]: , 'type'1560server # [ 141.904238] postgres[1230]: , 'rule'1561server # [ 141.909209] postgres[1230]: )1562server # [ 141.910596] postgres[1230]: AND obj.is_temporary IS false -- no pg_temp objects1563server # [ 141.914543] postgres[1230]: THEN1564server # [ 141.921581] postgres[1230]: NOTIFY pgrst, 'reload schema';1565server # [ 141.922444] postgres[1230]: END IF;1566server # [ 141.922899] postgres[1230]: END LOOP;1567server # [ 141.923600] postgres[1230]: END; $$ LANGUAGE plpgsql;1568server # [ 141.929157] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1229]: CREATE FUNCTION1569server # [ 141.932847] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1229]: CREATE FUNCTION1570server # [ 141.934136] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1229]: DROP EVENT TRIGGER1571server # [ 141.937112] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1229]: CREATE EVENT TRIGGER1572server # [ 141.942109] postgres[1230]: ::1 2026-10-31 19:39:14.589 UTC [1230] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1573server # [ 141.944070] postgres[1230]: ::1 2026-10-31 19:39:14.605 UTC [1230] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1574server # [ 141.946477] postgres[1230]: ON ddl_command_end1575server # [ 141.960026] postgres[1230]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1576server # [ 141.980054] postgres[1230]: ::1 2026-10-31 19:39:14.617 UTC [1230] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1577server # [ 141.989683] postgres[1230]: ::1 2026-10-31 19:39:14.623 UTC [1230] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1578server # [ 141.996950] postgres[1230]: ON sql_drop1579server # [ 142.002070] postgres[1230]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1580server # [ 142.007733] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1229]: DROP EVENT TRIGGER1581server # [ 142.010057] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1229]: CREATE EVENT TRIGGER1582server # [ 142.015828] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql1583server # [ 142.268393] postgres[1232]: ::1 2026-10-31 19:39:14.943 UTC [1232] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;1584server # [ 142.281912] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1231]: ALTER ROLE1585server # [ 142.312912] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql1586server # [ 142.618596] postgres[1234]: ::1 2026-10-31 19:39:15.288 UTC [1234] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1587server # [ 142.623095] postgres[1234]: returns event_trigger1588server # [ 142.629643] postgres[1234]: language plpgsql1589server # [ 142.632058] postgres[1234]: AS $func$1590server # [ 142.640807] postgres[1234]: DECLARE1591server # [ 142.643133] postgres[1234]: func_is_graphql_resolve bool;1592server # [ 142.661053] postgres[1234]: BEGIN1593server # [ 142.665531] postgres[1234]: func_is_graphql_resolve = (1594server # [ 142.669953] postgres[1234]: SELECT n.proname = 'resolve'1595server # [ 142.681936] postgres[1234]: FROM pg_event_trigger_ddl_commands() AS ev1596server # [ 142.685558] postgres[1234]: LEFT JOIN pg_catalog.pg_proc AS n1597server # [ 142.690489] postgres[1234]: ON ev.objid = n.oid1598server # [ 142.697513] postgres[1234]: );1599server # [ 142.707187] postgres[1234]:1600server # [ 142.710334] postgres[1234]: IF func_is_graphql_resolve1601server # [ 142.714386] postgres[1234]: THEN1602server # [ 142.725530] postgres[1234]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1603server # [ 142.727218] postgres[1234]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1604server # [ 142.728793] postgres[1234]:1605server # [ 142.729581] postgres[1234]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1606server # [ 142.730492] postgres[1234]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1607server # [ 142.733584] postgres[1234]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1608server # [ 142.734961] postgres[1234]:1609server # [ 142.741941] postgres[1234]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1610server # [ 142.743107] postgres[1234]: DROP FUNCTION IF EXISTS graphql_public.graphql;1611server # [ 142.745963] postgres[1234]: create or replace function graphql_public.graphql(1612server # [ 142.757012] postgres[1234]: "operationName" text default null,1613server # [ 142.758176] postgres[1234]: query text default null,1614server # [ 142.758867] postgres[1234]: variables jsonb default null,1615server # [ 142.761090] postgres[1234]: extensions jsonb default null1616server # [ 142.766486] postgres[1234]: )1617server # [ 142.774341] postgres[1234]: returns jsonb1618server # [ 142.778375] postgres[1234]: language sql1619server # [ 142.782401] postgres[1234]: as $$1620server # [ 142.793559] postgres[1234]: -- This changed1621server # [ 142.795920] postgres[1234]: select graphql.resolve(1622server # [ 142.797937] postgres[1234]: query := query,1623server # [ 142.800953] postgres[1234]: variables := coalesce(variables, '{}'),1624server # [ 142.805141] postgres[1234]: "operationName" := "operationName",1625server # [ 142.814187] postgres[1234]: extensions := extensions1626server # [ 142.816904] postgres[1234]: );1627server # [ 142.825873] postgres[1234]: $$;1628server # [ 142.829202] postgres[1234]:1629server # [ 142.832414] postgres[1234]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1630server # [ 142.837483] postgres[1234]: END IF;1631server # [ 142.841994] postgres[1234]:1632server # [ 142.843213] postgres[1234]: END;1633server # [ 142.845434] postgres[1234]: $func$;1634server # [ 142.849589] postgres[1234]: ::1 2026-10-31 19:39:15.357 UTC [1234] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1635server # [ 142.851534] postgres[1234]: RETURNS event_trigger1636server # [ 142.857220] postgres[1234]: LANGUAGE plpgsql1637server # [ 142.859188] postgres[1234]: AS $func$1638server # [ 142.861627] postgres[1234]: DECLARE1639server # [ 142.864562] postgres[1234]: graphql_is_dropped bool;1640server # [ 142.877424] postgres[1234]: BEGIN1641server # [ 142.881504] postgres[1234]: graphql_is_dropped = (1642server # [ 142.883049] postgres[1234]: SELECT ev.schema_name = 'graphql_public'1643server # [ 142.887698] postgres[1234]: FROM pg_event_trigger_dropped_objects() AS ev1644server # [ 142.891862] postgres[1234]: WHERE ev.schema_name = 'graphql_public'1645server # [ 142.893936] postgres[1234]: );1646server # [ 142.901882] postgres[1234]:1647server # [ 142.906442] postgres[1234]: IF graphql_is_dropped1648server # [ 142.913644] postgres[1234]: THEN1649server # [ 142.917739] postgres[1234]: create or replace function graphql_public.graphql(1650server # [ 142.922012] postgres[1234]: "operationName" text default null,1651server # [ 142.927064] postgres[1234]: query text default null,1652server # [ 142.929105] postgres[1234]: variables jsonb default null,1653server # [ 142.933122] postgres[1234]: extensions jsonb default null1654server # [ 142.943091] postgres[1234]: )1655server # [ 142.947640] postgres[1234]: returns jsonb1656server # [ 142.951470] postgres[1234]: language plpgsql1657server # [ 142.957243] postgres[1234]: as $$1658server # [ 142.959802] postgres[1234]: DECLARE1659server # [ 142.965987] postgres[1234]: server_version float;1660server # [ 142.969635] postgres[1234]: BEGIN1661server # [ 142.977359] postgres[1234]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1662server # [ 142.984686] postgres[1234]:1663server # [ 142.989396] postgres[1234]: IF server_version >= 14 THEN1664server # [ 142.994568] postgres[1234]: RETURN jsonb_build_object(1665server # [ 142.997551] postgres[1234]: 'errors', jsonb_build_array(1666server # [ 142.999686] postgres[1234]: jsonb_build_object(1667server # [ 143.007020] postgres[1234]: 'message', 'pg_graphql extension is not enabled.'1668server # [ 143.009767] postgres[1234]: )1669server # [ 143.013497] postgres[1234]: )1670server # [ 143.018411] postgres[1234]: );1671server # [ 143.022020] postgres[1234]: ELSE1672server # [ 143.024022] postgres[1234]: RETURN jsonb_build_object(1673server # [ 143.034834] postgres[1234]: 'errors', jsonb_build_array(1674server # [ 143.038796] postgres[1234]: jsonb_build_object(1675server # [ 143.043589] postgres[1234]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1676server # [ 143.045532] postgres[1234]: )1677server # [ 143.050162] postgres[1234]: )1678server # [ 143.053304] postgres[1234]: );1679server # [ 143.054370] postgres[1234]: END IF;1680server # [ 143.055801] postgres[1234]: END;1681server # [ 143.058246] postgres[1234]: $$;1682server # [ 143.062220] postgres[1234]: END IF;1683server # [ 143.064894] postgres[1234]:1684server # [ 143.067159] postgres[1234]: END;1685server # [ 143.070821] postgres[1234]: $func$;1686server # [ 143.074659] postgres[1234]: ::1 2026-10-31 19:39:15.379 UTC [1234] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1687server # [ 143.087867] postgres[1234]: "operationName" text default null,1688server # [ 143.092129] postgres[1234]: query text default null,1689server # [ 143.096895] postgres[1234]: variables jsonb default null,1690server # [ 143.111037] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1233]: CREATE FUNCTION1691server # [ 143.113592] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1233]: CREATE FUNCTION1692server # [ 143.117100] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1233]: CREATE FUNCTION1693server # [ 143.118192] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1233]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping1694server # [ 143.119575] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1233]: DROP EXTENSION1695server # [ 143.123449] postgres[1234]: extensions jsonb default null1696server # [ 143.127073] postgres[1234]: )1697server # [ 143.131175] postgres[1234]: returns jsonb1698server # [ 143.134417] postgres[1234]: language plpgsql1699server # [ 143.141099] postgres[1234]: as $$1700server # [ 143.142376] postgres[1234]: DECLARE1701server # [ 143.146873] postgres[1234]: server_version float;1702server # [ 143.150310] postgres[1234]: BEGIN1703server # [ 143.153434] postgres[1234]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1704server # [ 143.155770] postgres[1234]:1705server # [ 143.167199] postgres[1234]: IF server_version >= 14 THEN1706server # [ 143.170920] postgres[1234]: RETURN jsonb_build_object(1707server # [ 143.175113] postgres[1234]: 'errors', jsonb_build_array(1708server # [ 143.179491] postgres[1234]: jsonb_build_object(1709server # [ 143.183306] postgres[1234]: 'message', 'pg_graphql extension is not enabled.'1710server # [ 143.185644] postgres[1234]: )1711server # [ 143.187982] postgres[1234]: )1712server # [ 143.190594] postgres[1234]: );1713server # [ 143.200910] postgres[1234]: ELSE1714server # [ 143.205846] postgres[1234]: RETURN jsonb_build_object(1715server # [ 143.208987] postgres[1234]: 'errors', jsonb_build_array(1716server # [ 143.213828] postgres[1234]: jsonb_build_object(1717server # [ 143.218421] postgres[1234]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1718server # [ 143.220014] postgres[1234]: )1719server # [ 143.223695] postgres[1234]: )1720server # [ 143.228870] postgres[1234]: );1721server # [ 143.233169] postgres[1234]: END IF;1722server # [ 143.236223] postgres[1234]: END;1723server # [ 143.242279] postgres[1234]: $$;1724server # [ 143.244079] postgres[1234]: ::1 2026-10-31 19:39:15.416 UTC [1234] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1725server # [ 144.795935] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1233]: DO1726server # [ 144.847816] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql1727server # [ 145.218491] postgres[1258]: ::1 2026-10-31 19:39:17.896 UTC [1258] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres;1728server # [ 145.242825] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1257]: GRANT ROLE1729server # [ 145.279124] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql1730server # [ 145.613611] postgres[1260]: ::1 2026-10-31 19:39:18.295 UTC [1260] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1731server # [ 145.623911] postgres[1260]: returns event_trigger1732server # [ 145.626717] postgres[1260]: language plpgsql1733server # [ 145.629190] postgres[1260]: AS $func$1734server # [ 145.630602] postgres[1260]: DECLARE1735server # [ 145.632443] postgres[1260]: func_is_graphql_resolve bool;1736server # [ 145.634735] postgres[1260]: BEGIN1737server # [ 145.637171] postgres[1260]: func_is_graphql_resolve = (1738server # [ 145.638681] postgres[1260]: SELECT n.proname = 'resolve'1739server # [ 145.640027] postgres[1260]: FROM pg_event_trigger_ddl_commands() AS ev1740server # [ 145.642258] postgres[1260]: LEFT JOIN pg_catalog.pg_proc AS n1741server # [ 145.643180] postgres[1260]: ON ev.objid = n.oid1742server # [ 145.645056] postgres[1260]: );1743server # [ 145.645952] postgres[1260]:1744server # [ 145.646924] postgres[1260]: IF func_is_graphql_resolve1745server # [ 145.647893] postgres[1260]: THEN1746server # [ 145.649865] postgres[1260]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1747server # [ 145.651792] postgres[1260]: DROP FUNCTION IF EXISTS graphql_public.graphql;1748server # [ 145.655316] postgres[1260]: create or replace function graphql_public.graphql(1749server # [ 145.657631] postgres[1260]: "operationName" text default null,1750server # [ 145.659117] postgres[1260]: query text default null,1751server # [ 145.661476] postgres[1260]: variables jsonb default null,1752server # [ 145.662550] postgres[1260]: extensions jsonb default null1753server # [ 145.664329] postgres[1260]: )1754server # [ 145.665874] postgres[1260]: returns jsonb1755server # [ 145.666718] postgres[1260]: language sql1756server # [ 145.669191] postgres[1260]: as $$1757server # [ 145.670601] postgres[1260]: select graphql.resolve(1758server # [ 145.672051] postgres[1260]: query := query,1759server # [ 145.675688] postgres[1260]: variables := coalesce(variables, '{}'),1760server # [ 145.677372] postgres[1260]: "operationName" := "operationName",1761server # [ 145.678460] postgres[1260]: extensions := extensions1762server # [ 145.679445] postgres[1260]: );1763server # [ 145.681335] postgres[1260]: $$;1764server # [ 145.683335] postgres[1260]:1765server # [ 145.684153] postgres[1260]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1766server # [ 145.691324] postgres[1260]: -- function in the extension so we need to grant permissions on existing entities AND1767server # [ 145.694633] postgres[1260]: -- update default permissions to any others that are created after `graphql.resolve`1768server # [ 145.699946] postgres[1260]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1769server # [ 145.702449] postgres[1260]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1770server # [ 145.707500] postgres[1260]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1771server # [ 145.713959] postgres[1260]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1772server # [ 145.715192] postgres[1260]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1773server # [ 145.718905] postgres[1260]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1774server # [ 145.722855] postgres[1260]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1775server # [ 145.724184] postgres[1260]: END IF;1776server # [ 145.727406] postgres[1260]:1777server # [ 145.729295] postgres[1260]: END;1778server # [ 145.731217] postgres[1260]: $func$;1779server # [ 145.747513] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1259]: CREATE FUNCTION1780server # [ 145.756182] postgres[1260]: ::1 2026-10-31 19:39:18.432 UTC [1260] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1781server # [ 145.795942] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1259]: DROP EXTENSION1782server # [ 147.095781] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31783server # [ 147.546729] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1259]: DO1784server # [ 147.602480] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql1785server # [ 148.659931] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1281]: DO1786server: Guest root shell did not produce any data yet...1787server: To debug, enter the VM and run 'systemctl status backdoor.service'.1788server # [ 149.281762] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1281]: DO1789server # [ 149.337994] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql1790server # [ 149.632724] postgres[1284]: ::1 2026-10-31 19:39:22.315 UTC [1284] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s';1791server # [ 149.668031] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1283]: ALTER ROLE1792server # [ 149.708030] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql1793server # [ 150.050787] postgres[1286]: ::1 2026-10-31 19:39:22.726 UTC [1286] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator;1794server # [ 150.068262] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1285]: REVOKE ROLE1795server # [ 150.114764] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql1796server # [ 152.787048] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1289]: DO1797server # [ 152.831759] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql1798server # [ 153.123088] postgres[1310]: ::1 2026-10-31 19:39:25.801 UTC [1310] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres;1799server # [ 153.156022] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1309]: GRANT ROLE1800server # [ 153.199696] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql1801server # [ 153.482111] postgres[1312]: ::1 2026-10-31 19:39:26.161 UTC [1312] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option;1802server # [ 153.526780] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1311]: GRANT1803server # [ 153.536238] postgres[1312]: ::1 2026-10-31 19:39:26.197 UTC [1312] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option;1804server # [ 153.546992] postgres[1312]: ::1 2026-10-31 19:39:26.231 UTC [1312] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option;1805server # [ 153.558773] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1311]: GRANT1806server # [ 153.565798] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1311]: GRANT1807server # [ 153.570059] postgres[1312]: ::1 2026-10-31 19:39:26.238 UTC [1312] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;1808server # [ 153.572206] postgres[1312]: ::1 2026-10-31 19:39:26.254 UTC [1312] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;1809server # [ 153.580004] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1311]: ALTER DEFAULT PRIVILEGES1810server # [ 153.582722] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1311]: ALTER DEFAULT PRIVILEGES1811server # [ 153.586274] postgres[1312]: ::1 2026-10-31 19:39:26.263 UTC [1312] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;1812server # [ 153.605561] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1311]: ALTER DEFAULT PRIVILEGES1813server # [ 153.661412] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql1814server # [ 154.114815] postgres[1321]: ::1 2026-10-31 19:39:26.780 UTC [1321] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres;1815server # [ 154.159593] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1313]: GRANT ROLE1816server # [ 154.194556] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql1817server # [ 154.551029] postgres[1327]: ::1 2026-10-31 19:39:27.225 UTC [1327] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin;1818server # [ 154.609533] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1324]: GRANT ROLE1819server # [ 154.640819] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql1820server # [ 154.959531] postgres[1333]: ::1 2026-10-31 19:39:27.629 UTC [1333] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit;1821server # [ 154.962395] postgres[1333]: ::1 2026-10-31 19:39:27.649 UTC [1333] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit;1822server # [ 154.981475] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1331]: ALTER ROLE1823server # [ 154.986801] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1331]: ALTER ROLE1824server # [ 154.989341] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1331]: ALTER ROLE1825server # [ 154.997564] postgres[1333]: ::1 2026-10-31 19:39:27.660 UTC [1333] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit;1826server # [ 155.061220] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1331]: DO1827server # [ 155.112059] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql1828server # [ 155.526077] postgres[1339]: ::1 2026-10-31 19:39:28.186 UTC [1339] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin;1829server # [ 155.540145] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1337]: GRANT ROLE1830server # [ 155.544931] postgres[1339]: ::1 2026-10-31 19:39:28.226 UTC [1339] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin;1831server # [ 155.558671] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1337]: REVOKE ROLE1832server # [ 155.635938] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql1833server # [ 155.920056] postgres[1342]: ::1 2026-10-31 19:39:28.595 UTC [1342] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1834server # [ 155.929717] postgres[1342]: returns event_trigger1835server # [ 155.931068] postgres[1342]: language plpgsql1836server # [ 155.938976] postgres[1342]: AS $func$1837server # [ 155.940387] postgres[1342]: DECLARE1838server # [ 155.949522] postgres[1342]: func_is_graphql_resolve bool;1839server # [ 155.953907] postgres[1342]: BEGIN1840server # [ 155.954611] postgres[1342]: func_is_graphql_resolve = (1841server # [ 155.955588] postgres[1342]: SELECT n.proname = 'resolve'1842server # [ 155.962744] postgres[1342]: FROM pg_event_trigger_ddl_commands() AS ev1843server # [ 155.965687] postgres[1342]: LEFT JOIN pg_catalog.pg_proc AS n1844server # [ 155.966942] postgres[1342]: ON ev.objid = n.oid1845server # [ 155.971066] postgres[1342]: );1846server # [ 155.974729] postgres[1342]:1847server # [ 155.976405] postgres[1342]: IF func_is_graphql_resolve1848server # [ 155.979673] postgres[1342]: THEN1849server # [ 155.982277] postgres[1342]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1850server # [ 155.985824] postgres[1342]: DROP FUNCTION IF EXISTS graphql_public.graphql;1851server # [ 155.991054] postgres[1342]: create or replace function graphql_public.graphql(1852server # [ 155.994323] postgres[1342]: "operationName" text default null,1853server # [ 155.997777] postgres[1342]: query text default null,1854server # [ 155.999594] postgres[1342]: variables jsonb default null,1855server # [ 156.002077] postgres[1342]: extensions jsonb default null1856server # [ 156.007678] postgres[1342]: )1857server # [ 156.010257] postgres[1342]: returns jsonb1858server # [ 156.011902] postgres[1342]: language sql1859server # [ 156.013951] postgres[1342]: as $$1860server # [ 156.019052] postgres[1342]: select graphql.resolve(1861server # [ 156.025114] postgres[1342]: query := query,1862server # [ 156.030461] postgres[1342]: variables := coalesce(variables, '{}'),1863server # [ 156.037386] postgres[1342]: "operationName" := "operationName",1864server # [ 156.038761] postgres[1342]: extensions := extensions1865server # [ 156.046877] postgres[1342]: );1866server # [ 156.048296] postgres[1342]: $$;1867server # [ 156.050506] postgres[1342]:1868server # [ 156.051917] postgres[1342]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1869server # [ 156.057533] postgres[1342]: -- function in the extension so we need to grant permissions on existing entities AND1870server # [ 156.066163] postgres[1342]: -- update default permissions to any others that are created after `graphql.resolve`1871server # [ 156.068648] postgres[1342]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1872server # [ 156.070387] postgres[1342]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1873server # [ 156.077745] postgres[1342]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1874server # [ 156.079031] postgres[1342]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1875server # [ 156.086752] postgres[1342]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1876server # [ 156.097838] postgres[1342]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1877server # [ 156.099145] postgres[1342]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1878server # [ 156.110796] postgres[1342]:1879server # [ 156.117201] postgres[1342]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles1880server # [ 156.126660] postgres[1342]: grant usage on schema graphql_public to postgres with grant option;1881server # [ 156.130528] postgres[1342]: grant usage on schema graphql to postgres with grant option;1882server # [ 156.136236] postgres[1342]: END IF;1883server # [ 156.139555] postgres[1342]:1884server # [ 156.142347] postgres[1342]: END;1885server # [ 156.143840] postgres[1342]: $func$;1886server # [ 156.147444] postgres[1342]: ::1 2026-10-31 19:39:28.685 UTC [1342] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1887server # [ 156.161415] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1341]: CREATE FUNCTION1888server # [ 156.164169] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1341]: DROP EXTENSION1889server # [ 157.718795] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1341]: DO1890server # [ 157.779878] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql1891server # [ 158.292470] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1354]: DO1892server # [ 158.318730] postgres[1358]: ::1 2026-10-31 19:39:30.977 UTC [1358] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger1893server # [ 158.324958] postgres[1358]: LANGUAGE plpgsql1894server # [ 158.327083] postgres[1358]: AS $$1895server # [ 158.335940] postgres[1358]: BEGIN1896server # [ 158.337954] postgres[1358]: IF EXISTS (1897server # [ 158.340047] postgres[1358]: SELECT1898server # [ 158.343428] postgres[1358]: FROM pg_event_trigger_ddl_commands() AS ev1899server # [ 158.352678] postgres[1358]: JOIN pg_extension AS ext1900server # [ 158.355701] postgres[1358]: ON ev.objid = ext.oid1901server # [ 158.360727] postgres[1358]: WHERE ext.extname = 'pg_cron'1902server # [ 158.364718] postgres[1358]: )1903server # [ 158.365622] postgres[1358]: THEN1904server # [ 158.371438] postgres[1358]: grant usage on schema cron to postgres with grant option;1905server # [ 158.374394] postgres[1358]:1906server # [ 158.378632] postgres[1358]: alter default privileges in schema cron grant all on tables to postgres with grant option;1907server # [ 158.382258] postgres[1358]: alter default privileges in schema cron grant all on functions to postgres with grant option;1908server # [ 158.389237] postgres[1358]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1909server # [ 158.393110] postgres[1358]:1910server # [ 158.401718] postgres[1358]: alter default privileges for user supabase_admin in schema cron grant all1911server # [ 158.405047] postgres[1358]: on sequences to postgres with grant option;1912server # [ 158.409330] postgres[1358]: alter default privileges for user supabase_admin in schema cron grant all1913server # [ 158.413294] postgres[1358]: on tables to postgres with grant option;1914server # [ 158.420677] postgres[1358]: alter default privileges for user supabase_admin in schema cron grant all1915server # [ 158.424698] postgres[1358]: on functions to postgres with grant option;1916server # [ 158.429186] postgres[1358]:1917server # [ 158.437058] postgres[1358]: grant all privileges on all tables in schema cron to postgres with grant option;1918server # [ 158.453057] postgres[1358]: revoke all on table cron.job from postgres;1919server # [ 158.470918] postgres[1358]: grant select on table cron.job to postgres with grant option;1920server # [ 158.486642] postgres[1358]: END IF;1921server # [ 158.487773] postgres[1358]: END;1922server # [ 158.493811] postgres[1358]: $$;1923server # [ 158.496620] postgres[1358]: ::1 2026-10-31 19:39:31.048 UTC [1358] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access;1924server # [ 158.507234] postgres[1358]: ::1 2026-10-31 19:39:31.066 UTC [1358] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;1925server # [ 158.519705] postgres[1358]: ::1 2026-10-31 19:39:31.089 UTC [1358] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end1926server # [ 158.529447] postgres[1358]: WHEN TAG IN ('CREATE EXTENSION')1927server # [ 158.533219] postgres[1358]: EXECUTE FUNCTION extensions.grant_pg_cron_access();1928server # [ 158.543891] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1354]: CREATE FUNCTION1929server # [ 158.547548] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1354]: DROP EVENT TRIGGER1930server # [ 158.553356] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1354]: ALTER FUNCTION1931server # [ 158.557030] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1354]: CREATE EVENT TRIGGER1932server # [ 158.563637] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql1933server # [ 158.844996] postgres[1366]: ::1 2026-10-31 19:39:31.512 UTC [1366] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s';1934server # [ 158.882168] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1365]: ALTER ROLE1935server # [ 158.906596] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql1936server # [ 159.213239] postgres[1368]: ::1 2026-10-31 19:39:31.885 UTC [1368] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin;1937server # [ 159.237719] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1367]: ALTER FUNCTION1938server # [ 159.242993] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1367]: ALTER FUNCTION1939server # [ 159.257252] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1367]: ALTER FUNCTION1940server # [ 159.258466] postgres[1368]: ::1 2026-10-31 19:39:31.910 UTC [1368] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;1941server # [ 159.262417] postgres[1368]: ::1 2026-10-31 19:39:31.916 UTC [1368] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;1942server # [ 159.289584] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql1943server # [ 159.575272] postgres[1370]: ::1 2026-10-31 19:39:32.250 UTC [1370] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres;1944server # [ 159.581809] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1369]: GRANT ROLE1945server # [ 159.616232] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql1946server # [ 160.597391] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1371]: DO1947server # [ 160.678078] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql1948server # [ 161.028174] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1383]: DO1949server # [ 161.043887] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1383]: DO1950server # [ 161.091482] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql1951server # [ 161.330304] postgres[1396]: ::1 2026-10-31 19:39:34.013 UTC [1396] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none;1952server # [ 161.356264] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1395]: ALTER ROLE1953server # [ 161.367070] postgres[1396]: ::1 2026-10-31 19:39:34.038 UTC [1396] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none;1954server # [ 161.386502] postgres[1396]: ::1 2026-10-31 19:39:34.045 UTC [1396] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none;1955server # [ 161.387947] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1395]: ALTER ROLE1956server # [ 161.388845] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1395]: ALTER ROLE1957server # [ 161.405932] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql1958server # [ 161.691746] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1397]: DO1959server # [ 161.734851] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql1960server # [ 162.074627] systemd[1]: Starting Virtual Console Setup...1961server # [ 162.127526] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1402]: DO1962server # [ 162.176496] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql1963server # [ 162.501674] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1964server # [ 162.520541] systemd[1]: Stopped Virtual Console Setup.1965server # [ 162.614697] systemd[1]: Starting Virtual Console Setup...1966server # [ 162.645807] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1405]: CREATE FUNCTION1967server # [ 162.670126] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1405]: DO1968server # [ 162.686550] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql1969server # [ 162.979589] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1409]: ALTER FUNCTION1970server # [ 162.985812] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1409]: GRANT1971server # [ 163.045299] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql1972server # [ 163.442925] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1411]: DROP EVENT TRIGGER1973server # [ 163.493881] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1411]: ALTER FUNCTION1974server # [ 163.513768] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1411]: CREATE EVENT TRIGGER1975server # [ 163.583953] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql1976server # [ 164.231605] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1414]: DO1977server # [ 164.294754] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql1978server # [ 164.865847] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1416]: CREATE FUNCTION1979server # [ 164.880877] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1416]: GRANT1980server # [ 164.935376] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql1981server # [ 165.338482] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1426]: REVOKE ROLE1982server # [ 165.390329] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1426]: DO1983server # [ 165.412278] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1426]: DO1984server # [ 165.430660] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1426]: REVOKE ROLE1985server # [ 165.444603] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1426]: REVOKE1986server # [ 165.474469] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1426]: DO1987server # [ 165.543029] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql1988server # [ 166.188059] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1433]: DO1989server # [ 166.201778] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql1990server # [ 166.782135] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1442]: DO1991server # [ 166.825698] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql1992server # [ 167.338787] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1444]: DO1993server # [ 167.394299] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql1994server # [ 167.459996] systemd-vconsole-setup[1408]: Configuration of first virtual console was skipped, ignoring remaining ones.1995server # [ 167.530752] systemd[1]: Finished Virtual Console Setup.1996server # [ 167.710993] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1446]: ALTER ROLE1997server # [ 167.761895] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql1998server # [ 168.177710] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1449]: GRANT ROLE1999server # [ 168.217592] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1449]: DO2000server # [ 168.312712] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql2001server # [ 168.868655] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1455]: GRANT2002server # [ 168.924947] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql2003server # [ 169.418335] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1466]: CREATE FUNCTION2004server # [ 169.424711] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1466]: REVOKE2005server # [ 169.443227] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1466]: REVOKE2006server # [ 169.450268] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1466]: GRANT2007server # [ 169.514852] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql2008server # [ 169.877773] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1475]: DO2009server # [ 169.891486] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql2010server # [ 170.218597] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1477]: ALTER ROLE2011server # [ 170.261925] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql2012server # [ 170.640353] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1479]: DROP EXTENSION2013server # [ 170.698079] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql2014server # [ 171.160975] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1481]: CREATE FUNCTION2015server # [ 171.163477] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1481]: DROP EVENT TRIGGER2016server # [ 171.168491] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1481]: CREATE EVENT TRIGGER2017server # [ 171.216803] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql2018server # [ 171.742055] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1489]: DO2019server # [ 171.795290] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1489]: CREATE FUNCTION2020server # [ 171.883597] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql2021server # [ 172.305153] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1501]: CREATE FUNCTION2022server # [ 172.318240] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1501]: CREATE FUNCTION2023server # [ 172.353508] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql2024server # [ 172.424118] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2025server # [ 172.650376] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1507]: CREATE FUNCTION2026server # [ 172.666263] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1507]: CREATE FUNCTION2027server # [ 172.683389] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1507]: CREATE FUNCTION2028server # [ 172.705758] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1507]: CREATE FUNCTION2029server # [ 172.726623] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1507]: CREATE FUNCTION2030server # [ 172.737317] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1507]: CREATE FUNCTION2031server # [ 172.785650] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Running postgresql schema...2032server # [ 173.088020] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER DATABASE2033server # [ 173.096534] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER DATABASE2034server # [ 173.153592] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER ROLE2035server # [ 173.210315] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER ROLE2036server # [ 173.278685] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER ROLE2037server # [ 173.338561] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER ROLE2038server # [ 173.410578] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER ROLE2039server # [ 173.455469] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER ROLE2040server # [ 173.511491] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER ROLE2041server # [ 173.582965] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER ROLE2042server # [ 173.707467] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER ROLE2043server # [ 173.729895] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1509]: ALTER ROLE2044server # [ 173.803847] 3j17f06sldnfpj8jnk47zvn4s91dkk7h-supabase-db-init[1067]: Database initialization complete2045server # [ 173.890505] systemd[1]: Finished Supabase Database Initialization.2046server # [ 174.944597] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2047server # [ 175.235431] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2048server # [ 175.291591] systemd[1]: Started backdoor.service.2049server # [ 175.302279] systemd[1]: Reached target Multi-User System.2050server # [ 175.317717] systemd[1]: Startup finished in 2.477s (kernel) + 26.425s (initrd) + 2min 26.399s (userspace) = 2min 55.302s.2051server # [ 175.827320] (udev-worker)[1515]: Network interface NamePolicy= disabled on kernel command line.2052server # [ 175.861640] (udev-worker)[1520]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.2053server # [ 176.008649] 8021q: 802.1Q VLAN Support v1.82054server # [ 175.901942] (udev-worker)[1520]: Network interface NamePolicy= disabled on kernel command line.2055server # connecting to host...2056server: Guest shell says: b'Spawning backdoor root shell...\n'2057server: connected to guest root shell2058server: (connecting took 177.71 seconds)2059server: (finished: waiting for the VM to finish booting, in 177.71 seconds)2060server # [ 176.821325] cfg80211: Loading compiled-in X.509 certificates for regulatory database2061server # [ 176.885787] systemd[1]: Condition check resulted in Virtio network device being skipped.2062server # [ 176.945859] systemd[1]: Starting Address configuration of eth1...2063server # [ 177.156695] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2064server # [ 177.159582] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2065server # [ 177.183117] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22066server # [ 177.183599] cfg80211: failed to load regulatory.db2067server: (finished: waiting for unit supabase-db-init.service, in 178.89 seconds)2068subtest: Check upgrade path with postgresql 152069server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" 2070server # [ 177.846286] 8021q: adding VLAN 0 to HW filter on device eth12071server # [ 177.949252] network-addresses-eth1-start[1550]: adding address 192.168.1.1/24... done2072server # [ 178.225204] 8021q: adding VLAN 0 to HW filter on device eth02073server # [ 178.108065] dhcpcd[729]: eth0: waiting for carrier2074server # [ 178.142901] network-addresses-eth1-start[1550]: adding address 2001:db8:1::1/64... done2075server # [ 178.161881] dhcpcd[729]: eth0: carrier acquired2076server # NOTICE: extension "plv8" does not exist, skipping2077server # [ 178.335054] dhcpcd[729]: DUID 00:01:00:01:32:79:00:87:52:54:00:12:34:562078server # [ 178.352192] dhcpcd[729]: eth0: IAID 00:12:34:562079server # [ 178.360121] dhcpcd[729]: eth0: adding address fe80::5054:ff:fe12:34562080server # [ 178.441221] systemd[1]: Finished Address configuration of eth1.2081server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.82 seconds)2082server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.4' CASCADE;" 2083server # [ 180.088484] dhcpcd[729]: eth0: soliciting a DHCP lease2084server # [ 180.110980] dhcpcd[729]: eth0: offered 10.0.2.15 from 10.0.2.22085server # [ 180.132316] dhcpcd[729]: eth0: probing address 10.0.2.15/242086server # [ 181.053566] dhcpcd[729]: eth0: soliciting an IPv6 router2087server # [ 181.065382] dhcpcd[729]: eth0: Router Advertisement from fe80::22088server # [ 181.072987] dhcpcd[729]: eth0: adding address fec0::5054:ff:fe12:3456/642089server # [ 181.101129] dhcpcd[729]: eth0: adding route to fec0::/642090server # [ 181.105347] dhcpcd[729]: eth0: adding default route via fe80::22091server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.4' CASCADE;" , in 6.05 seconds)2092server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" 2093server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.62 seconds)2094server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" 2095server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.60 seconds)2096server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.5' CASCADE;" 2097server # [ 185.896413] dhcpcd[729]: eth0: leased 10.0.2.15 for 86400 seconds2098server # [ 185.902377] dhcpcd[729]: eth0: adding route to 10.0.2.0/242099server # [ 185.911320] dhcpcd[729]: eth0: adding default route via 10.0.2.22100server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.5' CASCADE;" , in 7.15 seconds)2101server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" 2102server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.73 seconds)2103server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" 2104server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.92 seconds)2105server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" 2106server # [ 195.218875] systemd-logind[592]: Watching system buttons on /dev/input/event0 (gpio-keys)2107server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 5.69 seconds)2108server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" 2109server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.61 seconds)2110(finished: subtest: Check upgrade path with postgresql 15, in 23.20 seconds)2111subtest: Check the install of the last version of the extension2112server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" 2113server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "DROP EXTENSION IF EXISTS plv8;" , in 0.51 seconds)2114server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" 2115server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "CREATE EXTENSION plv8 WITH VERSION '3.1.10' CASCADE;" , in 1.98 seconds)2116server: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" 2117server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F"," -c "SELECT extversion FROM pg_extension WHERE extname = 'plv8';" , in 0.70 seconds)2118(finished: subtest: Check the install of the last version of the extension, in 3.19 seconds)2119(finished: run the VM test script, in 205.51 seconds)2120test script finished in 205.96s2121cleanup2122kill QemuMachine (pid 13)2123server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/vilynzly1pyhawy04ljmrp7n9ffr24qy-python3-3.13.17/bin/python3.13)2124(finished: cleanup, in 0.07 seconds)