vm-test-run-amcheck-upgrade
checks.aarch64-linux.ext-amcheck-upgrade
· build #432
· raw
1Machine state will be reset. To keep it, pass --keep-vm-state2start all VLans3start vlan4running vlan (pid 7; ctl /build/vde1.ctl)5(finished: start all VLans, in 0.00 seconds)6Test will time out and terminate in 3600 seconds7run the VM test script8additionally exposed symbols:9 server,10 vlan1,11 start_all, test_script, machines, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, Machine, t, debug12start all VMs13server: starting vm14mke2fs 1.47.3 (8-Jul-2025)15qemu-system-aarch64: Could not access KVM kernel module: No such file or directory16qemu-system-aarch64: failed to initialize kvm: No such file or directory17qemu-system-aarch64: falling back to tcg18server # Disk image does not exist, creating the virtualisation disk image...19server # Formatting '/build/vm-state-server/tmp.PRYVKZtiER', fmt=raw size=107374182420server # Discarding device blocks: 0/262144 done21server # Creating filesystem with 262144 4k blocks and 65536 inodes22server # Filesystem UUID: f91de203-96d1-4cff-9209-0285bdf227a023server # Superblock backups stored on blocks:24server # 32768, 98304, 163840, 22937625server # 26server # Allocating group tables: 0/8 done27server # Writing inode tables: 0/8 done28server # Creating journal (8192 blocks): done29server # Writing superblocks and filesystem accounting information: 0/8 done30server: QEMU running (pid 9)31server # 32server # Virtualisation disk image created.33(finished: start all VMs, in 0.78 seconds)34server: waiting for unit supabase-db-init.service35server: waiting for the VM to finish booting36server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]37server # [ 0.000000] Linux version 6.12.63 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP Thu Dec 18 12:55:23 UTC 202538server # [ 0.000000] KASLR enabled39server # [ 0.000000] random: crng init done40server # [ 0.000000] Machine model: linux,dummy-virt41server # [ 0.000000] efi: UEFI not found.42server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT43server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]44server # [ 0.000000] NODE_DATA(0) allocated [mem 0x13f602200-0x13f60593f]45server # [ 0.000000] Zone ranges:46server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff]47server # [ 0.000000] DMA32 empty48server # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff]49server # [ 0.000000] Device empty50server # [ 0.000000] Movable zone start for each node51server # [ 0.000000] Early memory node ranges52server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff]53server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]54server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -155server # [ 0.000000] psci: probing for conduit method from DT.56server # [ 0.000000] psci: PSCIv1.1 detected in firmware.57server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs58server # [ 0.000000] psci: Trusted OS migration not required59server # [ 0.000000] psci: SMC Calling Convention v1.060server # [ 0.000000] percpu: Embedded 88 pages/cpu s180056 r65536 d114856 u36044861server # [ 0.000000] Detected PIPT I-cache on CPU062server # [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)63server # [ 0.000000] CPU features: detected: GIC system register CPU interface64server # [ 0.000000] CPU features: detected: HCRX_EL2 register65server # [ 0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2)66server # [ 0.000000] CPU features: detected: Spectre-v467server # [ 0.000000] alternatives: applying boot alternatives68server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/gr1yaf8psc7yjvr43i6x7hbzrb5fxz5a-nixos-system-server-test/init regInfo=/nix/store/y020dhnfbm44g9hxrg1z630c79xznlda-closure-info/registration console=ttyAMA0,115200n8 console=tty069server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/y020dhnfbm44g9hxrg1z630c79xznlda-closure-info/registration", will be passed to user space.70server # [ 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] Fallback order for Node 0: 073server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 104857674server # [ 0.000000] Policy zone: Normal75server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off76server # [ 0.000000] software IO TLB: area num 2.77server # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)78server # [ 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 72257 entries in 283 pages81server # [ 0.000000] ftrace: allocated 283 pages with 5 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] Rude variant of Tasks RCU enabled.86server # [ 0.000000] Tracing variant of Tasks RCU enabled.87server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.88server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=289server # [ 0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.90server # [ 0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.91server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 092server # [ 0.000000] GICv3: 256 SPIs implemented93server # [ 0.000000] GICv3: 0 Extended SPIs implemented94server # [ 0.000000] Root IRQ handler: gic_handle_irq95server # [ 0.000000] GICv3: GICv3 features: 16 PPIs96server # [ 0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=097server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a000098server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]99server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100ae0000 (indirect, esz 8, psz 64K, shr 1)100server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100af0000 (flat, esz 8, psz 64K, shr 1)101server # [ 0.000000] GICv3: using LPI property table @0x0000000100b00000102server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b10000103server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.104server # [ 0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (virt).105server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns106server # [ 0.000032] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns107server # [ 0.004077] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)108server # [ 0.013743] Console: colour dummy device 80x25109server # [ 0.015011] printk: legacy console [tty0] enabled110server # [ 0.020118] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)111server # [ 0.020473] pid_max: default: 32768 minimum: 301112server # [ 0.022318] LSM: initializing lsm=capability,landlock,yama,bpf113server # [ 0.023408] landlock: Up and running.114server # [ 0.023447] Yama: becoming mindful.115server # [ 0.026519] LSM support for eBPF active116server # [ 0.030838] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)117server # [ 0.030987] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)118server # [ 0.060103] cacheinfo: Unable to detect cache hierarchy for CPU 0119server # [ 0.075638] rcu: Hierarchical SRCU implementation.120server # [ 0.075743] rcu: Max phase no-delay instances is 1000.121server # [ 0.077051] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level122server # [ 0.084177] fsl-mc MSI: its@8080000 domain created123server # [ 0.086188] EFI services will not be available.124server # [ 0.087670] smp: Bringing up secondary CPUs ...125server # [ 0.094002] Detected PIPT I-cache on CPU1126server # [ 0.095097] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000127server # [ 0.095791] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000128server # [ 0.097223] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]129server # [ 0.100291] smp: Brought up 1 node, 2 CPUs130server # [ 0.100409] SMP: Total of 2 processors activated.131server # [ 0.100442] CPU: All CPU(s) started at EL1132server # [ 0.100588] CPU features: detected: Branch Target Identification133server # [ 0.100636] CPU features: detected: 32-bit EL0 Support134server # [ 0.100659] CPU features: detected: 32-bit EL1 Support135server # [ 0.100679] CPU features: detected: ARMv8.4 Translation Table Level136server # [ 0.100707] CPU features: detected: Instruction cache invalidation not required for I/D coherence137server # [ 0.100740] CPU features: detected: Data cache clean to the PoU not required for I/D coherence138server # [ 0.100789] CPU features: detected: Common not Private translations139server # [ 0.100813] CPU features: detected: CRC32 instructions140server # [ 0.100835] CPU features: detected: Data cache clean to Point of Deep Persistence141server # [ 0.100863] CPU features: detected: Data cache clean to Point of Persistence142server # [ 0.100888] CPU features: detected: Data independent timing control (DIT)143server # [ 0.100913] CPU features: detected: E0PD144server # [ 0.100933] CPU features: detected: Enhanced Counter Virtualization145server # [ 0.100956] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)146server # [ 0.100982] CPU features: detected: Enhanced Privileged Access Never147server # [ 0.101005] CPU features: detected: Enhanced Virtualization Traps148server # [ 0.101028] CPU features: detected: Fine Grained Traps149server # [ 0.101072] CPU features: detected: Generic authentication (IMP DEF algorithm)150server # [ 0.101141] CPU features: detected: RCpc load-acquire (LDAPR)151server # [ 0.101178] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)152server # [ 0.101198] CPU features: detected: LSE atomic instructions153server # [ 0.101219] CPU features: detected: Memory Copy and Memory Set instructions154server # [ 0.101239] CPU features: detected: Privileged Access Never155server # [ 0.101258] CPU features: detected: RAS Extension Support156server # [ 0.101276] CPU features: detected: Random Number Generator157server # [ 0.101294] CPU features: detected: Speculation barrier (SB)158server # [ 0.101312] CPU features: detected: Stage-2 Force Write-Back159server # [ 0.101332] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality160server # [ 0.101360] CPU features: detected: TLB range maintenance instructions161server # [ 0.101384] CPU features: detected: WFx with timeout162server # [ 0.101425] CPU features: detected: Speculative Store Bypassing Safe (SSBS)163server # [ 0.101451] CPU features: detected: Scalable Vector Extension164server # [ 0.107805] alternatives: applying system-wide alternatives165server # [ 0.121970] CPU features: detected: Hardware dirty bit management on CPU0-1166server # [ 0.122514] SVE: maximum available vector length 256 bytes per vector167server # [ 0.122605] SVE: default vector length 64 bytes per vector168server # [ 0.134063] Memory: 3922832K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved)169server # [ 0.153068] devtmpfs: initialized170server # [ 0.176564] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns171server # [ 0.177047] futex hash table entries: 512 (order: 3, 32768 bytes, linear)172server # [ 0.179687] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL173server # [ 0.179742] 0 pages in range for non-PLT usage174server # [ 0.179782] 509248 pages in range for PLT usage175server # [ 0.181894] pinctrl core: initialized pinctrl subsystem176server # [ 0.190317] DMI not present or invalid.177server # [ 0.205875] NET: Registered PF_NETLINK/PF_ROUTE protocol family178server # [ 0.216117] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations179server # [ 0.216993] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations180server # [ 0.217903] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations181server # [ 0.218131] audit: initializing netlink subsys (disabled)182server # [ 0.220041] audit: type=2000 audit(0.144:1): state=initialized audit_enabled=0 res=1183server # [ 0.225776] thermal_sys: Registered thermal governor 'fair_share'184server # [ 0.225818] thermal_sys: Registered thermal governor 'bang_bang'185server # [ 0.225856] thermal_sys: Registered thermal governor 'step_wise'186server # [ 0.225879] thermal_sys: Registered thermal governor 'user_space'187server # [ 0.225903] thermal_sys: Registered thermal governor 'power_allocator'188server # [ 0.226374] cpuidle: using governor ladder189server # [ 0.226626] cpuidle: using governor menu190server # [ 0.228662] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.191server # [ 0.229339] ASID allocator initialised with 65536 entries192server # [ 0.235560] Serial: AMBA PL011 UART driver193server # [ 0.276014] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1194server # [ 0.277420] printk: legacy console [ttyAMA0] enabled195server # [ 0.307308] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages196server # [ 0.307509] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page197server # [ 0.307636] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages198server # [ 0.307853] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page199server # [ 0.308023] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages200server # [ 0.308120] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page201server # [ 0.308214] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages202server # [ 0.308320] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page203server # [ 0.318447] fbcon: Taking over console204server # [ 0.319144] ACPI: Interpreter disabled.205server # [ 0.331951] iommu: Default domain type: Translated206server # [ 0.332113] iommu: DMA domain TLB invalidation policy: strict mode207server # [ 0.334624] SCSI subsystem initialized208server # [ 0.336679] usbcore: registered new interface driver usbfs209server # [ 0.337048] usbcore: registered new interface driver hub210server # [ 0.337390] usbcore: registered new device driver usb211server # [ 0.339776] pps_core: LinuxPPS API ver. 1 registered212server # [ 0.339923] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>213server # [ 0.340155] PTP clock support registered214server # [ 0.340687] EDAC MC: Ver: 3.0.0215server # [ 0.342907] scmi_core: SCMI protocol bus registered216server # [ 0.345433] FPGA manager framework217server # [ 0.346633] Advanced Linux Sound Architecture Driver Initialized.218server # [ 0.353518] vgaarb: loaded219server # [ 0.357444] clocksource: Switched to clocksource arch_sys_counter220server # [ 0.361097] VFS: Disk quotas dquot_6.6.0221server # [ 0.361318] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)222server # [ 0.363472] netfs: FS-Cache loaded223server # [ 0.364558] pnp: PnP ACPI: disabled224server # [ 0.396237] NET: Registered PF_INET protocol family225server # [ 0.397225] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)226server # [ 0.489742] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)227server # [ 0.490227] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)228server # [ 0.490768] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)229server # [ 0.491558] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)230server # [ 0.492220] TCP: Hash tables configured (established 32768 bind 32768)231server # [ 0.493602] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)232server # [ 0.494099] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)233server # [ 0.494496] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)234server # [ 0.496039] NET: Registered PF_UNIX/PF_LOCAL protocol family235server # [ 0.496447] NET: Registered PF_XDP protocol family236server # [ 0.496700] PCI: CLS 0 bytes, default 64237server # [ 0.500001] Trying to unpack rootfs image as initramfs...238server # [ 0.502903] kvm [1]: HYP mode not available239server # [ 0.589872] Initialise system trusted keyrings240server # [ 0.591390] workingset: timestamp_bits=42 max_order=20 bucket_order=0241server # [ 0.594542] squashfs: version 4.0 (2009/01/31) Phillip Lougher242server # [ 0.595216] 9p: Installing v9fs 9p2000 file system support243server # [ 0.640061] Key type asymmetric registered244server # [ 0.640263] Asymmetric key parser 'x509' registered245server # [ 0.640620] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244)246server # [ 0.641826] io scheduler mq-deadline registered247server # [ 0.641984] io scheduler kyber registered248server # [ 0.661300] pl061_gpio 9030000.pl061: PL061 GPIO chip registered249server # [ 0.664783] ledtrig-cpu: registered to indicate activity on CPUs250server # [ 0.668353] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:251server # [ 0.668921] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000252server # [ 0.669513] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000253server # [ 0.670105] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000254server # [ 0.670816] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits255server # [ 0.671358] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]256server # [ 0.672507] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00257server # [ 0.672892] pci_bus 0000:00: root bus resource [bus 00-ff]258server # [ 0.673036] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]259server # [ 0.673227] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]260server # [ 0.673405] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]261server # [ 0.674592] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint262server # [ 0.677012] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint263server # [ 0.677323] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]264server # [ 0.677773] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]265server # [ 0.677913] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]266server # [ 0.678100] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]267server # [ 0.678844] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint268server # [ 0.679082] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]269server # [ 0.679198] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]270server # [ 0.679290] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]271server # [ 0.679696] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint272server # [ 0.680049] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]273server # [ 0.680211] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]274server # [ 0.680445] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]275server # [ 0.680929] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint276server # [ 0.681098] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]277server # [ 0.681186] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]278server # [ 0.681283] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]279server # [ 0.681804] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint280server # [ 0.681966] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]281server # [ 0.682069] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]282server # [ 0.682196] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]283server # [ 0.682744] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint284server # [ 0.683107] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]285server # [ 0.683216] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]286server # [ 0.683326] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]287server # [ 0.683718] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint288server # [ 0.684038] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]289server # [ 0.684127] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]290server # [ 0.684225] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]291server # [ 0.684366] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]292server # [ 0.684830] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint293server # [ 0.685023] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]294server # [ 0.685188] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]295server # [ 0.685928] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint296server # [ 0.686111] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]297server # [ 0.686267] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298server # [ 0.686794] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint299server # [ 0.687155] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]300server # [ 0.687606] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint301server # [ 0.687856] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]302server # [ 0.688011] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]303server # [ 0.688133] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]304server # [ 0.688643] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint305server # [ 0.688835] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]306server # [ 0.688916] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]307server # [ 0.689012] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]308server # [ 0.691389] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned309server # [ 0.691642] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned310server # [ 0.691849] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned311server # [ 0.692112] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned312server # [ 0.692329] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned313server # [ 0.692471] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned314server # [ 0.692617] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned315server # [ 0.692732] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned316server # [ 0.692841] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned317server # [ 0.692981] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned318server # [ 0.693110] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned319server # [ 0.693223] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned320server # [ 0.693352] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned321server # [ 0.694175] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned322server # [ 0.694519] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned323server # [ 0.694648] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned324server # [ 0.694806] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned325server # [ 0.694945] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned326server # [ 0.695051] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned327server # [ 0.695179] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned328server # [ 0.695276] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned329server # [ 0.695373] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned330server # [ 0.695467] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned331server # [ 0.695561] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned332server # [ 0.695689] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned333server # [ 0.695798] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned334server # [ 0.695948] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned335server # [ 0.696063] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned336server # [ 0.696581] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned337server # [ 0.696695] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned338server # [ 0.696786] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned339server # [ 0.696871] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned340server # [ 0.696957] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned341server # [ 0.697113] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned342server # [ 0.697380] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]343server # [ 0.698056] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]344server # [ 0.698242] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]345server # [ 0.699761] pci 0000:00:0a.0: enabling device (0000 -> 0002)346server # [ 0.743281] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)347server # [ 0.747662] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)348server # [ 0.749283] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)349server # [ 0.750846] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)350server # [ 0.752256] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)351server # [ 0.753773] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)352server # [ 0.755440] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)353server # [ 0.757040] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)354server # [ 0.758560] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)355server # [ 0.760347] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)356server # [ 0.761884] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)357server # [ 0.773123] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled358server # [ 0.779967] msm_serial: driver initialized359server # [ 0.781415] SuperH (H)SCI(F) driver initialized360server # [ 0.782020] STM32 USART driver initialized361server # [ 0.817785] loop: module loaded362server # [ 0.818378] virtio_blk virtio5: 2/0/0 default/read/poll queues363server # [ 0.821457] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)364server # [ 0.831641] megasas: 07.727.03.00-rc1365server # [ 0.835951] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]366server # [ 0.838333] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000367server # [ 0.838918] Intel/Sharp Extended Query Table at 0x0031368server # [ 0.840263] Using buffer write method369server # [ 0.840770] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]370server # [ 0.842009] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000371server # [ 0.842323] Intel/Sharp Extended Query Table at 0x0031372server # [ 0.843516] Using buffer write method373server # [ 0.843715] Concatenating MTD devices:374server # [ 0.843813] (0): "0.flash"375server # [ 0.843874] (1): "0.flash"376server # [ 0.843927] into device "0.flash"377server # [ 0.850575] Freeing initrd memory: 10684K378server # [ 0.866759] tun: Universal TUN/TAP device driver, 1.6379server # [ 0.875205] thunder_xcv, ver 1.0380server # [ 0.875421] thunder_bgx, ver 1.0381server # [ 0.875574] nicpf, ver 1.0382server # [ 0.877582] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version383server # [ 0.877715] hns3: Copyright (c) 2017 Huawei Corporation.384server # [ 0.878032] hclge is initializing385server # [ 0.878740] e1000: Intel(R) PRO/1000 Network Driver386server # [ 0.878906] e1000: Copyright (c) 1999-2006 Intel Corporation.387server # [ 0.879115] e1000e: Intel(R) PRO/1000 Network Driver388server # [ 0.879190] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.389server # [ 0.879396] igb: Intel(R) Gigabit Ethernet Network Driver390server # [ 0.879470] igb: Copyright (c) 2007-2014 Intel Corporation.391server # [ 0.879660] igbvf: Intel(R) Gigabit Virtual Function Network Driver392server # [ 0.879964] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.393server # [ 0.880605] sky2: driver version 1.30394server # [ 0.887148] ehci-pci 0000:00:0a.0: EHCI Host Controller395server # [ 0.887671] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1396server # [ 0.888495] usbcore: registered new interface driver usb-storage397server # [ 0.889056] usbcore: registered new interface driver usbserial_generic398server # [ 0.890052] usbserial: USB Serial support registered for generic399server # [ 0.891230] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000400server # [ 0.896576] rtc-pl031 9010000.pl031: registered as rtc0401server # [ 0.897206] rtc-pl031 9010000.pl031: setting system clock to 2026-10-22T15:11:52 UTC (1792681912)402server # [ 0.898802] i2c_dev: i2c /dev entries driver403server # [ 0.901680] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00404server # [ 0.907267] hub 1-0:1.0: USB hub found405server # [ 0.908068] hub 1-0:1.0: 6 ports detected406server # [ 0.910365] sdhci: Secure Digital Host Controller Interface driver407server # [ 0.910512] sdhci: Copyright(c) Pierre Ossman408server # [ 0.911720] Synopsys Designware Multimedia Card Interface Driver409server # [ 0.913096] sdhci-pltfm: SDHCI platform and OF driver helper410server # [ 0.917999] hid: raw HID events driver (C) Jiri Kosina411server # [ 0.919626] usbcore: registered new interface driver usbhid412server # [ 0.919741] usbhid: USB HID core driver413server # [ 0.925130] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available414server # [ 0.933879] drop_monitor: Initializing network drop monitor service415server # [ 0.935820] NET: Registered PF_INET6 protocol family416server # [ 0.945481] Segment Routing with IPv6417server # [ 0.945745] In-situ OAM (IOAM) with IPv6418server # [ 0.947327] NET: Registered PF_PACKET protocol family419server # [ 0.948308] 9pnet: Installing 9P2000 support420server # [ 0.951290] Key type dns_resolver registered421server # [ 0.978973] registered taskstats version 1422server # [ 0.980879] Loading compiled-in X.509 certificates423server # [ 1.022021] Demotion targets for Node 0: null424server # [ 1.023753] Key type .fscrypt registered425server # [ 1.023883] Key type fscrypt-provisioning registered426server # [ 1.030318] input: gpio-keys as /devices/platform/gpio-keys/input/input0427server # [ 1.064878] clk: Disabling unused clocks428server # [ 1.065141] PM: genpd: Disabling unused power domains429server # [ 1.065405] ALSA device list:430server # [ 1.065504] No soundcards found.431server # [ 1.133474] Freeing unused kernel memory: 4416K432server # [ 1.135245] Run /init as init process433server # [ 1.165858] usb 1-1: new high-speed USB device number 2 using ehci-pci434server # [ 1.344268] 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/input1435server # [ 1.459954] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0436server # [ 1.538774] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev437server # [ 1.581796] usb 1-2: new high-speed USB device number 3 using ehci-pci438server # [ 1.616018] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0439server # [ 1.616645] [drm] features: -virgl +edid -resource_blob -host_visible440server # [ 1.616666] [drm] features: -context_init441server # [ 1.618264] [drm] number of scanouts: 1442server # [ 1.618589] [drm] number of cap sets: 0443server # [ 1.627424] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0444server # [ 1.656417] Console: switching to colour frame buffer device 160x50445server # [ 1.665463] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device446server # [ 1.756957] 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/input2447server # [ 1.758957] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0448server # [ 4.479825] EXT4-fs (vda): mounted filesystem f91de203-96d1-4cff-9209-0285bdf227a0 r/w with ordered data mode. Quota mode: none.449server # [ 6.782732] EXT4-fs (vda): re-mounted f91de203-96d1-4cff-9209-0285bdf227a0.450server # [ 6.798759] booting system configuration /nix/store/gr1yaf8psc7yjvr43i6x7hbzrb5fxz5a-nixos-system-server-test451server # [ 18.306938] systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN -IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE)452server # [ 18.317086] systemd[1]: Detected virtualization qemu.453server # [ 18.321691] systemd[1]: Detected architecture arm64.454server # [ 18.327182] systemd[1]: Detected first boot.455server # [ 18.356135] systemd[1]: Initializing machine ID from random generator.456server # [ 18.387560] systemd[1]: Hostname set to <server>.457server # [ 19.603866] systemd[1]: bpf-restrict-fs: LSM BPF program attached458server # [ 20.867399] systemd[1]: Applying preset policy.459server # [ 24.057068] systemd[1]: Populated /etc with preset unit settings.460server # [ 27.318867] systemd[1]: Queued start job for default target Multi-User System.461server # [ 27.512158] systemd[1]: Created slice Slice /system/getty.462server # [ 27.528214] systemd[1]: Created slice Slice /system/modprobe.463server # [ 27.540815] systemd[1]: Created slice User and Session Slice.464server # [ 27.549124] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.465server # [ 27.555548] systemd[1]: Started Forward Password Requests to Wall Directory Watch.466server # [ 27.560855] systemd[1]: Expecting device /dev/hvc0...467server # [ 27.565170] systemd[1]: Expecting device /dev/ttyAMA0...468server # [ 27.569902] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1...469server # [ 27.574402] systemd[1]: Reached target Local Encrypted Volumes.470server # [ 27.578717] systemd[1]: Reached target Virtual Machines and Containers.471server # [ 27.583701] systemd[1]: Reached target Path Units.472server # [ 27.587833] systemd[1]: Reached target Remote File Systems.473server # [ 27.592546] systemd[1]: Reached target Slice Units.474server # [ 27.597070] systemd[1]: Reached target Swaps.475server # [ 27.631890] systemd[1]: Listening on Process Core Dump Socket.476server # [ 27.654482] systemd[1]: Listening on Credential Encryption/Decryption.477server # [ 27.665543] systemd[1]: Listening on Journal Audit Socket.478server # [ 27.672460] systemd[1]: Listening on Journal Socket (/dev/log).479server # [ 27.679183] systemd[1]: Listening on Journal Sockets.480server # [ 27.687836] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.481server # [ 27.693133] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki).482server # [ 27.700329] systemd[1]: Listening on udev Control Socket.483server # [ 27.706242] systemd[1]: Listening on udev Kernel Socket.484server # [ 27.747654] systemd[1]: Mounting Huge Pages File System...485server # [ 27.785861] systemd[1]: Mounting POSIX Message Queue File System...486server # [ 27.832288] systemd[1]: Mounting Kernel Debug File System...487server # [ 27.884814] systemd[1]: Mounting Kernel Trace File System...488server # [ 28.027131] systemd[1]: Starting Create List of Static Device Nodes...489server # [ 28.099277] systemd[1]: Starting Load Kernel Module 9pnet_virtio...490server # [ 28.104552] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs).491server # [ 28.226597] systemd[1]: Mounting Kernel Configuration File System...492server # [ 28.239484] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm).493server # [ 28.256430] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore).494server # [ 28.393130] systemd[1]: Starting Load Kernel Module fuse...495server # [ 28.407408] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).496server # [ 28.418952] systemd[1]: Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67).497server # [ 28.490398] systemd[1]: Starting Journal Service...498server # [ 28.587009] systemd[1]: Starting Load Kernel Modules...499server # [ 28.657446] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...500server # [ 28.714797] systemd[1]: Starting Remount Root and Kernel File Systems...501server # [ 28.724693] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).502server # [ 28.784404] systemd[1]: Starting Coldplug All udev Devices...503server # [ 28.849898] systemd[1]: Mounted Huge Pages File System.504server # [ 28.861192] systemd[1]: Mounted POSIX Message Queue File System.505server # [ 28.872606] systemd[1]: Mounted Kernel Debug File System.506server # [ 28.886091] systemd[1]: Mounted Kernel Trace File System.507server # [ 28.908121] systemd[1]: Finished Create List of Static Device Nodes.508server # [ 28.930985] systemd[1]: Mounted Kernel Configuration File System.509server # [ 28.989407] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...510server: Guest root shell did not produce any data yet...511server: To debug, enter the VM and run 'systemctl status backdoor.service'.512server # [ 29.286135] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.513server # [ 29.307394] systemd[1]: Finished Load Kernel Module 9pnet_virtio.514server # [ 29.570520] systemd[1]: Finished Load Kernel Modules.515server # [ 29.648215] systemd[1]: Starting Firewall...516server # [ 29.715263] systemd[1]: Starting Apply Kernel Variables...517server # [ 29.751207] fuse: init (API version 7.41)518server # [ 29.807584] systemd[1]: modprobe@fuse.service: Deactivated successfully.519server # [ 29.823255] systemd[1]: Finished Load Kernel Module fuse.520server # [ 29.884298] systemd[1]: Mounting FUSE Control File System...521server # [ 29.953300] EXT4-fs (vda): re-mounted f91de203-96d1-4cff-9209-0285bdf227a0.522server # [ 30.129208] systemd[1]: Finished Remount Root and Kernel File Systems.523server # [ 30.162394] systemd[1]: Mounted FUSE Control File System.524server # [ 30.169240] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).525server # [ 30.227424] systemd[1]: Starting Load/Save OS Random Seed...526server # [ 30.234546] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).527server # [ 30.319129] systemd-journald[397]: Collecting audit messages is enabled.528server # [ 31.048632] systemd[1]: Finished Apply Kernel Variables.529server # [ 31.166467] systemd[1]: Finished Load/Save OS Random Seed.530server # [ 31.173014] systemd[1]: Reached target First Boot Complete.531server # [ 31.353096] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.532server # [ 31.445703] systemd[1]: Starting Create Static Device Nodes in /dev...533server # [ 31.665310] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.534server # [ 32.427735] systemd[1]: Finished Create Static Device Nodes in /dev.535server # [ 32.445104] systemd[1]: Reached target Preparation for Local File Systems.536server # [ 32.497345] systemd[1]: Mounting /run/wrappers...537server # [ 32.552692] systemd[1]: Starting Rule-based Manager for Device Events and Files...538server # [ 32.824096] systemd[1]: Started Journal Service.539server # [ 32.786483] systemd-modules-load[398]: Module 'atkbd' is built in540server # [ 32.799934] systemd-modules-load[398]: Module 'loop' is built in541server # [ 32.828097] systemd-oomd[399]: No swap; memory pressure usage will be degraded542server # [ 32.876698] systemd[1]: Starting Flush Journal to Persistent Storage...543server # [ 32.927599] systemd[1]: Mounted /run/wrappers.544server # [ 32.951710] systemd[1]: Reached target Local File Systems.545server # [ 32.955431] systemd[1]: Listening on Boot Entries Service Socket.546server # [ 33.002448] systemd[1]: Starting Create SUID/SGID Wrappers...547server # [ 33.022845] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met.548server # [ 33.042923] systemd[1]: Starting Save Transient machine-id to Disk...549server # [ 33.705426] systemd-journald[397]: Received client request to flush runtime journal.550server # [ 34.300451] systemd-udevd[429]: Using default interface naming scheme 'v258'.551server # [ 34.375271] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.552server # [ 34.390972] systemd[1]: Finished Save Transient machine-id to Disk.553server # [ 34.393945] systemd[1]: Finished Flush Journal to Persistent Storage.554server # [ 34.415220] systemd[1]: Starting Create System Files and Directories...555server # [ 36.695889] systemd[1]: Finished Create System Files and Directories.556server # [ 36.771212] systemd[1]: Starting Rebuild Journal Catalog...557server # [ 36.833572] systemd[1]: Starting Record System Boot/Shutdown in UTMP...558server # [ 37.053682] systemd[1]: Started Rule-based Manager for Device Events and Files.559server # [ 37.838813] systemd[1]: Finished Record System Boot/Shutdown in UTMP.560server # [ 38.975155] systemd[1]: Finished Rebuild Journal Catalog.561server # [ 39.029675] systemd[1]: Starting Update is Completed...562server # [ 40.001970] systemd[1]: Finished Update is Completed.563server # [ 44.199554] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.564server # [ 44.202844] systemd[1]: Finished Create SUID/SGID Wrappers.565server # [ 44.205988] systemd[1]: suid-sgid-wrappers.service: Consumed 3.067s CPU time, 5.6M memory peak.566server # [ 46.511868] systemd[1]: Finished Firewall.567server # [ 48.496060] systemd[1]: Finished Coldplug All udev Devices.568server # [ 48.514672] systemd[1]: Reached target System Initialization.569server # [ 48.522886] systemd[1]: Started Discard unused filesystem blocks once a week.570server # [ 48.531234] systemd[1]: Started Daily Cleanup of Temporary Directories.571server # [ 48.542402] systemd[1]: Reached target Timer Units.572server # [ 48.554893] systemd[1]: Listening on D-Bus System Message Bus Socket.573server # [ 48.565781] systemd[1]: Listening on Nix Daemon Socket.574server # [ 48.569074] systemd[1]: Listening on Hostname Service Socket.575server # [ 48.573265] systemd[1]: Reached target Socket Units.576server # [ 48.579265] systemd[1]: Reached target Basic System.577server # [ 48.591423] systemd[1]: Starting Import lastlog data into lastlog2 database...578server # [ 48.627631] systemd[1]: Starting Name Service Cache Daemon (nsncd)...579server # [ 48.681560] systemd[1]: Started Reset console on configuration changes.580server # [ 48.771476] systemd[1]: Starting resolvconf update...581server # [ 48.819295] systemd[1]: Starting D-Bus System Message Bus...582server # [ 49.955133] systemd[1]: Finished Import lastlog data into lastlog2 database.583server # [ 50.246141] nsncd[630]: Oct 22 15:12:41.880 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"584server # [ 50.279764] systemd[1]: Started Name Service Cache Daemon (nsncd).585server # [ 50.321545] systemd[1]: Reached target Host and Network Name Lookups.586server # [ 50.323361] systemd[1]: Reached target User and Group Name Lookups.587server # [ 50.377109] systemd[1]: Starting User Login Management...588server # [ 50.411753] dbus-daemon[633]: dbus[633]: Unknown username "systemd-timesync" in message bus configuration file589server # [ 50.897015] systemd[1]: Started D-Bus System Message Bus.590server # [ 51.858950] systemd[1]: Stopped target Host and Network Name Lookups.591server # [ 51.875205] systemd[1]: Stopping Host and Network Name Lookups...592server # [ 51.879273] systemd[1]: Stopped target User and Group Name Lookups.593server # [ 51.883349] systemd[1]: Stopping User and Group Name Lookups...594server # [ 51.887102] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...595server # [ 51.913721] systemd[1]: nscd.service: Deactivated successfully.596server # [ 51.931409] systemd[1]: Stopped Name Service Cache Daemon (nsncd).597server # [ 52.067547] systemd[1]: Starting Name Service Cache Daemon (nsncd)...598server # [ 52.289611] systemd-logind[652]: New seat seat0.599server # [ 52.350067] systemd[1]: Started User Login Management.600server # [ 52.427789] systemd[1]: Starting linger-users.service...601server # [ 53.098466] nsncd[690]: Oct 22 15:12:44.785 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"602server # [ 53.118602] systemd[1]: Started Name Service Cache Daemon (nsncd).603server # [ 53.129424] systemd[1]: Reached target Host and Network Name Lookups.604server # [ 53.142994] systemd[1]: Reached target User and Group Name Lookups.605server # [ 53.158668] systemd[1]: linger-users.service: Deactivated successfully.606server # [ 53.174500] systemd[1]: Finished linger-users.service.607server # [ 53.622380] systemd[1]: Finished resolvconf update.608server # [ 53.642863] systemd[1]: Reached target Preparation for Network.609server # [ 53.686122] systemd[1]: Starting DHCP Client...610server # [ 55.091476] dhcpcd[741]: dhcpcd-10.2.4 starting611server # [ 55.260984] dhcpcd[755]: dev: loaded udev612server # [ 55.835663] 8021q: 802.1Q VLAN Support v1.8613server # [ 56.334889] cfg80211: Loading compiled-in X.509 certificates for regulatory database614server # [ 56.574520] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'615server # [ 56.580681] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'616server # [ 56.618657] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2617server # [ 56.622362] cfg80211: failed to load regulatory.db618server # [ 57.067529] systemd[1]: Found device /dev/hvc0.619server # [ 57.556226] 8021q: adding VLAN 0 to HW filter on device eth0620server # [ 57.475628] dhcpcd[755]: eth0: waiting for carrier621server # [ 57.514839] dhcpcd[755]: eth0: carrier acquired622server # [ 57.623050] dhcpcd[755]: DUID 00:01:00:01:32:6c:e4:71:52:54:00:12:34:56623server # [ 57.627230] dhcpcd[755]: eth0: IAID 00:12:34:56624server # [ 57.629553] dhcpcd[755]: eth0: adding address fe80::5054:ff:fe12:3456625server # [ 58.225685] dhcpcd[755]: eth0: soliciting a DHCP lease626server # [ 58.257675] dhcpcd[755]: eth0: offered 10.0.2.15 from 10.0.2.2627server # [ 58.293033] dhcpcd[755]: eth0: probing address 10.0.2.15/24628server # [ 58.737280] systemd[1]: Found device /dev/ttyAMA0.629server # [ 58.779441] systemd[1]: Started backdoor.service.630server: Guest root shell did not produce any data yet...631server: To debug, enter the VM and run 'systemctl status backdoor.service'.632server # connecting to host...633server: Guest shell says: b'Spawning backdoor root shell...\n'634server: connected to guest root shell635server: (connecting took 60.50 seconds)636server: (finished: waiting for the VM to finish booting, in 60.50 seconds)637server # [ 59.831693] (udev-worker)[794]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.638server # [ 59.843277] (udev-worker)[794]: Network interface NamePolicy= disabled on kernel command line.639server # [ 59.854554] (udev-worker)[788]: Network interface NamePolicy= disabled on kernel command line.640server # [ 60.183319] dhcpcd[755]: eth0: soliciting an IPv6 router641server # [ 60.213514] dhcpcd[755]: eth0: Router Advertisement from fe80::2642server # [ 60.214755] dhcpcd[755]: eth0: adding address fec0::5054:ff:fe12:3456/64643server # [ 60.229248] dhcpcd[755]: eth0: adding route to fec0::/64644server # [ 60.231581] dhcpcd[755]: eth0: adding default route via fe80::2645server # [ 61.004199] dhcpcd[755]: eth0: IAID 00:12:34:56646server # [ 61.189560] systemd[1]: Found device Virtio network device.647server # [ 61.206136] systemd[1]: Starting Address configuration of eth1...648server # [ 61.371871] dhcpcd[755]: eth0: soliciting an IPv6 router649server # [ 61.843614] dhcpcd[755]: eth0: soliciting a DHCP lease650server # [ 61.848529] dhcpcd[755]: eth0: offered 10.0.2.15 from 10.0.2.2651server # [ 61.850721] dhcpcd[755]: eth0: probing address 10.0.2.15/24652server # [ 62.100626] 8021q: adding VLAN 0 to HW filter on device eth1653server # [ 62.272830] network-addresses-eth1-start[818]: adding address 192.168.1.1/24... done654server # [ 62.465368] network-addresses-eth1-start[818]: adding address 2001:db8:1::1/64... done655server # [ 62.791977] systemd[1]: Finished Address configuration of eth1.656server # [ 62.847398] systemd[1]: Starting Networking Setup...657server # [ 63.375177] dhcpcd[755]: eth0: leased 10.0.2.15 for 86400 seconds658server # [ 63.384990] dhcpcd[755]: eth0: adding route to 10.0.2.0/24659server # [ 63.394688] dhcpcd[755]: eth0: adding default route via 10.0.2.2660server # [ 64.151442] dhcpcd[861]: /nix/store/hsj50yr7hr62ql9xaynbihkhfhbgprcn-openresolv-3.17.0/sbin/.resolvconf-wrapped: line 1221: kill: (858) - Operation not permitted661server # [ 64.165653] dhcpcd[861]: clearing stale lock pid 858662server # [ 66.160139] systemd[1]: Stopped target Host and Network Name Lookups.663server # [ 66.204180] systemd[1]: Stopping Host and Network Name Lookups...664server # [ 66.258112] systemd[1]: Stopped target User and Group Name Lookups.665server # [ 66.263919] systemd[1]: Stopping User and Group Name Lookups...666server # [ 66.283264] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...667server # [ 66.322849] systemd[1]: nscd.service: Deactivated successfully.668server # [ 66.353425] systemd[1]: Stopped Name Service Cache Daemon (nsncd).669server # [ 66.516785] systemd[1]: Starting Name Service Cache Daemon (nsncd)...670server # [ 67.642482] systemd[1]: Started DHCP Client.671server # [ 67.741837] nsncd[943]: Oct 22 15:12:59.415 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"672server # [ 67.770143] systemd[1]: Started Name Service Cache Daemon (nsncd).673server # [ 67.772487] systemd[1]: Reached target Host and Network Name Lookups.674server # [ 67.784043] systemd[1]: Reached target User and Group Name Lookups.675server # [ 67.842039] systemd[1]: Finished Networking Setup.676server # [ 67.868069] systemd[1]: Reached target Network.677server # [ 67.909602] systemd[1]: Starting PostgreSQL Database Server...678server # [ 67.944605] systemd[1]: Starting Permit User Sessions...679server # [ 68.553840] systemd[1]: Finished Permit User Sessions.680server # [ 68.630793] systemd[1]: Started Getty on tty1.681server # [ 68.636264] systemd[1]: Reached target Login Prompts.682server # [ 69.147261] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[987]: Initializing database at /var/lib/postgresql/data683server # [ 71.257996] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: The files belonging to this database system will be owned by user "postgres".684server # [ 71.266797] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: This user must also own the server process.685server # [ 71.357064] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: The database cluster will be initialized with locale "en_US.UTF-8".686server # [ 71.358105] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: The default database encoding has accordingly been set to "UTF8".687server # [ 71.358752] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: The default text search configuration will be set to "english".688server # [ 71.365759] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: Data page checksums are enabled.689server # [ 71.366769] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: fixing permissions on existing directory /var/lib/postgresql/data ... ok690server # [ 71.377604] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: creating subdirectories ... ok691server # [ 71.390915] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: selecting dynamic shared memory implementation ... posix692server # [ 72.322171] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: selecting default max_connections ... 100693server # [ 73.301018] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: selecting default shared_buffers ... 128MB694server # [ 74.767599] systemd-logind[652]: Watching system buttons on /dev/input/event0 (gpio-keys)695server # [ 81.166201] mousedev: PS/2 mouse device common for all mice696server # [ 84.986803] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: selecting default time zone ... UTC697server # [ 85.014538] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: creating configuration files ... ok698server # [ 85.938513] systemd-logind[652]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)699server # [ 89.847595] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: running bootstrap script ... ok700server # [ 104.522851] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: performing post-bootstrap initialization ... ok701server # [ 107.786727] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: syncing data to disk ... ok702server # [ 107.788294] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: initdb: warning: enabling "trust" authentication for local connections703server # [ 107.796409] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: 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.704server # [ 107.804062] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: Success. You can now start the database server using:705server # [ 107.806752] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[988]: /nix/store/i45yhjwwac2d5ygyv0s5gbg2cgdjclf9-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start706server # [ 109.529774] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[987]: Validating PostgreSQL configuration...707server # [ 110.193100] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[1381]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault708server # [ 111.552375] postgres[1393]: 2026-10-22 15:13:43.255 UTC [1393] LOG: pgaudit extension initialized709server # [ 112.345846] postgres[1393]: 2026-10-22 15:13:44.056 UTC [1393] LOG: pgsodium primary server secret key loaded710server # [ 112.995037] postgres[1393]: 2026-10-22 15:13:44.698 UTC [1393] LOG: vault primary server secret key loaded711server # [ 113.801907] postgres[1393]: 2026-10-22 15:13:45.512 UTC [1393] LOG: starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit712server # [ 113.845170] postgres[1393]: 2026-10-22 15:13:45.553 UTC [1393] LOG: listening on IPv4 address "0.0.0.0", port 5432713server # [ 113.847605] postgres[1393]: 2026-10-22 15:13:45.557 UTC [1393] LOG: listening on IPv6 address "::", port 5432714server # [ 113.863927] postgres[1393]: 2026-10-22 15:13:45.575 UTC [1393] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"715server # [ 114.099542] postgres[1435]: 2026-10-22 15:13:45.798 UTC [1435] LOG: database system was shut down at 2026-10-22 15:13:36 UTC716server # [ 114.619646] postgres[1393]: 2026-10-22 15:13:46.325 UTC [1393] LOG: database system is ready to accept connections717server # [ 114.640325] postgres[1446]: 2026-10-22 15:13:46.347 UTC [1446] FATAL: role "postgres" does not exist718server # [ 114.754068] postgres[1444]: 2026-10-22 15:13:46.397 UTC [1444] LOG: TimescaleDB background worker launcher connected to shared catalogs719server # [ 114.782636] systemd[1]: Started PostgreSQL Database Server.720server # [ 114.795386] systemd[1]: Starting Supabase Database Initialization...721server # [ 114.947477] postgres[1393]: 2026-10-22 15:13:46.657 UTC [1393] LOG: background worker "pg_net 0.20.4 worker" (PID 1446) exited with exit code 1722server # [ 115.266388] postgres[1447]: 2026-10-22 15:13:46.956 UTC [1447] LOG: pg_cron scheduler started723server # [ 115.349789] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Waiting for PostgreSQL to be ready...724server # [ 115.903108] postgres[1454]: ::1 2026-10-22 15:13:47.587 UTC [1454] root@root FATAL: role "root" does not exist725server # [ 115.929971] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: PostgreSQL is ready726server # [ 115.937445] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Creating postgres role...727server # [ 116.026615] postgres[1455]: 2026-10-22 15:13:47.728 UTC [1455] FATAL: role "postgres" does not exist728server # [ 116.071363] postgres[1393]: 2026-10-22 15:13:47.772 UTC [1393] LOG: background worker "pg_net 0.20.4 worker" (PID 1455) exited with exit code 1729server # [ 116.451075] postgres[1457]: ::1 2026-10-22 15:13:48.138 UTC [1457] supabase_admin@postgres LOG: statement: CREATE ROLE postgres SUPERUSER LOGIN;730server # [ 116.512300] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1456]: CREATE ROLE731server # [ 117.090081] postgres[1471]: ::1 2026-10-22 15:13:48.775 UTC [1471] supabase_admin@postgres LOG: statement: ALTER DATABASE postgres OWNER TO postgres;732server # [ 117.135323] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1464]: ALTER DATABASE733server # [ 117.183474] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000000-initial-schema.sql734server # [ 117.689205] postgres[1480]: ::1 2026-10-22 15:13:49.372 UTC [1480] postgres@postgres LOG: statement: create publication supabase_realtime;735server # [ 117.729238] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: CREATE PUBLICATION736server # [ 117.731742] postgres[1480]: ::1 2026-10-22 15:13:49.438 UTC [1480] postgres@postgres LOG: statement: alter user supabase_admin with superuser createdb createrole replication bypassrls;737server # [ 117.738930] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: ALTER ROLE738server # [ 117.742720] postgres[1480]: ::1 2026-10-22 15:13:49.454 UTC [1480] postgres@postgres LOG: statement: create user supabase_replication_admin with login replication;739server # [ 117.759082] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: CREATE ROLE740server # [ 117.761891] postgres[1480]: ::1 2026-10-22 15:13:49.472 UTC [1480] postgres@postgres LOG: statement: create user supabase_etl_admin with login replication bypassrls;741server # [ 117.770847] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: CREATE ROLE742server # [ 117.774590] postgres[1480]: ::1 2026-10-22 15:13:49.486 UTC [1480] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_etl_admin;743server # [ 117.797509] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: GRANT ROLE744server # [ 117.798632] postgres[1480]: ::1 2026-10-22 15:13:49.510 UTC [1480] postgres@postgres LOG: statement: grant create on database postgres to supabase_etl_admin;745server # [ 117.813116] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: GRANT746server # [ 117.816171] postgres[1480]: ::1 2026-10-22 15:13:49.525 UTC [1480] postgres@postgres LOG: statement: create role supabase_read_only_user with login bypassrls;747server # [ 117.831844] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: CREATE ROLE748server # [ 117.834189] postgres[1480]: ::1 2026-10-22 15:13:49.541 UTC [1480] postgres@postgres LOG: statement: grant pg_read_all_data to supabase_read_only_user;749server # [ 117.844129] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: GRANT ROLE750server # [ 117.847694] postgres[1480]: ::1 2026-10-22 15:13:49.559 UTC [1480] postgres@postgres LOG: statement: create schema if not exists extensions;751server # [ 117.863653] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: CREATE SCHEMA752server # [ 117.874340] postgres[1480]: ::1 2026-10-22 15:13:49.585 UTC [1480] postgres@postgres LOG: statement: create extension if not exists "uuid-ossp" with schema extensions;753server # [ 120.655096] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: CREATE EXTENSION754server # [ 120.679280] postgres[1480]: ::1 2026-10-22 15:13:52.362 UTC [1480] postgres@postgres LOG: statement: create extension if not exists pgcrypto with schema extensions;755server # [ 121.816239] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: CREATE EXTENSION756server # [ 121.831495] postgres[1480]: ::1 2026-10-22 15:13:53.529 UTC [1480] postgres@postgres LOG: statement: create role anon nologin noinherit;757server # [ 121.834377] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: CREATE ROLE758server # [ 121.841567] postgres[1480]: ::1 2026-10-22 15:13:53.547 UTC [1480] postgres@postgres LOG: statement: create role authenticated nologin noinherit;759server # [ 121.850099] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: CREATE ROLE760server # [ 121.851426] postgres[1480]: ::1 2026-10-22 15:13:53.559 UTC [1480] postgres@postgres LOG: statement: create role service_role nologin noinherit bypassrls;761server # [ 121.857100] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: CREATE ROLE762server # [ 121.859590] postgres[1480]: ::1 2026-10-22 15:13:53.571 UTC [1480] postgres@postgres LOG: statement: create user authenticator noinherit;763server # [ 121.867555] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: CREATE ROLE764server # [ 121.870214] postgres[1480]: ::1 2026-10-22 15:13:53.581 UTC [1480] postgres@postgres LOG: statement: grant anon to authenticator;765server # [ 121.879155] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: GRANT ROLE766server # [ 121.883163] postgres[1480]: ::1 2026-10-22 15:13:53.591 UTC [1480] postgres@postgres LOG: statement: grant authenticated to authenticator;767server # [ 121.888754] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: GRANT ROLE768server # [ 121.896323] postgres[1480]: ::1 2026-10-22 15:13:53.602 UTC [1480] postgres@postgres LOG: statement: grant service_role to authenticator;769server # [ 121.901068] postgres[1480]: ::1 2026-10-22 15:13:53.611 UTC [1480] postgres@postgres LOG: statement: grant supabase_admin to authenticator;770server # [ 121.902801] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: GRANT ROLE771server # [ 121.910832] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: GRANT ROLE772server # [ 121.913681] postgres[1480]: ::1 2026-10-22 15:13:53.624 UTC [1480] postgres@postgres LOG: statement: grant usage on schema public to postgres, anon, authenticated, service_role;773server # [ 121.920013] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: GRANT774server # [ 121.923218] postgres[1480]: ::1 2026-10-22 15:13:53.634 UTC [1480] postgres@postgres LOG: statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;775server # [ 121.938349] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: ALTER DEFAULT PRIVILEGES776server # [ 121.944027] postgres[1480]: ::1 2026-10-22 15:13:53.653 UTC [1480] postgres@postgres LOG: statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;777server # [ 121.951220] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: ALTER DEFAULT PRIVILEGES778server # [ 121.955267] postgres[1480]: ::1 2026-10-22 15:13:53.666 UTC [1480] postgres@postgres LOG: statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;779server # [ 121.963663] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: ALTER DEFAULT PRIVILEGES780server # [ 121.966758] postgres[1480]: ::1 2026-10-22 15:13:53.678 UTC [1480] postgres@postgres LOG: statement: grant usage on schema extensions to postgres, anon, authenticated, service_role;781server # [ 121.974196] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: GRANT782server # [ 121.975054] postgres[1480]: ::1 2026-10-22 15:13:53.686 UTC [1480] postgres@postgres LOG: statement: alter user supabase_admin SET search_path TO public, extensions;783server # [ 121.984134] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: ALTER ROLE784server # [ 121.989691] postgres[1480]: ::1 2026-10-22 15:13:53.698 UTC [1480] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all785server # [ 121.991301] postgres[1480]: on sequences to postgres, anon, authenticated, service_role;786server # [ 122.002006] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: ALTER DEFAULT PRIVILEGES787server # [ 122.004307] postgres[1480]: ::1 2026-10-22 15:13:53.710 UTC [1480] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all788server # [ 122.007042] postgres[1480]: on tables to postgres, anon, authenticated, service_role;789server # [ 122.014878] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: ALTER DEFAULT PRIVILEGES790server # [ 122.017614] postgres[1480]: ::1 2026-10-22 15:13:53.725 UTC [1480] postgres@postgres LOG: statement: alter default privileges for user supabase_admin in schema public grant all791server # [ 122.019256] postgres[1480]: on functions to postgres, anon, authenticated, service_role;792server # [ 122.025965] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: ALTER DEFAULT PRIVILEGES793server # [ 122.028157] postgres[1480]: ::1 2026-10-22 15:13:53.740 UTC [1480] postgres@postgres LOG: statement: alter role anon set statement_timeout = '3s';794server # [ 122.039095] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: ALTER ROLE795server # [ 122.042653] postgres[1480]: ::1 2026-10-22 15:13:53.753 UTC [1480] postgres@postgres LOG: statement: alter role authenticated set statement_timeout = '8s';796server # [ 122.050812] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1477]: ALTER ROLE797server # [ 122.088066] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000001-auth-schema.sql798server # [ 122.370890] postgres[1516]: ::1 2026-10-22 15:13:54.074 UTC [1516] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;799server # [ 122.389631] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE SCHEMA800server # [ 122.391831] postgres[1516]: ::1 2026-10-22 15:13:54.097 UTC [1516] postgres@postgres LOG: statement: CREATE TABLE auth.users (801server # [ 122.396023] postgres[1516]: instance_id uuid NULL,802server # [ 122.398999] postgres[1516]: id uuid NOT NULL UNIQUE,803server # [ 122.399502] postgres[1516]: aud varchar(255) NULL,804server # [ 122.400328] postgres[1516]: "role" varchar(255) NULL,805server # [ 122.401732] postgres[1516]: email varchar(255) NULL UNIQUE,806server # [ 122.402212] postgres[1516]: encrypted_password varchar(255) NULL,807server # [ 122.402809] postgres[1516]: confirmed_at timestamptz NULL,808server # [ 122.405666] postgres[1516]: invited_at timestamptz NULL,809server # [ 122.406553] postgres[1516]: confirmation_token varchar(255) NULL,810server # [ 122.406888] postgres[1516]: confirmation_sent_at timestamptz NULL,811server # [ 122.407598] postgres[1516]: recovery_token varchar(255) NULL,812server # [ 122.409182] postgres[1516]: recovery_sent_at timestamptz NULL,813server # [ 122.409923] postgres[1516]: email_change_token varchar(255) NULL,814server # [ 122.410496] postgres[1516]: email_change varchar(255) NULL,815server # [ 122.410942] postgres[1516]: email_change_sent_at timestamptz NULL,816server # [ 122.413636] postgres[1516]: last_sign_in_at timestamptz NULL,817server # [ 122.414122] postgres[1516]: raw_app_meta_data jsonb NULL,818server # [ 122.414378] postgres[1516]: raw_user_meta_data jsonb NULL,819server # [ 122.414733] postgres[1516]: is_super_admin bool NULL,820server # [ 122.414991] postgres[1516]: created_at timestamptz NULL,821server # [ 122.416825] postgres[1516]: updated_at timestamptz NULL,822server # [ 122.418758] postgres[1516]: CONSTRAINT users_pkey PRIMARY KEY (id)823server # [ 122.419372] postgres[1516]: );824server # [ 122.534745] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE TABLE825server # [ 122.542273] postgres[1516]: ::1 2026-10-22 15:13:54.251 UTC [1516] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);826server # [ 122.575420] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE INDEX827server # [ 122.582148] postgres[1516]: ::1 2026-10-22 15:13:54.286 UTC [1516] postgres@postgres LOG: statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);828server # [ 122.605723] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE INDEX829server # [ 122.606938] postgres[1516]: ::1 2026-10-22 15:13:54.318 UTC [1516] postgres@postgres LOG: statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';830server # [ 122.617497] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: COMMENT831server # [ 122.622066] postgres[1516]: ::1 2026-10-22 15:13:54.327 UTC [1516] postgres@postgres LOG: statement: CREATE TABLE auth.refresh_tokens (832server # [ 122.623357] postgres[1516]: instance_id uuid NULL,833server # [ 122.623697] postgres[1516]: id bigserial NOT NULL,834server # [ 122.624079] postgres[1516]: "token" varchar(255) NULL,835server # [ 122.628917] postgres[1516]: user_id varchar(255) NULL,836server # [ 122.630297] postgres[1516]: revoked bool NULL,837server # [ 122.630922] postgres[1516]: created_at timestamptz NULL,838server # [ 122.631481] postgres[1516]: updated_at timestamptz NULL,839server # [ 122.632056] postgres[1516]: CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)840server # [ 122.633728] postgres[1516]: );841server # [ 122.719476] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE TABLE842server # [ 122.722175] postgres[1516]: ::1 2026-10-22 15:13:54.428 UTC [1516] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);843server # [ 122.758925] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE INDEX844server # [ 122.770664] postgres[1516]: ::1 2026-10-22 15:13:54.479 UTC [1516] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_instance_id_user_id_idx ON auth.refresh_tokens USING btree (instance_id, user_id);845server # [ 122.824965] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE INDEX846server # [ 122.835174] postgres[1516]: ::1 2026-10-22 15:13:54.541 UTC [1516] postgres@postgres LOG: statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);847server # [ 122.903592] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE INDEX848server # [ 122.910670] postgres[1516]: ::1 2026-10-22 15:13:54.612 UTC [1516] postgres@postgres LOG: statement: comment on table auth.refresh_tokens is 'Auth: Store of tokens used to refresh JWT tokens once they expire.';849server # [ 122.926392] postgres[1516]: ::1 2026-10-22 15:13:54.633 UTC [1516] postgres@postgres LOG: statement: CREATE TABLE auth.instances (850server # [ 122.931887] postgres[1516]: id uuid NOT NULL,851server # [ 122.941640] postgres[1516]: uuid uuid NULL,852server # [ 122.942288] postgres[1516]: raw_base_config text NULL,853server # [ 122.942822] postgres[1516]: created_at timestamptz NULL,854server # [ 122.944012] postgres[1516]: updated_at timestamptz NULL,855server # [ 122.962737] postgres[1516]: CONSTRAINT instances_pkey PRIMARY KEY (id)856server # [ 122.970114] postgres[1516]: );857server # [ 122.991189] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: COMMENT858server # [ 123.104816] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE TABLE859server # [ 123.106384] postgres[1516]: ::1 2026-10-22 15:13:54.814 UTC [1516] postgres@postgres LOG: statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';860server # [ 123.137153] postgres[1516]: ::1 2026-10-22 15:13:54.834 UTC [1516] postgres@postgres LOG: statement: CREATE TABLE auth.audit_log_entries (861server # [ 123.139120] postgres[1516]: instance_id uuid NULL,862server # [ 123.145683] postgres[1516]: id uuid NOT NULL,863server # [ 123.146754] postgres[1516]: payload json NULL,864server # [ 123.147141] postgres[1516]: created_at timestamptz NULL,865server # [ 123.147443] postgres[1516]: CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)866server # [ 123.158312] postgres[1516]: );867server # [ 123.175506] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: COMMENT868server # [ 123.248964] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE TABLE869server # [ 123.250470] postgres[1516]: ::1 2026-10-22 15:13:54.961 UTC [1516] postgres@postgres LOG: statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);870server # [ 123.308238] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE INDEX871server # [ 123.314041] postgres[1516]: ::1 2026-10-22 15:13:55.023 UTC [1516] postgres@postgres LOG: statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';872server # [ 123.328917] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: COMMENT873server # [ 123.334138] postgres[1516]: ::1 2026-10-22 15:13:55.040 UTC [1516] postgres@postgres LOG: statement: CREATE TABLE auth.schema_migrations (874server # [ 123.335202] postgres[1516]: "version" varchar(255) NOT NULL,875server # [ 123.336914] postgres[1516]: CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")876server # [ 123.337676] postgres[1516]: );877server # [ 123.409836] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE TABLE878server # [ 123.411779] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: COMMENT879server # [ 123.435887] postgres[1516]: ::1 2026-10-22 15:13:55.106 UTC [1516] postgres@postgres LOG: statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';880server # [ 123.494348] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: INSERT 0 7881server # [ 123.495384] postgres[1516]: ::1 2026-10-22 15:13:55.206 UTC [1516] postgres@postgres LOG: statement: create or replace function auth.uid() returns uuid as $$882server # [ 123.496205] postgres[1516]: select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;883server # [ 123.503510] postgres[1516]: $$ language sql stable;884server # [ 123.521046] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE FUNCTION885server # [ 123.524019] postgres[1516]: ::1 2026-10-22 15:13:55.231 UTC [1516] postgres@postgres LOG: statement: create or replace function auth.role() returns text as $$886server # [ 123.534668] postgres[1516]: select nullif(current_setting('request.jwt.claim.role', true), '')::text;887server # [ 123.551602] postgres[1516]: $$ language sql stable;888server # [ 123.552526] postgres[1516]: ::1 2026-10-22 15:13:55.263 UTC [1516] postgres@postgres LOG: statement: create or replace function auth.email() returns text as $$889server # [ 123.557038] postgres[1516]: select nullif(current_setting('request.jwt.claim.email', true), '')::text;890server # [ 123.558598] postgres[1516]: $$ language sql stable;891server # [ 123.559125] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE FUNCTION892server # [ 123.566454] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE FUNCTION893server # [ 123.567799] postgres[1516]: ::1 2026-10-22 15:13:55.278 UTC [1516] postgres@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;894server # [ 123.587252] postgres[1516]: ::1 2026-10-22 15:13:55.291 UTC [1516] postgres@postgres LOG: statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;895server # [ 123.588358] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: GRANT896server # [ 123.588728] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: CREATE ROLE897server # [ 123.589075] postgres[1516]: ::1 2026-10-22 15:13:55.300 UTC [1516] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;898server # [ 123.602417] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: GRANT899server # [ 123.611512] postgres[1516]: ::1 2026-10-22 15:13:55.317 UTC [1516] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;900server # [ 123.626547] postgres[1516]: ::1 2026-10-22 15:13:55.336 UTC [1516] postgres@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;901server # [ 123.627326] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: GRANT902server # [ 123.645507] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: GRANT903server # [ 123.653012] postgres[1516]: ::1 2026-10-22 15:13:55.353 UTC [1516] postgres@postgres LOG: statement: ALTER USER supabase_auth_admin SET search_path = "auth";904server # [ 123.654402] postgres[1516]: ::1 2026-10-22 15:13:55.363 UTC [1516] postgres@postgres LOG: statement: ALTER table "auth".users OWNER TO supabase_auth_admin;905server # [ 123.654942] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: ALTER ROLE906server # [ 123.676048] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: ALTER TABLE907server # [ 123.678389] postgres[1516]: ::1 2026-10-22 15:13:55.383 UTC [1516] postgres@postgres LOG: statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;908server # [ 123.698992] postgres[1516]: ::1 2026-10-22 15:13:55.395 UTC [1516] postgres@postgres LOG: statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;909server # [ 123.703584] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: ALTER TABLE910server # [ 123.713752] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: ALTER TABLE911server # [ 123.714548] postgres[1516]: ::1 2026-10-22 15:13:55.413 UTC [1516] postgres@postgres LOG: statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;912server # [ 123.714991] postgres[1516]: ::1 2026-10-22 15:13:55.426 UTC [1516] postgres@postgres LOG: statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;913server # [ 123.716008] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: ALTER TABLE914server # [ 123.742538] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1515]: ALTER TABLE915server # [ 123.837265] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000002-storage-schema.sql916server # [ 124.301937] postgres[1542]: ::1 2026-10-22 15:13:56.009 UTC [1542] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;917server # [ 124.317851] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1536]: CREATE SCHEMA918server # [ 124.319174] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1536]: CREATE ROLE919server # [ 124.319959] postgres[1542]: ::1 2026-10-22 15:13:56.021 UTC [1542] postgres@postgres LOG: statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;920server # [ 124.322777] postgres[1542]: ::1 2026-10-22 15:13:56.033 UTC [1542] postgres@postgres LOG: statement: ALTER USER supabase_storage_admin SET search_path = "storage";921server # [ 124.331038] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1536]: ALTER ROLE922server # [ 124.331939] postgres[1542]: ::1 2026-10-22 15:13:56.043 UTC [1542] postgres@postgres LOG: statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;923server # [ 124.343232] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1536]: GRANT924server # [ 124.380543] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1536]: DO925server # [ 124.423951] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running init-script: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/init-scripts/00000000000003-post-setup.sql926server # [ 124.697291] postgres[1544]: ::1 2026-10-22 15:13:56.402 UTC [1544] postgres@postgres LOG: statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;927server # [ 124.714884] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: ALTER ROLE928server # [ 124.717165] postgres[1544]: ::1 2026-10-22 15:13:56.422 UTC [1544] postgres@postgres LOG: statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;929server # [ 124.720169] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: ALTER ROLE930server # [ 124.723580] postgres[1544]: ::1 2026-10-22 15:13:56.435 UTC [1544] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()931server # [ 124.725656] postgres[1544]: RETURNS event_trigger932server # [ 124.726311] postgres[1544]: LANGUAGE plpgsql933server # [ 124.726640] postgres[1544]: AS $$934server # [ 124.727508] postgres[1544]: DECLARE935server # [ 124.733804] postgres[1544]: schema_is_cron bool;936server # [ 124.734712] postgres[1544]: BEGIN937server # [ 124.735602] postgres[1544]: schema_is_cron = (938server # [ 124.735994] postgres[1544]: SELECT n.nspname = 'cron'939server # [ 124.737073] postgres[1544]: FROM pg_event_trigger_ddl_commands() AS ev940server # [ 124.738422] postgres[1544]: LEFT JOIN pg_catalog.pg_namespace AS n941server # [ 124.739140] postgres[1544]: ON ev.objid = n.oid942server # [ 124.739427] postgres[1544]: );943server # [ 124.740002] postgres[1544]:944server # [ 124.744404] postgres[1544]: IF schema_is_cron945server # [ 124.744895] postgres[1544]: THEN946server # [ 124.753879] postgres[1544]: grant usage on schema cron to postgres with grant option;947server # [ 124.754680] postgres[1544]:948server # [ 124.755120] postgres[1544]: alter default privileges in schema cron grant all on tables to postgres with grant option;949server # [ 124.755432] postgres[1544]: alter default privileges in schema cron grant all on functions to postgres with grant option;950server # [ 124.755871] postgres[1544]: alter default privileges in schema cron grant all on sequences to postgres with grant option;951server # [ 124.761469] postgres[1544]:952server # [ 124.761939] postgres[1544]: alter default privileges for user supabase_admin in schema cron grant all953server # [ 124.762684] postgres[1544]: on sequences to postgres with grant option;954server # [ 124.763375] postgres[1544]: alter default privileges for user supabase_admin in schema cron grant all955server # [ 124.763720] postgres[1544]: on tables to postgres with grant option;956server # [ 124.765014] postgres[1544]: alter default privileges for user supabase_admin in schema cron grant all957server # [ 124.765728] postgres[1544]: on functions to postgres with grant option;958server # [ 124.766834] postgres[1544]:959server # [ 124.767135] postgres[1544]: grant all privileges on all tables in schema cron to postgres with grant option;960server # [ 124.767445] postgres[1544]:961server # [ 124.768023] postgres[1544]: END IF;962server # [ 124.768274] postgres[1544]:963server # [ 124.773889] postgres[1544]: END;964server # [ 124.774218] postgres[1544]: $$;965server # [ 124.774627] postgres[1544]: ::1 2026-10-22 15:13:56.474 UTC [1544] postgres@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')966server # [ 124.777281] postgres[1544]: EXECUTE PROCEDURE extensions.grant_pg_cron_access();967server # [ 124.778719] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: CREATE FUNCTION968server # [ 124.782881] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: CREATE EVENT TRIGGER969server # [ 124.785608] postgres[1544]: ::1 2026-10-22 15:13:56.497 UTC [1544] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';970server # [ 124.794709] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: COMMENT971server # [ 124.797738] postgres[1544]: ::1 2026-10-22 15:13:56.509 UTC [1544] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()972server # [ 124.798810] postgres[1544]: RETURNS event_trigger973server # [ 124.799957] postgres[1544]: LANGUAGE plpgsql974server # [ 124.800395] postgres[1544]: AS $$975server # [ 124.805092] postgres[1544]: BEGIN976server # [ 124.806121] postgres[1544]: IF EXISTS (977server # [ 124.806480] postgres[1544]: SELECT 1978server # [ 124.807581] postgres[1544]: FROM pg_event_trigger_ddl_commands() AS ev979server # [ 124.810544] postgres[1544]: JOIN pg_extension AS ext980server # [ 124.822109] postgres[1544]: ON ev.objid = ext.oid981server # [ 124.823133] postgres[1544]: WHERE ext.extname = 'pg_net'982server # [ 124.824199] postgres[1544]: )983server # [ 124.827324] postgres[1544]: THEN984server # [ 124.830681] postgres[1544]: IF NOT EXISTS (985server # [ 124.831491] postgres[1544]: SELECT 1986server # [ 124.832791] postgres[1544]: FROM pg_roles987server # [ 124.834228] postgres[1544]: WHERE rolname = 'supabase_functions_admin'988server # [ 124.835306] postgres[1544]: )989server # [ 124.835972] postgres[1544]: THEN990server # [ 124.837649] postgres[1544]: CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;991server # [ 124.838211] postgres[1544]: END IF;992server # [ 124.839622] postgres[1544]:993server # [ 124.840013] postgres[1544]: GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;994server # [ 124.841832] postgres[1544]:995server # [ 124.842601] postgres[1544]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;996server # [ 124.846986] postgres[1544]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;997server # [ 124.849620] postgres[1544]:998server # [ 124.850105] postgres[1544]: ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;999server # [ 124.851365] postgres[1544]: ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1000server # [ 124.853108] postgres[1544]:1001server # [ 124.853707] postgres[1544]: REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1002server # [ 124.855535] postgres[1544]: REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1003server # [ 124.856039] postgres[1544]:1004server # [ 124.857658] postgres[1544]: 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;1005server # [ 124.858349] postgres[1544]: 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;1006server # [ 124.859037] postgres[1544]: END IF;1007server # [ 124.860168] postgres[1544]: END;1008server # [ 124.863086] postgres[1544]: $$;1009server # [ 124.863700] postgres[1544]: ::1 2026-10-22 15:13:56.527 UTC [1544] postgres@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';1010server # [ 124.866747] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: CREATE FUNCTION1011server # [ 124.867326] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: COMMENT1012server # [ 124.867928] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: DO1013server # [ 124.875038] postgres[1544]: ::1 2026-10-22 15:13:56.582 UTC [1544] postgres@postgres LOG: statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;1014server # [ 124.882709] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: CREATE ROLE1015server # [ 124.886005] postgres[1544]: ::1 2026-10-22 15:13:56.597 UTC [1544] postgres@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO dashboard_user;1016server # [ 124.895169] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: GRANT1017server # [ 124.897769] postgres[1544]: ::1 2026-10-22 15:13:56.609 UTC [1544] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO dashboard_user;1018server # [ 124.905945] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: GRANT1019server # [ 124.911206] postgres[1544]: ::1 2026-10-22 15:13:56.620 UTC [1544] postgres@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;1020server # [ 124.916939] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: GRANT1021server # [ 124.923293] postgres[1544]: ::1 2026-10-22 15:13:56.630 UTC [1544] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;1022server # [ 124.930804] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: GRANT1023server # [ 124.935490] postgres[1544]: ::1 2026-10-22 15:13:56.646 UTC [1544] postgres@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;1024server # [ 124.940142] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: GRANT1025server # [ 124.943973] postgres[1544]: ::1 2026-10-22 15:13:56.651 UTC [1544] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;1026server # [ 124.954649] postgres[1544]: ::1 2026-10-22 15:13:56.664 UTC [1544] postgres@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;1027server # [ 124.956466] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: GRANT1028server # [ 124.963494] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: GRANT1029server # [ 124.966717] postgres[1544]: ::1 2026-10-22 15:13:56.672 UTC [1544] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;1030server # [ 124.986368] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: GRANT1031server # [ 124.987618] postgres[1544]: ::1 2026-10-22 15:13:56.698 UTC [1544] postgres@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;1032server # [ 125.071496] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: GRANT1033server # [ 125.101912] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1543]: DO1034server # [ 125.182015] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running pgbouncer auth schema...1035server # [ 125.524781] postgres[1550]: ::1 2026-10-22 15:13:57.224 UTC [1550] postgres@postgres LOG: statement: CREATE USER pgbouncer;1036server # [ 125.554269] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1548]: CREATE ROLE1037server # [ 125.561695] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1548]: REVOKE1038server # [ 125.563454] postgres[1550]: ::1 2026-10-22 15:13:57.246 UTC [1550] postgres@postgres LOG: statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;1039server # [ 125.570703] postgres[1550]: ::1 2026-10-22 15:13:57.272 UTC [1550] postgres@postgres LOG: statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;1040server # [ 125.655254] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1548]: CREATE SCHEMA1041server # [ 125.661980] postgres[1550]: ::1 2026-10-22 15:13:57.371 UTC [1550] postgres@postgres LOG: statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)1042server # [ 125.663233] postgres[1550]: RETURNS TABLE(username TEXT, password TEXT) AS1043server # [ 125.664347] postgres[1550]: $$1044server # [ 125.669658] postgres[1550]: BEGIN1045server # [ 125.670516] postgres[1550]: RAISE WARNING 'PgBouncer auth request: %', p_usename;1046server # [ 125.671698] postgres[1550]:1047server # [ 125.680019] postgres[1550]: RETURN QUERY1048server # [ 125.681832] postgres[1550]: SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow1049server # [ 125.683273] postgres[1550]: WHERE usename = p_usename;1050server # [ 125.683742] postgres[1550]: END;1051server # [ 125.684010] postgres[1550]: $$ LANGUAGE plpgsql1052server # [ 125.684267] postgres[1550]: SET search_path = ''1053server # [ 125.686893] postgres[1550]: SECURITY DEFINER;1054server # [ 125.694697] postgres[1550]: ::1 2026-10-22 15:13:57.404 UTC [1550] postgres@postgres LOG: statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;1055server # [ 125.695994] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1548]: CREATE FUNCTION1056server # [ 125.708099] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1548]: REVOKE1057server # [ 125.709097] postgres[1550]: ::1 2026-10-22 15:13:57.418 UTC [1550] postgres@postgres LOG: statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;1058server # [ 125.721734] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1548]: GRANT1059server # [ 125.754546] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running stat extension...1060server # [ 126.271661] postgres[1555]: ::1 2026-10-22 15:13:57.975 UTC [1555] postgres@postgres LOG: statement: CREATE SCHEMA IF NOT exists extensions;1061server # [ 126.283587] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1551]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE: schema "extensions" already exists, skipping1062server # [ 126.318719] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1551]: CREATE SCHEMA1063server # [ 126.320685] postgres[1555]: ::1 2026-10-22 15:13:58.032 UTC [1555] postgres@postgres LOG: statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;1064server # [ 127.722288] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1551]: CREATE EXTENSION1065server # [ 127.812076] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/10000000000000_demote-postgres.sql1066server # [ 128.060034] postgres[1578]: ::1 2026-10-22 15:13:59.764 UTC [1578] supabase_admin@postgres LOG: statement: GRANT ALL ON DATABASE postgres TO postgres;1067server # [ 128.074760] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1577]: GRANT1068server # [ 128.076015] postgres[1578]: ::1 2026-10-22 15:13:59.781 UTC [1578] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA auth TO postgres;1069server # [ 128.089831] postgres[1578]: ::1 2026-10-22 15:13:59.798 UTC [1578] supabase_admin@postgres LOG: statement: GRANT ALL ON SCHEMA extensions TO postgres;1070server # [ 128.091664] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1577]: GRANT1071server # [ 128.092459] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1577]: GRANT1072server # [ 128.094733] postgres[1578]: ::1 2026-10-22 15:13:59.806 UTC [1578] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;1073server # [ 128.113136] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1577]: GRANT1074server # [ 128.114501] postgres[1578]: ::1 2026-10-22 15:13:59.825 UTC [1578] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;1075server # [ 128.125625] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1577]: GRANT1076server # [ 128.130306] postgres[1578]: ::1 2026-10-22 15:13:59.840 UTC [1578] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;1077server # [ 128.147348] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1577]: GRANT1078server # [ 128.151774] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1577]: GRANT1079server # [ 128.153874] postgres[1578]: ::1 2026-10-22 15:13:59.854 UTC [1578] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;1080server # [ 128.154823] postgres[1578]: ::1 2026-10-22 15:13:59.861 UTC [1578] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;1081server # [ 128.162885] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1577]: GRANT1082server # [ 128.169161] postgres[1578]: ::1 2026-10-22 15:13:59.876 UTC [1578] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;1083server # [ 128.199104] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1577]: GRANT1084server # [ 128.219265] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1577]: DO1085server # [ 128.225213] postgres[1578]: ::1 2026-10-22 15:13:59.934 UTC [1578] supabase_admin@postgres LOG: statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;1086server # [ 128.230447] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1577]: ALTER ROLE1087server # [ 128.263613] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211115181400_update-auth-permissions.sql1088server # [ 128.533529] postgres[1580]: ::1 2026-10-22 15:14:00.239 UTC [1580] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1089server # [ 128.556083] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: GRANT1090server # [ 128.559885] postgres[1580]: ::1 2026-10-22 15:14:00.265 UTC [1580] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1091server # [ 128.570046] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: GRANT1092server # [ 128.579784] postgres[1580]: ::1 2026-10-22 15:14:00.284 UTC [1580] supabase_admin@postgres LOG: statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1093server # [ 128.583529] postgres[1580]: ::1 2026-10-22 15:14:00.291 UTC [1580] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;1094server # [ 128.587408] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: GRANT1095server # [ 128.595477] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: ALTER TABLE1096server # [ 128.597771] postgres[1580]: ::1 2026-10-22 15:14:00.309 UTC [1580] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;1097server # [ 128.607047] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: ALTER TABLE1098server # [ 128.614423] postgres[1580]: ::1 2026-10-22 15:14:00.324 UTC [1580] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;1099server # [ 128.630694] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: ALTER TABLE1100server # [ 128.639007] postgres[1580]: ::1 2026-10-22 15:14:00.347 UTC [1580] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;1101server # [ 128.658622] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: ALTER TABLE1102server # [ 128.666437] postgres[1580]: ::1 2026-10-22 15:14:00.373 UTC [1580] supabase_admin@postgres LOG: statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;1103server # [ 128.673080] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: ALTER TABLE1104server # [ 128.677283] postgres[1580]: ::1 2026-10-22 15:14:00.388 UTC [1580] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA auth TO postgres;1105server # [ 128.684855] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: GRANT1106server # [ 128.690838] postgres[1580]: ::1 2026-10-22 15:14:00.400 UTC [1580] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;1107server # [ 128.699155] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: GRANT1108server # [ 128.706442] postgres[1580]: ::1 2026-10-22 15:14:00.414 UTC [1580] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;1109server # [ 128.714940] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: GRANT1110server # [ 128.719754] postgres[1580]: ::1 2026-10-22 15:14:00.430 UTC [1580] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;1111server # [ 128.734503] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: GRANT1112server # [ 128.737979] postgres[1580]: ::1 2026-10-22 15:14:00.445 UTC [1580] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON TABLES TO postgres, dashboard_user;1113server # [ 128.762913] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: ALTER DEFAULT PRIVILEGES1114server # [ 128.766029] postgres[1580]: ::1 2026-10-22 15:14:00.473 UTC [1580] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1115server # [ 128.776966] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: ALTER DEFAULT PRIVILEGES1116server # [ 128.778459] postgres[1580]: ::1 2026-10-22 15:14:00.490 UTC [1580] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_auth_admin IN SCHEMA auth GRANT ALL ON ROUTINES TO postgres, dashboard_user;1117server # [ 128.794676] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1579]: ALTER DEFAULT PRIVILEGES1118server # [ 128.870412] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211118015519_create-realtime-schema.sql1119server # [ 129.308125] postgres[1590]: ::1 2026-10-22 15:14:00.996 UTC [1590] supabase_admin@postgres LOG: statement: CREATE SCHEMA IF NOT EXISTS realtime;1120server # [ 129.361419] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1583]: CREATE SCHEMA1121server # [ 129.411777] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211122051245_update-realtime-permissions.sql1122server # [ 129.835354] postgres[1597]: ::1 2026-10-22 15:14:01.534 UTC [1597] supabase_admin@postgres LOG: statement: GRANT USAGE ON SCHEMA realtime TO postgres;1123server # [ 129.859252] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1595]: GRANT1124server # [ 129.866302] postgres[1597]: ::1 2026-10-22 15:14:01.567 UTC [1597] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;1125server # [ 129.867460] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1595]: GRANT1126server # [ 129.872016] postgres[1597]: ::1 2026-10-22 15:14:01.582 UTC [1597] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;1127server # [ 129.875319] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1595]: GRANT1128server # [ 129.878894] postgres[1597]: ::1 2026-10-22 15:14:01.589 UTC [1597] supabase_admin@postgres LOG: statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;1129server # [ 129.899501] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1595]: GRANT1130server # [ 129.971686] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211124212715_update-auth-owner.sql1131server # [ 130.518783] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1601]: DO1132server # [ 130.524732] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1601]: DO1133server # [ 130.534984] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1601]: DO1134server # [ 130.573415] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20211130151719_update-realtime-permissions.sql1135server # [ 130.960469] postgres[1612]: ::1 2026-10-22 15:14:02.658 UTC [1612] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON TABLES TO postgres, dashboard_user;1136server # [ 131.016521] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1611]: ALTER DEFAULT PRIVILEGES1137server # [ 131.018973] postgres[1612]: ::1 2026-10-22 15:14:02.721 UTC [1612] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON SEQUENCES TO postgres, dashboard_user;1138server # [ 131.025437] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1611]: ALTER DEFAULT PRIVILEGES1139server # [ 131.026463] postgres[1612]: ::1 2026-10-22 15:14:02.735 UTC [1612] supabase_admin@postgres LOG: statement: ALTER DEFAULT PRIVILEGES FOR ROLE supabase_admin IN SCHEMA realtime GRANT ALL ON ROUTINES TO postgres, dashboard_user;1140server # [ 131.039693] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1611]: ALTER DEFAULT PRIVILEGES1141server # [ 131.111045] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql1142server # [ 131.448039] postgres[1618]: ::1 2026-10-22 15:14:03.152 UTC [1618] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';1143server # [ 131.511544] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1617]: ALTER ROLE1144server # [ 131.520324] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql1145server # [ 131.828129] postgres[1620]: ::1 2026-10-22 15:14:03.534 UTC [1620] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1146server # [ 131.841595] postgres[1620]: ::1 2026-10-22 15:14:03.547 UTC [1620] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1147server # [ 131.858571] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1148server # [ 131.861155] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: DROP EVENT TRIGGER1149server # [ 131.861765] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE: function extensions.notify_api_restart() does not exist, skipping1150server # [ 131.864099] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: DROP FUNCTION1151server # [ 131.866810] postgres[1620]: ::1 2026-10-22 15:14:03.556 UTC [1620] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1152server # [ 131.867439] postgres[1620]: DECLARE1153server # [ 131.868121] postgres[1620]: cmd record;1154server # [ 131.870183] postgres[1620]: BEGIN1155server # [ 131.871344] postgres[1620]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1156server # [ 131.873854] postgres[1620]: LOOP1157server # [ 131.874668] postgres[1620]: IF cmd.command_tag IN (1158server # [ 131.875439] postgres[1620]: 'CREATE SCHEMA', 'ALTER SCHEMA'1159server # [ 131.875887] postgres[1620]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1160server # [ 131.876225] postgres[1620]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1161server # [ 131.877034] postgres[1620]: , 'CREATE VIEW', 'ALTER VIEW'1162server # [ 131.878005] postgres[1620]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1163server # [ 131.878452] postgres[1620]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1164server # [ 131.879093] postgres[1620]: , 'CREATE TRIGGER'1165server # [ 131.879392] postgres[1620]: , 'CREATE TYPE'1166server # [ 131.879638] postgres[1620]: , 'CREATE RULE'1167server # [ 131.879871] postgres[1620]: , 'COMMENT'1168server # [ 131.880972] postgres[1620]: )1169server # [ 131.881938] postgres[1620]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1170server # [ 131.883061] postgres[1620]: AND cmd.schema_name is distinct from 'pg_temp'1171server # [ 131.883546] postgres[1620]: THEN1172server # [ 131.885242] postgres[1620]: NOTIFY pgrst, 'reload schema';1173server # [ 131.885723] postgres[1620]: END IF;1174server # [ 131.885987] postgres[1620]: END LOOP;1175server # [ 131.886278] postgres[1620]: END; $$ LANGUAGE plpgsql;1176server # [ 131.888138] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: CREATE FUNCTION1177server # [ 131.891490] postgres[1620]: ::1 2026-10-22 15:14:03.603 UTC [1620] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1178server # [ 131.893784] postgres[1620]: DECLARE1179server # [ 131.894418] postgres[1620]: obj record;1180server # [ 131.895282] postgres[1620]: BEGIN1181server # [ 131.899925] postgres[1620]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1182server # [ 131.900971] postgres[1620]: LOOP1183server # [ 131.902284] postgres[1620]: IF obj.object_type IN (1184server # [ 131.903503] postgres[1620]: 'schema'1185server # [ 131.905227] postgres[1620]: , 'table'1186server # [ 131.905722] postgres[1620]: , 'foreign table'1187server # [ 131.906153] postgres[1620]: , 'view'1188server # [ 131.907230] postgres[1620]: , 'materialized view'1189server # [ 131.907633] postgres[1620]: , 'function'1190server # [ 131.909564] postgres[1620]: , 'trigger'1191server # [ 131.909967] postgres[1620]: , 'type'1192server # [ 131.910210] postgres[1620]: , 'rule'1193server # [ 131.910721] postgres[1620]: )1194server # [ 131.912225] postgres[1620]: AND obj.is_temporary IS false -- no pg_temp objects1195server # [ 131.915014] postgres[1620]: THEN1196server # [ 131.915879] postgres[1620]: NOTIFY pgrst, 'reload schema';1197server # [ 131.917654] postgres[1620]: END IF;1198server # [ 131.918068] postgres[1620]: END LOOP;1199server # [ 131.918531] postgres[1620]: END; $$ LANGUAGE plpgsql;1200server # [ 131.920133] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: CREATE FUNCTION1201server # [ 131.927528] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE: event trigger "pgrst_ddl_watch" does not exist, skipping1202server # [ 131.931279] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: DROP EVENT TRIGGER1203server # [ 131.931877] postgres[1620]: ::1 2026-10-22 15:14:03.632 UTC [1620] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1204server # [ 131.938171] postgres[1620]: ::1 2026-10-22 15:14:03.643 UTC [1620] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1205server # [ 131.939216] postgres[1620]: ON ddl_command_end1206server # [ 131.940044] postgres[1620]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1207server # [ 131.946956] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: CREATE EVENT TRIGGER1208server # [ 131.952236] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE: event trigger "pgrst_drop_watch" does not exist, skipping1209server # [ 131.954182] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: DROP EVENT TRIGGER1210server # [ 131.955074] postgres[1620]: ::1 2026-10-22 15:14:03.660 UTC [1620] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1211server # [ 131.961271] postgres[1620]: ::1 2026-10-22 15:14:03.668 UTC [1620] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1212server # [ 131.965654] postgres[1620]: ON sql_drop1213server # [ 131.966695] postgres[1620]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1214server # [ 131.967621] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1619]: CREATE EVENT TRIGGER1215server # [ 131.994707] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql1216server # [ 133.331458] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1621]: DO1217server # [ 133.418343] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql1218server # [ 133.830701] postgres[1642]: ::1 2026-10-22 15:14:05.531 UTC [1642] supabase_admin@postgres LOG: statement: create schema if not exists graphql_public;1219server # [ 133.886791] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: CREATE SCHEMA1220server # [ 133.888279] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE: function graphql_public.graphql(text,text,jsonb) does not exist, skipping1221server # [ 133.902065] postgres[1642]: ::1 2026-10-22 15:14:05.591 UTC [1642] supabase_admin@postgres LOG: statement: drop function if exists graphql_public.graphql(text, text, jsonb);1222server # [ 133.902948] postgres[1642]: ::1 2026-10-22 15:14:05.603 UTC [1642] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1223server # [ 133.910648] postgres[1642]: "operationName" text default null,1224server # [ 133.912100] postgres[1642]: query text default null,1225server # [ 133.914555] postgres[1642]: variables jsonb default null,1226server # [ 133.915850] postgres[1642]: extensions jsonb default null1227server # [ 133.916186] postgres[1642]: )1228server # [ 133.916414] postgres[1642]: returns jsonb1229server # [ 133.921150] postgres[1642]: language plpgsql1230server # [ 133.922092] postgres[1642]: as $$1231server # [ 133.922611] postgres[1642]: DECLARE1232server # [ 133.932131] postgres[1642]: server_version float;1233server # [ 133.933204] postgres[1642]: BEGIN1234server # [ 133.934306] postgres[1642]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1235server # [ 133.934968] postgres[1642]:1236server # [ 133.935721] postgres[1642]: IF server_version >= 14 THEN1237server # [ 133.945111] postgres[1642]: RETURN jsonb_build_object(1238server # [ 133.946516] postgres[1642]: 'data', null::jsonb,1239server # [ 133.953292] postgres[1642]: 'errors', array['pg_graphql extension is not enabled.']1240server # [ 133.954330] postgres[1642]: );1241server # [ 133.955126] postgres[1642]: ELSE1242server # [ 133.960828] postgres[1642]: RETURN jsonb_build_object(1243server # [ 133.963802] postgres[1642]: 'data', null::jsonb,1244server # [ 133.968735] postgres[1642]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1245server # [ 133.970043] postgres[1642]: );1246server # [ 133.970822] postgres[1642]: END IF;1247server # [ 133.971127] postgres[1642]: END;1248server # [ 133.972036] postgres[1642]: $$;1249server # [ 133.980607] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: DROP FUNCTION1250server # [ 133.981829] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: CREATE FUNCTION1251server # [ 133.982961] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: GRANT1252server # [ 133.983367] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: ALTER DEFAULT PRIVILEGES1253server # [ 133.984101] postgres[1642]: ::1 2026-10-22 15:14:05.633 UTC [1642] supabase_admin@postgres LOG: statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;1254server # [ 133.989237] postgres[1642]: ::1 2026-10-22 15:14:05.658 UTC [1642] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;1255server # [ 133.990978] postgres[1642]: ::1 2026-10-22 15:14:05.681 UTC [1642] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;1256server # [ 133.994174] postgres[1642]: ::1 2026-10-22 15:14:05.693 UTC [1642] supabase_admin@postgres LOG: statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;1257server # [ 133.995514] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: ALTER DEFAULT PRIVILEGES1258server # [ 134.002738] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: ALTER DEFAULT PRIVILEGES1259server # [ 134.004199] postgres[1642]: ::1 2026-10-22 15:14:05.710 UTC [1642] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1260server # [ 134.006823] postgres[1642]: on sequences to postgres, anon, authenticated, service_role;1261server # [ 134.017396] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: ALTER DEFAULT PRIVILEGES1262server # [ 134.018470] postgres[1642]: ::1 2026-10-22 15:14:05.730 UTC [1642] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1263server # [ 134.018950] postgres[1642]: on tables to postgres, anon, authenticated, service_role;1264server # [ 134.029290] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: ALTER DEFAULT PRIVILEGES1265server # [ 134.030311] postgres[1642]: ::1 2026-10-22 15:14:05.742 UTC [1642] supabase_admin@postgres LOG: statement: alter default privileges for user supabase_admin in schema graphql_public grant all1266server # [ 134.030801] postgres[1642]: on functions to postgres, anon, authenticated, service_role;1267server # [ 134.049110] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: ALTER DEFAULT PRIVILEGES1268server # [ 134.051011] postgres[1642]: ::1 2026-10-22 15:14:05.758 UTC [1642] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()1269server # [ 134.061370] postgres[1642]: RETURNS event_trigger1270server # [ 134.062583] postgres[1642]: LANGUAGE plpgsql1271server # [ 134.063848] postgres[1642]: AS $func$1272server # [ 134.075350] postgres[1642]: DECLARE1273server # [ 134.087578] postgres[1642]: func_is_graphql_resolve bool;1274server # [ 134.098301] postgres[1642]: BEGIN1275server # [ 134.099751] postgres[1642]: func_is_graphql_resolve = (1276server # [ 134.100198] postgres[1642]: SELECT n.proname = 'resolve'1277server # [ 134.103935] postgres[1642]: FROM pg_event_trigger_ddl_commands() AS ev1278server # [ 134.117032] postgres[1642]: LEFT JOIN pg_catalog.pg_proc AS n1279server # [ 134.119308] postgres[1642]: ON ev.objid = n.oid1280server # [ 134.133044] postgres[1642]: );1281server # [ 134.135972] postgres[1642]:1282server # [ 134.149905] postgres[1642]: IF func_is_graphql_resolve1283server # [ 134.162334] postgres[1642]: THEN1284server # [ 134.178186] postgres[1642]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1285server # [ 134.185082] postgres[1642]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1286server # [ 134.187548] postgres[1642]:1287server # [ 134.191721] postgres[1642]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1288server # [ 134.201694] postgres[1642]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1289server # [ 134.203608] postgres[1642]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1290server # [ 134.204437] postgres[1642]:1291server # [ 134.205050] postgres[1642]: DROP FUNCTION IF EXISTS graphql_public.graphql;1292server # [ 134.206059] postgres[1642]: create or replace function graphql_public.graphql(1293server # [ 134.207056] postgres[1642]: "operationName" text default null,1294server # [ 134.207396] postgres[1642]: query text default null,1295server # [ 134.207870] postgres[1642]: variables jsonb default null,1296server # [ 134.208885] postgres[1642]: extensions jsonb default null1297server # [ 134.209535] postgres[1642]: )1298server # [ 134.210236] postgres[1642]: returns jsonb1299server # [ 134.210534] postgres[1642]: language sql1300server # [ 134.210778] postgres[1642]: as $$1301server # [ 134.211385] postgres[1642]: SELECT graphql.resolve(query, coalesce(variables, '{}'));1302server # [ 134.211921] postgres[1642]: $$;1303server # [ 134.213105] postgres[1642]:1304server # [ 134.213911] postgres[1642]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1305server # [ 134.214637] postgres[1642]: END IF;1306server # [ 134.214931] postgres[1642]:1307server # [ 134.215166] postgres[1642]: END;1308server # [ 134.215973] postgres[1642]: $func$;1309server # [ 134.217899] postgres[1642]: ::1 2026-10-22 15:14:05.825 UTC [1642] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;1310server # [ 134.218729] postgres[1642]: ::1 2026-10-22 15:14:05.842 UTC [1642] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')1311server # [ 134.219208] postgres[1642]: EXECUTE PROCEDURE extensions.grant_pg_graphql_access();1312server # [ 134.219591] postgres[1642]: ::1 2026-10-22 15:14:05.875 UTC [1642] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';1313server # [ 134.220383] postgres[1642]: ::1 2026-10-22 15:14:05.909 UTC [1642] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1314server # [ 134.221269] postgres[1642]: RETURNS event_trigger1315server # [ 134.221707] postgres[1642]: LANGUAGE plpgsql1316server # [ 134.222679] postgres[1642]: AS $func$1317server # [ 134.223010] postgres[1642]: DECLARE1318server # [ 134.223774] postgres[1642]: graphql_is_dropped bool;1319server # [ 134.225802] postgres[1642]: BEGIN1320server # [ 134.226128] postgres[1642]: graphql_is_dropped = (1321server # [ 134.226594] postgres[1642]: SELECT ev.schema_name = 'graphql_public'1322server # [ 134.227107] postgres[1642]: FROM pg_event_trigger_dropped_objects() AS ev1323server # [ 134.227383] postgres[1642]: WHERE ev.schema_name = 'graphql_public'1324server # [ 134.227770] postgres[1642]: );1325server # [ 134.228232] postgres[1642]:1326server # [ 134.228581] postgres[1642]: IF graphql_is_dropped1327server # [ 134.229309] postgres[1642]: THEN1328server # [ 134.229848] postgres[1642]: create or replace function graphql_public.graphql(1329server # [ 134.230108] postgres[1642]: "operationName" text default null,1330server # [ 134.231077] postgres[1642]: query text default null,1331server # [ 134.231387] postgres[1642]: variables jsonb default null,1332server # [ 134.231912] postgres[1642]: extensions jsonb default null1333server # [ 134.232318] postgres[1642]: )1334server # [ 134.232557] postgres[1642]: returns jsonb1335server # [ 134.233291] postgres[1642]: language plpgsql1336server # [ 134.234504] postgres[1642]: as $$1337server # [ 134.235443] postgres[1642]: DECLARE1338server # [ 134.236341] postgres[1642]: server_version float;1339server # [ 134.237791] postgres[1642]: BEGIN1340server # [ 134.238091] postgres[1642]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1341server # [ 134.238685] postgres[1642]:1342server # [ 134.239010] postgres[1642]: IF server_version >= 14 THEN1343server # [ 134.239429] postgres[1642]: RETURN jsonb_build_object(1344server # [ 134.239690] postgres[1642]: 'data', null::jsonb,1345server # [ 134.239990] postgres[1642]: 'errors', array['pg_graphql extension is not enabled.']1346server # [ 134.241237] postgres[1642]: );1347server # [ 134.242167] postgres[1642]: ELSE1348server # [ 134.242689] postgres[1642]: RETURN jsonb_build_object(1349server # [ 134.243160] postgres[1642]: 'data', null::jsonb,1350server # [ 134.243868] postgres[1642]: 'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1351server # [ 134.244237] postgres[1642]: );1352server # [ 134.245557] postgres[1642]: END IF;1353server # [ 134.246615] postgres[1642]: END;1354server # [ 134.247566] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: CREATE FUNCTION1355server # [ 134.248054] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE: event trigger "issue_pg_graphql_access" does not exist, skipping1356server # [ 134.249822] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: DROP EVENT TRIGGER1357server # [ 134.250640] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: CREATE EVENT TRIGGER1358server # [ 134.250920] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: COMMENT1359server # [ 134.251290] postgres[1642]: $$;1360server # [ 134.251903] postgres[1642]: END IF;1361server # [ 134.252136] postgres[1642]:1362server # [ 134.252791] postgres[1642]: END;1363server # [ 134.253439] postgres[1642]: $func$;1364server # [ 134.273443] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: CREATE FUNCTION1365server # [ 134.276812] postgres[1642]: ::1 2026-10-22 15:14:05.987 UTC [1642] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;1366server # [ 134.279204] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE: event trigger "issue_graphql_placeholder" does not exist, skipping1367server # [ 134.286273] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: DROP EVENT TRIGGER1368server # [ 134.287585] postgres[1642]: ::1 2026-10-22 15:14:05.994 UTC [1642] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')1369server # [ 134.290027] postgres[1642]: EXECUTE PROCEDURE extensions.set_graphql_placeholder();1370server # [ 134.293911] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: CREATE EVENT TRIGGER1371server # [ 134.296621] postgres[1642]: ::1 2026-10-22 15:14:06.007 UTC [1642] supabase_admin@postgres LOG: statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';1372server # [ 134.306623] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1639]: COMMENT1373server # [ 134.350641] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql1374server # [ 134.600466] postgres[1650]: ::1 2026-10-22 15:14:06.307 UTC [1650] supabase_admin@postgres LOG: statement: drop event trigger if exists api_restart;1375server # [ 134.618455] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1649]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE: event trigger "api_restart" does not exist, skipping1376server # [ 134.623637] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1649]: DROP EVENT TRIGGER1377server # [ 134.625758] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1649]: 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, skipping1378server # [ 134.626750] postgres[1650]: ::1 2026-10-22 15:14:06.321 UTC [1650] supabase_admin@postgres LOG: statement: drop function if exists extensions.notify_api_restart();1379server # [ 134.639826] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1649]: DROP FUNCTION1380server # [ 134.645736] postgres[1650]: ::1 2026-10-22 15:14:06.348 UTC [1650] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1381server # [ 134.646824] postgres[1650]: DECLARE1382server # [ 134.647632] postgres[1650]: cmd record;1383server # [ 134.650784] postgres[1650]: BEGIN1384server # [ 134.653866] postgres[1650]: FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1385server # [ 134.654792] postgres[1650]: LOOP1386server # [ 134.655111] postgres[1650]: IF cmd.command_tag IN (1387server # [ 134.655372] postgres[1650]: 'CREATE SCHEMA', 'ALTER SCHEMA'1388server # [ 134.659878] postgres[1650]: , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1389server # [ 134.663349] postgres[1650]: , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1390server # [ 134.664562] postgres[1650]: , 'CREATE VIEW', 'ALTER VIEW'1391server # [ 134.665457] postgres[1650]: , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1392server # [ 134.665996] postgres[1650]: , 'CREATE FUNCTION', 'ALTER FUNCTION'1393server # [ 134.666454] postgres[1650]: , 'CREATE TRIGGER'1394server # [ 134.667012] postgres[1650]: , 'CREATE TYPE', 'ALTER TYPE'1395server # [ 134.667354] postgres[1650]: , 'CREATE RULE'1396server # [ 134.667661] postgres[1650]: , 'COMMENT'1397server # [ 134.669528] postgres[1650]: )1398server # [ 134.670012] postgres[1650]: -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1399server # [ 134.670531] postgres[1650]: AND cmd.schema_name is distinct from 'pg_temp'1400server # [ 134.670962] postgres[1650]: THEN1401server # [ 134.671204] postgres[1650]: NOTIFY pgrst, 'reload schema';1402server # [ 134.671487] postgres[1650]: END IF;1403server # [ 134.672145] postgres[1650]: END LOOP;1404server # [ 134.675530] postgres[1650]: END; $$ LANGUAGE plpgsql;1405server # [ 134.704873] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1649]: CREATE FUNCTION1406server # [ 134.706055] postgres[1650]: ::1 2026-10-22 15:14:06.416 UTC [1650] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1407server # [ 134.706770] postgres[1650]: DECLARE1408server # [ 134.707812] postgres[1650]: obj record;1409server # [ 134.709486] postgres[1650]: BEGIN1410server # [ 134.710110] postgres[1650]: FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1411server # [ 134.710992] postgres[1650]: LOOP1412server # [ 134.711977] postgres[1650]: IF obj.object_type IN (1413server # [ 134.713746] postgres[1650]: 'schema'1414server # [ 134.714305] postgres[1650]: , 'table'1415server # [ 134.715317] postgres[1650]: , 'foreign table'1416server # [ 134.716113] postgres[1650]: , 'view'1417server # [ 134.717647] postgres[1650]: , 'materialized view'1418server # [ 134.718483] postgres[1650]: , 'function'1419server # [ 134.718854] postgres[1650]: , 'trigger'1420server # [ 134.719118] postgres[1650]: , 'type'1421server # [ 134.719356] postgres[1650]: , 'rule'1422server # [ 134.719599] postgres[1650]: )1423server # [ 134.720003] postgres[1650]: AND obj.is_temporary IS false -- no pg_temp objects1424server # [ 134.720315] postgres[1650]: THEN1425server # [ 134.721482] postgres[1650]: NOTIFY pgrst, 'reload schema';1426server # [ 134.721990] postgres[1650]: END IF;1427server # [ 134.722312] postgres[1650]: END LOOP;1428server # [ 134.723088] postgres[1650]: END; $$ LANGUAGE plpgsql;1429server # [ 134.734858] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1649]: CREATE FUNCTION1430server # [ 134.737246] postgres[1650]: ::1 2026-10-22 15:14:06.448 UTC [1650] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1431server # [ 134.747391] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1649]: DROP EVENT TRIGGER1432server # [ 134.750433] postgres[1650]: ::1 2026-10-22 15:14:06.462 UTC [1650] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_ddl_watch1433server # [ 134.751127] postgres[1650]: ON ddl_command_end1434server # [ 134.751948] postgres[1650]: EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1435server # [ 134.768615] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1649]: CREATE EVENT TRIGGER1436server # [ 134.771798] postgres[1650]: ::1 2026-10-22 15:14:06.478 UTC [1650] supabase_admin@postgres LOG: statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1437server # [ 134.783660] postgres[1650]: ::1 2026-10-22 15:14:06.489 UTC [1650] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER pgrst_drop_watch1438server # [ 134.789733] postgres[1650]: ON sql_drop1439server # [ 134.795666] postgres[1650]: EXECUTE PROCEDURE extensions.pgrst_drop_watch();1440server # [ 134.797463] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1649]: DROP EVENT TRIGGER1441server # [ 134.799114] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1649]: CREATE EVENT TRIGGER1442server # [ 134.882945] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220322085208_gotrue-session-limit.sql1443server # [ 135.308074] postgres[1656]: ::1 2026-10-22 15:14:07.004 UTC [1656] supabase_admin@postgres LOG: statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;1444server # [ 135.354485] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1653]: ALTER ROLE1445server # [ 135.381152] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql1446server # [ 135.716418] postgres[1658]: ::1 2026-10-22 15:14:07.423 UTC [1658] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1447server # [ 135.721516] postgres[1658]: returns event_trigger1448server # [ 135.723271] postgres[1658]: language plpgsql1449server # [ 135.724699] postgres[1658]: AS $func$1450server # [ 135.726268] postgres[1658]: DECLARE1451server # [ 135.726809] postgres[1658]: func_is_graphql_resolve bool;1452server # [ 135.730864] postgres[1658]: BEGIN1453server # [ 135.731535] postgres[1658]: func_is_graphql_resolve = (1454server # [ 135.731872] postgres[1658]: SELECT n.proname = 'resolve'1455server # [ 135.732491] postgres[1658]: FROM pg_event_trigger_ddl_commands() AS ev1456server # [ 135.734148] postgres[1658]: LEFT JOIN pg_catalog.pg_proc AS n1457server # [ 135.735513] postgres[1658]: ON ev.objid = n.oid1458server # [ 135.735951] postgres[1658]: );1459server # [ 135.737263] postgres[1658]:1460server # [ 135.738297] postgres[1658]: IF func_is_graphql_resolve1461server # [ 135.739523] postgres[1658]: THEN1462server # [ 135.741123] postgres[1658]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1463server # [ 135.742741] postgres[1658]: grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1464server # [ 135.745656] postgres[1658]:1465server # [ 135.746321] postgres[1658]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1466server # [ 135.746916] postgres[1658]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1467server # [ 135.749005] postgres[1658]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1468server # [ 135.751099] postgres[1658]:1469server # [ 135.752979] postgres[1658]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1470server # [ 135.753979] postgres[1658]: DROP FUNCTION IF EXISTS graphql_public.graphql;1471server # [ 135.755622] postgres[1658]: create or replace function graphql_public.graphql(1472server # [ 135.756966] postgres[1658]: "operationName" text default null,1473server # [ 135.757627] postgres[1658]: query text default null,1474server # [ 135.758527] postgres[1658]: variables jsonb default null,1475server # [ 135.758850] postgres[1658]: extensions jsonb default null1476server # [ 135.759780] postgres[1658]: )1477server # [ 135.761141] postgres[1658]: returns jsonb1478server # [ 135.762778] postgres[1658]: language sql1479server # [ 135.763791] postgres[1658]: as $$1480server # [ 135.765205] postgres[1658]: -- This changed1481server # [ 135.765791] postgres[1658]: select graphql.resolve(1482server # [ 135.769017] postgres[1658]: query := query,1483server # [ 135.770684] postgres[1658]: variables := coalesce(variables, '{}'),1484server # [ 135.771484] postgres[1658]: "operationName" := "operationName",1485server # [ 135.772815] postgres[1658]: extensions := extensions1486server # [ 135.773288] postgres[1658]: );1487server # [ 135.774370] postgres[1658]: $$;1488server # [ 135.775112] postgres[1658]:1489server # [ 135.775933] postgres[1658]: grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1490server # [ 135.777405] postgres[1658]: END IF;1491server # [ 135.778402] postgres[1658]:1492server # [ 135.779578] postgres[1658]: END;1493server # [ 135.781161] postgres[1658]: $func$;1494server # [ 135.828424] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1657]: CREATE FUNCTION1495server # [ 135.847872] postgres[1658]: ::1 2026-10-22 15:14:07.537 UTC [1658] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1496server # [ 135.852080] postgres[1658]: RETURNS event_trigger1497server # [ 135.854894] postgres[1658]: LANGUAGE plpgsql1498server # [ 135.865724] postgres[1658]: AS $func$1499server # [ 135.866489] postgres[1658]: DECLARE1500server # [ 135.866816] postgres[1658]: graphql_is_dropped bool;1501server # [ 135.867088] postgres[1658]: BEGIN1502server # [ 135.867323] postgres[1658]: graphql_is_dropped = (1503server # [ 135.867554] postgres[1658]: SELECT ev.schema_name = 'graphql_public'1504server # [ 135.867803] postgres[1658]: FROM pg_event_trigger_dropped_objects() AS ev1505server # [ 135.868058] postgres[1658]: WHERE ev.schema_name = 'graphql_public'1506server # [ 135.878631] postgres[1658]: );1507server # [ 135.881220] postgres[1658]:1508server # [ 135.882621] postgres[1658]: IF graphql_is_dropped1509server # [ 135.883691] postgres[1658]: THEN1510server # [ 135.886926] postgres[1658]: create or replace function graphql_public.graphql(1511server # [ 135.888778] postgres[1658]: "operationName" text default null,1512server # [ 135.889259] postgres[1658]: query text default null,1513server # [ 135.891069] postgres[1658]: variables jsonb default null,1514server # [ 135.891521] postgres[1658]: extensions jsonb default null1515server # [ 135.893663] postgres[1658]: )1516server # [ 135.894948] postgres[1658]: returns jsonb1517server # [ 135.896305] postgres[1658]: language plpgsql1518server # [ 135.897836] postgres[1658]: as $$1519server # [ 135.898698] postgres[1658]: DECLARE1520server # [ 135.900280] postgres[1658]: server_version float;1521server # [ 135.902406] postgres[1658]: BEGIN1522server # [ 135.906572] postgres[1658]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1523server # [ 135.907591] postgres[1658]:1524server # [ 135.908073] postgres[1658]: IF server_version >= 14 THEN1525server # [ 135.908383] postgres[1658]: RETURN jsonb_build_object(1526server # [ 135.909745] postgres[1658]: 'errors', jsonb_build_array(1527server # [ 135.910384] postgres[1658]: jsonb_build_object(1528server # [ 135.912284] postgres[1658]: 'message', 'pg_graphql extension is not enabled.'1529server # [ 135.914053] postgres[1658]: )1530server # [ 135.914509] postgres[1658]: )1531server # [ 135.915536] postgres[1658]: );1532server # [ 135.917516] postgres[1658]: ELSE1533server # [ 135.918560] postgres[1658]: RETURN jsonb_build_object(1534server # [ 135.919759] postgres[1658]: 'errors', jsonb_build_array(1535server # [ 135.923311] postgres[1658]: jsonb_build_object(1536server # [ 135.925966] postgres[1658]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1537server # [ 135.927450] postgres[1658]: )1538server # [ 135.929518] postgres[1658]: )1539server # [ 135.930219] postgres[1658]: );1540server # [ 135.931489] postgres[1658]: END IF;1541server # [ 135.933908] postgres[1658]: END;1542server # [ 135.934366] postgres[1658]: $$;1543server # [ 135.934615] postgres[1658]: END IF;1544server # [ 135.934826] postgres[1658]:1545server # [ 135.935027] postgres[1658]: END;1546server # [ 135.935226] postgres[1658]: $func$;1547server # [ 135.936696] postgres[1658]: ::1 2026-10-22 15:14:07.570 UTC [1658] supabase_admin@postgres LOG: statement: create or replace function graphql_public.graphql(1548server # [ 135.938902] postgres[1658]: "operationName" text default null,1549server # [ 135.941567] postgres[1658]: query text default null,1550server # [ 135.942490] postgres[1658]: variables jsonb default null,1551server # [ 135.945850] postgres[1658]: extensions jsonb default null1552server # [ 135.947268] postgres[1658]: )1553server # [ 135.947600] postgres[1658]: returns jsonb1554server # [ 135.948029] postgres[1658]: language plpgsql1555server # [ 135.948527] postgres[1658]: as $$1556server # [ 135.951642] postgres[1658]: DECLARE1557server # [ 135.953747] postgres[1658]: server_version float;1558server # [ 135.954524] postgres[1658]: BEGIN1559server # [ 135.955770] postgres[1658]: server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1560server # [ 135.956353] postgres[1658]:1561server # [ 135.958527] postgres[1658]: IF server_version >= 14 THEN1562server # [ 135.961294] postgres[1658]: RETURN jsonb_build_object(1563server # [ 135.962116] postgres[1658]: 'errors', jsonb_build_array(1564server # [ 135.962985] postgres[1658]: jsonb_build_object(1565server # [ 135.964267] postgres[1658]: 'message', 'pg_graphql extension is not enabled.'1566server # [ 135.965988] postgres[1658]: )1567server # [ 135.966734] postgres[1658]: )1568server # [ 135.971910] postgres[1658]: );1569server # [ 135.974032] postgres[1658]: ELSE1570server # [ 135.975365] postgres[1658]: RETURN jsonb_build_object(1571server # [ 135.977484] postgres[1658]: 'errors', jsonb_build_array(1572server # [ 135.977944] postgres[1658]: jsonb_build_object(1573server # [ 135.978326] postgres[1658]: 'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1574server # [ 135.982139] postgres[1658]: )1575server # [ 135.983798] postgres[1658]: )1576server # [ 135.986524] postgres[1658]: );1577server # [ 135.987968] postgres[1658]: END IF;1578server # [ 135.989658] postgres[1658]: END;1579server # [ 135.990037] postgres[1658]: $$;1580server # [ 135.990527] postgres[1658]: ::1 2026-10-22 15:14:07.602 UTC [1658] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1581server # [ 135.995492] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1657]: CREATE FUNCTION1582server # [ 135.996931] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1657]: CREATE FUNCTION1583server # [ 135.997920] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1657]: psql:/nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE: extension "pg_graphql" does not exist, skipping1584server # [ 135.999806] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1657]: DROP EXTENSION1585server # [ 138.080191] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1657]: DO1586server # [ 138.125904] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql1587server # [ 138.366908] postgres[1684]: ::1 2026-10-22 15:14:10.070 UTC [1684] supabase_admin@postgres LOG: statement: grant supabase_auth_admin, supabase_storage_admin to postgres;1588server # [ 138.383981] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1683]: GRANT ROLE1589server # [ 138.412823] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql1590server # [ 138.684137] postgres[1686]: ::1 2026-10-22 15:14:10.383 UTC [1686] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1591server # [ 138.689665] postgres[1686]: returns event_trigger1592server # [ 138.690930] postgres[1686]: language plpgsql1593server # [ 138.691357] postgres[1686]: AS $func$1594server # [ 138.691632] postgres[1686]: DECLARE1595server # [ 138.693867] postgres[1686]: func_is_graphql_resolve bool;1596server # [ 138.694524] postgres[1686]: BEGIN1597server # [ 138.694948] postgres[1686]: func_is_graphql_resolve = (1598server # [ 138.696895] postgres[1686]: SELECT n.proname = 'resolve'1599server # [ 138.697822] postgres[1686]: FROM pg_event_trigger_ddl_commands() AS ev1600server # [ 138.698376] postgres[1686]: LEFT JOIN pg_catalog.pg_proc AS n1601server # [ 138.698900] postgres[1686]: ON ev.objid = n.oid1602server # [ 138.699476] postgres[1686]: );1603server # [ 138.700290] postgres[1686]:1604server # [ 138.701953] postgres[1686]: IF func_is_graphql_resolve1605server # [ 138.703454] postgres[1686]: THEN1606server # [ 138.704074] postgres[1686]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1607server # [ 138.706384] postgres[1686]: DROP FUNCTION IF EXISTS graphql_public.graphql;1608server # [ 138.707180] postgres[1686]: create or replace function graphql_public.graphql(1609server # [ 138.707609] postgres[1686]: "operationName" text default null,1610server # [ 138.707922] postgres[1686]: query text default null,1611server # [ 138.708206] postgres[1686]: variables jsonb default null,1612server # [ 138.708646] postgres[1686]: extensions jsonb default null1613server # [ 138.708932] postgres[1686]: )1614server # [ 138.710773] postgres[1686]: returns jsonb1615server # [ 138.717588] postgres[1686]: language sql1616server # [ 138.725083] postgres[1686]: as $$1617server # [ 138.726178] postgres[1686]: select graphql.resolve(1618server # [ 138.726943] postgres[1686]: query := query,1619server # [ 138.727970] postgres[1686]: variables := coalesce(variables, '{}'),1620server # [ 138.730281] postgres[1686]: "operationName" := "operationName",1621server # [ 138.731123] postgres[1686]: extensions := extensions1622server # [ 138.732055] postgres[1686]: );1623server # [ 138.737794] postgres[1686]: $$;1624server # [ 138.740386] postgres[1686]:1625server # [ 138.747174] postgres[1686]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1626server # [ 138.751366] postgres[1686]: -- function in the extension so we need to grant permissions on existing entities AND1627server # [ 138.763823] postgres[1686]: -- update default permissions to any others that are created after `graphql.resolve`1628server # [ 138.770328] postgres[1686]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1629server # [ 138.775593] postgres[1686]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1630server # [ 138.782125] postgres[1686]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1631server # [ 138.783341] postgres[1686]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1632server # [ 138.787747] postgres[1686]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1633server # [ 138.794027] postgres[1686]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1634server # [ 138.797088] postgres[1686]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1635server # [ 138.798123] postgres[1686]: END IF;1636server # [ 138.798420] postgres[1686]:1637server # [ 138.798635] postgres[1686]: END;1638server # [ 138.799576] postgres[1686]: $func$;1639server # [ 138.866282] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1685]: CREATE FUNCTION1640server # [ 138.871814] postgres[1686]: ::1 2026-10-22 15:14:10.572 UTC [1686] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1641server # [ 138.995355] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1685]: DROP EXTENSION1642server # [ 141.209874] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1685]: DO1643server # [ 141.235706] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql1644server # [ 142.241889] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1715]: DO1645server # [ 143.026377] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1715]: DO1646server # [ 143.111395] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql1647server # [ 143.634029] postgres[1731]: ::1 2026-10-22 15:14:15.326 UTC [1731] supabase_admin@postgres LOG: statement: alter role authenticator set statement_timeout = '8s';1648server # [ 143.659994] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1726]: ALTER ROLE1649server # [ 143.694090] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221103090837_revoke_admin.sql1650server # [ 144.167581] postgres[1742]: ::1 2026-10-22 15:14:15.868 UTC [1742] supabase_admin@postgres LOG: statement: revoke supabase_admin from authenticator;1651server # [ 144.186876] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1736]: REVOKE ROLE1652server # [ 144.231029] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql1653server # [ 146.972239] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1745]: DO1654server # [ 147.030416] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql1655server # [ 147.454356] postgres[1776]: ::1 2026-10-22 15:14:19.135 UTC [1776] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to postgres;1656server # [ 147.494116] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1772]: GRANT ROLE1657server # [ 147.499819] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql1658server # [ 147.905611] postgres[1778]: ::1 2026-10-22 15:14:19.590 UTC [1778] supabase_admin@postgres LOG: statement: grant all privileges on all tables in schema extensions to postgres with grant option;1659server # [ 147.966947] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1777]: GRANT1660server # [ 147.968211] postgres[1778]: ::1 2026-10-22 15:14:19.655 UTC [1778] supabase_admin@postgres LOG: statement: grant all privileges on all routines in schema extensions to postgres with grant option;1661server # [ 147.990753] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1777]: GRANT1662server # [ 147.998544] postgres[1778]: ::1 2026-10-22 15:14:19.706 UTC [1778] supabase_admin@postgres LOG: statement: grant all privileges on all sequences in schema extensions to postgres with grant option;1663server # [ 148.004223] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1777]: GRANT1664server # [ 148.009436] postgres[1778]: ::1 2026-10-22 15:14:19.715 UTC [1778] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;1665server # [ 148.023424] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1777]: ALTER DEFAULT PRIVILEGES1666server # [ 148.025587] postgres[1778]: ::1 2026-10-22 15:14:19.737 UTC [1778] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;1667server # [ 148.034360] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1777]: ALTER DEFAULT PRIVILEGES1668server # [ 148.035404] postgres[1778]: ::1 2026-10-22 15:14:19.747 UTC [1778] supabase_admin@postgres LOG: statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;1669server # [ 148.044165] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1777]: ALTER DEFAULT PRIVILEGES1670server # [ 148.115710] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql1671server # [ 148.352336] postgres[1780]: ::1 2026-10-22 15:14:20.059 UTC [1780] supabase_admin@postgres LOG: statement: grant pg_monitor to postgres;1672server # [ 148.367803] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1779]: GRANT ROLE1673server # [ 148.400812] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql1674server # [ 148.686109] postgres[1782]: ::1 2026-10-22 15:14:20.391 UTC [1782] supabase_admin@postgres LOG: statement: grant anon, authenticated, service_role to supabase_storage_admin;1675server # [ 148.700974] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1781]: GRANT ROLE1676server # [ 148.744536] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql1677server # [ 149.191308] postgres[1787]: ::1 2026-10-22 15:14:20.888 UTC [1787] supabase_admin@postgres LOG: statement: ALTER ROLE authenticated inherit;1678server # [ 149.198746] postgres[1787]: ::1 2026-10-22 15:14:20.903 UTC [1787] supabase_admin@postgres LOG: statement: ALTER ROLE anon inherit;1679server # [ 149.214358] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1783]: ALTER ROLE1680server # [ 149.218000] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1783]: ALTER ROLE1681server # [ 149.219826] postgres[1787]: ::1 2026-10-22 15:14:20.924 UTC [1787] supabase_admin@postgres LOG: statement: ALTER ROLE service_role inherit;1682server # [ 149.236032] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1783]: ALTER ROLE1683server # [ 149.338154] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1783]: DO1684server # [ 149.423034] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql1685server # [ 149.981048] postgres[1797]: ::1 2026-10-22 15:14:21.666 UTC [1797] supabase_admin@postgres LOG: statement: grant authenticator to supabase_storage_admin;1686server # [ 150.007777] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1793]: GRANT ROLE1687server # [ 150.014124] postgres[1797]: ::1 2026-10-22 15:14:21.701 UTC [1797] supabase_admin@postgres LOG: statement: revoke anon, authenticated, service_role from supabase_storage_admin;1688server # [ 150.032808] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1793]: REVOKE ROLE1689server # [ 150.093083] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql1690server # [ 150.495394] postgres[1806]: ::1 2026-10-22 15:14:22.189 UTC [1806] supabase_admin@postgres LOG: statement: create or replace function extensions.grant_pg_graphql_access()1691server # [ 150.508044] postgres[1806]: returns event_trigger1692server # [ 150.510428] postgres[1806]: language plpgsql1693server # [ 150.511514] postgres[1806]: AS $func$1694server # [ 150.511878] postgres[1806]: DECLARE1695server # [ 150.520945] postgres[1806]: func_is_graphql_resolve bool;1696server # [ 150.534484] postgres[1806]: BEGIN1697server # [ 150.534962] postgres[1806]: func_is_graphql_resolve = (1698server # [ 150.535243] postgres[1806]: SELECT n.proname = 'resolve'1699server # [ 150.541158] postgres[1806]: FROM pg_event_trigger_ddl_commands() AS ev1700server # [ 150.542812] postgres[1806]: LEFT JOIN pg_catalog.pg_proc AS n1701server # [ 150.543567] postgres[1806]: ON ev.objid = n.oid1702server # [ 150.544034] postgres[1806]: );1703server # [ 150.544910] postgres[1806]:1704server # [ 150.553709] postgres[1806]: IF func_is_graphql_resolve1705server # [ 150.554326] postgres[1806]: THEN1706server # [ 150.554614] postgres[1806]: -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1707server # [ 150.554925] postgres[1806]: DROP FUNCTION IF EXISTS graphql_public.graphql;1708server # [ 150.555723] postgres[1806]: create or replace function graphql_public.graphql(1709server # [ 150.556145] postgres[1806]: "operationName" text default null,1710server # [ 150.558790] postgres[1806]: query text default null,1711server # [ 150.559269] postgres[1806]: variables jsonb default null,1712server # [ 150.559581] postgres[1806]: extensions jsonb default null1713server # [ 150.559980] postgres[1806]: )1714server # [ 150.560222] postgres[1806]: returns jsonb1715server # [ 150.561757] postgres[1806]: language sql1716server # [ 150.562578] postgres[1806]: as $$1717server # [ 150.562991] postgres[1806]: select graphql.resolve(1718server # [ 150.563714] postgres[1806]: query := query,1719server # [ 150.564731] postgres[1806]: variables := coalesce(variables, '{}'),1720server # [ 150.566312] postgres[1806]: "operationName" := "operationName",1721server # [ 150.574148] postgres[1806]: extensions := extensions1722server # [ 150.574848] postgres[1806]: );1723server # [ 150.575352] postgres[1806]: $$;1724server # [ 150.575681] postgres[1806]:1725server # [ 150.575948] postgres[1806]: -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1726server # [ 150.577755] postgres[1806]: -- function in the extension so we need to grant permissions on existing entities AND1727server # [ 150.579743] postgres[1806]: -- update default permissions to any others that are created after `graphql.resolve`1728server # [ 150.585207] postgres[1806]: grant usage on schema graphql to postgres, anon, authenticated, service_role;1729server # [ 150.585862] postgres[1806]: grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1730server # [ 150.586372] postgres[1806]: grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1731server # [ 150.586832] postgres[1806]: grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1732server # [ 150.587166] postgres[1806]: alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1733server # [ 150.587721] postgres[1806]: alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1734server # [ 150.595465] postgres[1806]: alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1735server # [ 150.597642] postgres[1806]:1736server # [ 150.598334] postgres[1806]: -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles1737server # [ 150.599849] postgres[1806]: grant usage on schema graphql_public to postgres with grant option;1738server # [ 150.608792] postgres[1806]: grant usage on schema graphql to postgres with grant option;1739server # [ 150.610300] postgres[1806]: END IF;1740server # [ 150.610639] postgres[1806]:1741server # [ 150.610874] postgres[1806]: END;1742server # [ 150.611405] postgres[1806]: $func$;1743server # [ 150.635786] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1802]: CREATE FUNCTION1744server # [ 150.641956] postgres[1806]: ::1 2026-10-22 15:14:22.345 UTC [1806] supabase_admin@postgres LOG: statement: drop extension if exists pg_graphql;1745server # [ 150.745864] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1802]: DROP EXTENSION1746server # [ 152.486851] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1802]: DO1747server # [ 152.558245] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql1748server # [ 153.066980] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1817]: DO1749server # [ 153.094482] postgres[1823]: ::1 2026-10-22 15:14:24.754 UTC [1823] supabase_admin@postgres LOG: statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger1750server # [ 153.107425] postgres[1823]: LANGUAGE plpgsql1751server # [ 153.121465] postgres[1823]: AS $$1752server # [ 153.133482] postgres[1823]: BEGIN1753server # [ 153.134986] postgres[1823]: IF EXISTS (1754server # [ 153.136077] postgres[1823]: SELECT1755server # [ 153.151512] postgres[1823]: FROM pg_event_trigger_ddl_commands() AS ev1756server # [ 153.161253] postgres[1823]: JOIN pg_extension AS ext1757server # [ 153.162684] postgres[1823]: ON ev.objid = ext.oid1758server # [ 153.174032] postgres[1823]: WHERE ext.extname = 'pg_cron'1759server # [ 153.175937] postgres[1823]: )1760server # [ 153.176698] postgres[1823]: THEN1761server # [ 153.191044] postgres[1823]: grant usage on schema cron to postgres with grant option;1762server # [ 153.197912] postgres[1823]:1763server # [ 153.206173] postgres[1823]: alter default privileges in schema cron grant all on tables to postgres with grant option;1764server # [ 153.207852] postgres[1823]: alter default privileges in schema cron grant all on functions to postgres with grant option;1765server # [ 153.230201] postgres[1823]: alter default privileges in schema cron grant all on sequences to postgres with grant option;1766server # [ 153.238000] postgres[1823]:1767server # [ 153.239443] postgres[1823]: alter default privileges for user supabase_admin in schema cron grant all1768server # [ 153.250713] postgres[1823]: on sequences to postgres with grant option;1769server # [ 153.253174] postgres[1823]: alter default privileges for user supabase_admin in schema cron grant all1770server # [ 153.261991] postgres[1823]: on tables to postgres with grant option;1771server # [ 153.263301] postgres[1823]: alter default privileges for user supabase_admin in schema cron grant all1772server # [ 153.272651] postgres[1823]: on functions to postgres with grant option;1773server # [ 153.275533] postgres[1823]:1774server # [ 153.291427] postgres[1823]: grant all privileges on all tables in schema cron to postgres with grant option;1775server # [ 153.294319] postgres[1823]: revoke all on table cron.job from postgres;1776server # [ 153.301503] postgres[1823]: grant select on table cron.job to postgres with grant option;1777server # [ 153.304112] postgres[1823]: END IF;1778server # [ 153.308035] postgres[1823]: END;1779server # [ 153.310767] postgres[1823]: $$;1780server # [ 153.313637] postgres[1823]: ::1 2026-10-22 15:14:24.995 UTC [1823] supabase_admin@postgres LOG: statement: drop event trigger if exists issue_pg_cron_access;1781server # [ 153.322981] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1817]: CREATE FUNCTION1782server # [ 153.329815] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1817]: DROP EVENT TRIGGER1783server # [ 153.330756] postgres[1823]: ::1 2026-10-22 15:14:25.030 UTC [1823] supabase_admin@postgres LOG: statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;1784server # [ 153.342707] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1817]: ALTER FUNCTION1785server # [ 153.349440] postgres[1823]: ::1 2026-10-22 15:14:25.058 UTC [1823] supabase_admin@postgres LOG: statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end1786server # [ 153.351067] postgres[1823]: WHEN TAG IN ('CREATE EXTENSION')1787server # [ 153.358215] postgres[1823]: EXECUTE FUNCTION extensions.grant_pg_cron_access();1788server # [ 153.379150] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1817]: CREATE EVENT TRIGGER1789server # [ 153.437608] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql1790server # [ 154.100142] postgres[1840]: ::1 2026-10-22 15:14:25.806 UTC [1840] supabase_admin@postgres LOG: statement: ALTER ROLE authenticator set lock_timeout to '8s';1791server # [ 154.144648] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1834]: ALTER ROLE1792server # [ 154.229702] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql1793server # [ 154.544898] postgres[1846]: ::1 2026-10-22 15:14:26.246 UTC [1846] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_export owner to supabase_admin;1794server # [ 154.605954] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1845]: ALTER FUNCTION1795server # [ 154.606883] postgres[1846]: ::1 2026-10-22 15:14:26.302 UTC [1846] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;1796server # [ 154.614341] postgres[1846]: ::1 2026-10-22 15:14:26.314 UTC [1846] supabase_admin@postgres LOG: statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;1797server # [ 154.615908] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1845]: ALTER FUNCTION1798server # [ 154.624301] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1845]: ALTER FUNCTION1799server # [ 154.657502] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql1800server # [ 154.925064] postgres[1848]: ::1 2026-10-22 15:14:26.632 UTC [1848] supabase_admin@postgres LOG: statement: grant pg_read_all_data, pg_signal_backend to postgres;1801server # [ 154.953284] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1847]: GRANT ROLE1802server # [ 154.977394] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241031003909_create_orioledb.sql1803server # [ 156.222183] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1849]: DO1804server # [ 156.261984] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql1805server # [ 156.860459] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1860]: DO1806server # [ 156.893909] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1860]: DO1807server # [ 156.917935] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql1808server # [ 157.519306] postgres[1881]: ::1 2026-10-22 15:14:29.196 UTC [1881] supabase_admin@postgres LOG: statement: alter role supabase_admin set log_statement = none;1809server # [ 157.520468] postgres[1881]: ::1 2026-10-22 15:14:29.231 UTC [1881] supabase_admin@postgres LOG: statement: alter role supabase_auth_admin set log_statement = none;1810server # [ 157.531750] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1872]: ALTER ROLE1811server # [ 157.534268] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1872]: ALTER ROLE1812server # [ 157.535452] postgres[1881]: ::1 2026-10-22 15:14:29.246 UTC [1881] supabase_admin@postgres LOG: statement: alter role supabase_storage_admin set log_statement = none;1813server # [ 157.558251] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1872]: ALTER ROLE1814server # [ 157.618749] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql1815server # [ 158.069918] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1883]: DO1816server # [ 158.092598] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql1817server # [ 158.394599] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1885]: DO1818server # [ 158.423583] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql1819server # [ 158.771996] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1887]: CREATE FUNCTION1820server # [ 158.782530] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1887]: DO1821server # [ 158.855563] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql1822server # [ 159.227394] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1889]: ALTER FUNCTION1823server # [ 159.259899] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1889]: GRANT1824server # [ 159.281584] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql1825server # [ 159.990361] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1896]: DROP EVENT TRIGGER1826server # [ 160.033179] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1896]: ALTER FUNCTION1827server # [ 160.057214] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1896]: CREATE EVENT TRIGGER1828server # [ 160.103190] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql1829server # [ 160.621120] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1907]: DO1830server # [ 160.664837] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql1831server # [ 161.039969] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1919]: CREATE FUNCTION1832server # [ 161.049181] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1919]: GRANT1833server # [ 161.090566] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql1834server # [ 161.402921] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1921]: REVOKE ROLE1835server # [ 161.485536] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1921]: DO1836server # [ 161.506139] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1921]: DO1837server # [ 161.518329] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1921]: REVOKE ROLE1838server # [ 161.537265] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1921]: REVOKE1839server # [ 161.573981] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1921]: DO1840server # [ 161.653025] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql1841server # [ 162.019722] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1927]: DO1842server # [ 162.052126] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql1843server # [ 162.395607] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1929]: DO1844server # [ 162.427701] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql1845server # [ 162.998747] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1931]: DO1846server # [ 163.049413] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql1847server # [ 163.603854] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1944]: ALTER ROLE1848server # [ 163.646599] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251001204436_predefined_role_grants.sql1849server # [ 164.114856] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1957]: GRANT ROLE1850server # [ 164.122498] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1957]: DO1851server # [ 164.210047] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql1852server # [ 164.503381] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1961]: GRANT1853server # [ 164.542810] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql1854server # [ 164.854589] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1963]: CREATE FUNCTION1855server # [ 164.867965] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1963]: REVOKE1856server # [ 164.878172] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1963]: REVOKE1857server # [ 164.889568] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1963]: GRANT1858server # [ 164.922271] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260211120934_supabase_privileged_role.sql1859server # [ 165.220209] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1965]: DO1860server # [ 165.287459] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql1861server # [ 165.979107] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1969]: ALTER ROLE1862server # [ 166.017353] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql1863server # [ 166.667856] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1981]: DROP EXTENSION1864server # [ 166.747529] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql1865server # [ 167.103992] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1995]: CREATE FUNCTION1866server # [ 167.114783] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1995]: DROP EVENT TRIGGER1867server # [ 167.122840] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1995]: CREATE EVENT TRIGGER1868server # [ 167.153013] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql1869server # [ 167.505890] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1997]: DO1870server # [ 167.548735] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1997]: CREATE FUNCTION1871server # [ 167.588884] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql1872server # [ 168.067050] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2002]: CREATE FUNCTION1873server # [ 168.085306] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2002]: CREATE FUNCTION1874server # [ 168.148107] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running migration: /nix/store/js0m5hf160s54dcv5rwafq9rrcgmr3bn-migrations-db/migrations/20261016000001_search_path_for_supa_functions.sql1875server # [ 168.492047] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2005]: CREATE FUNCTION1876server # [ 168.509590] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2005]: CREATE FUNCTION1877server # [ 168.523870] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2005]: CREATE FUNCTION1878server # [ 168.543057] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2005]: CREATE FUNCTION1879server # [ 168.556004] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2005]: CREATE FUNCTION1880server # [ 168.567927] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2005]: CREATE FUNCTION1881server # [ 168.616891] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Running postgresql schema...1882server # [ 168.976258] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER DATABASE1883server # [ 169.009513] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER DATABASE1884server # [ 169.190748] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER ROLE1885server # [ 169.335990] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER ROLE1886server # [ 169.563133] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER ROLE1887server # [ 169.773393] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER ROLE1888server # [ 169.894937] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER ROLE1889server # [ 170.259446] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER ROLE1890server # [ 170.460037] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER ROLE1891server # [ 170.531945] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER ROLE1892server # [ 170.615567] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER ROLE1893server # [ 170.631168] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[2007]: ALTER ROLE1894server # [ 170.675659] vajsrmb87v5n6q7zw49mmp7q0dxq2gln-supabase-db-init[1450]: Database initialization complete1895server # [ 170.726186] systemd[1]: Finished Supabase Database Initialization.1896server # [ 170.728304] systemd[1]: Reached target Multi-User System.1897server # [ 170.737283] systemd[1]: Startup finished in 17.563s (kernel) + 2min 33.159s (userspace) = 2min 50.722s.1898server: (finished: waiting for unit supabase-db-init.service, in 173.38 seconds)1899subtest: Preconditions1900server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select rolsuper from pg_roles where rolname = 'postgres'"1901server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select rolsuper from pg_roles where rolname = 'postgres'", in 0.59 seconds)1902server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select current_user"1903server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select current_user", in 0.56 seconds)1904(finished: subtest: Preconditions, in 1.16 seconds)1905subtest: A non-superuser installs amcheck on PG 15, pinned to pg_catalog1906server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension amcheck"1907server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension amcheck", in 1.92 seconds)1908server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'"1909server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'", in 0.87 seconds)1910PG 15 amcheck: 1.3,pg_catalog1911(finished: subtest: A non-superuser installs amcheck on PG 15, pinned to pg_catalog, in 2.79 seconds)1912subtest: PG 15 grants reach postgres only1913server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname"1914server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname", in 0.63 seconds)1915(finished: subtest: PG 15 grants reach postgres only, in 0.63 seconds)1916subtest: amcheck dropped before upgrade, mirroring EXTENSIONS_TO_DISABLE1917server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "drop extension if exists amcheck cascade"1918server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "drop extension if exists amcheck cascade", in 0.56 seconds)1919(finished: subtest: amcheck dropped before upgrade, mirroring EXTENSIONS_TO_DISABLE, in 0.56 seconds)1920subtest: switch to postgresql 171921server # Checking switch inhibitors... done1922server # stopping the following units: postgresql.service, supabase-db-init.service1923server # [ 187.385941] nixos[2107]: switching to system configuration /nix/store/wpyq7nr77a2pbgvz20nkqkpdcj9xaz8y-nixos-system-server-test1924server # [ 187.406285] systemd[1]: supabase-db-init.service: Deactivated successfully.1925server # [ 187.413930] systemd[1]: Stopped Supabase Database Initialization.1926server # [ 187.415531] systemd[1]: supabase-db-init.service: Consumed 8.121s CPU time, 3.5M memory peak, 89.9K incoming IP traffic, 130.9K outgoing IP traffic.1927server # [ 187.508022] postgres[1393]: 2026-10-22 15:14:59.216 UTC [1393] LOG: received fast shutdown request1928server # [ 187.517408] systemd[1]: Stopping PostgreSQL Database Server...1929server # [ 187.537411] postgres[1393]: 2026-10-22 15:14:59.246 UTC [1393] LOG: aborting any active transactions1930server # [ 187.576228] postgres[1447]: 2026-10-22 15:14:59.284 UTC [1447] LOG: pg_cron scheduler shutting down1931server # [ 187.585598] systemd[1]: Stopped target Remote File Systems.1932server # [ 187.635496] postgres[1444]: 2026-10-22 15:14:59.338 UTC [1444] FATAL: terminating background worker "TimescaleDB Background Worker Launcher" due to administrator command1933server # [ 187.664737] systemd[1]: Stopped target Local File Systems.1934server # [ 187.781088] postgres[1393]: 2026-10-22 15:14:59.490 UTC [1393] LOG: background worker "pg_cron launcher" (PID 1447) exited with exit code 11935server # [ 187.904646] postgres[1393]: 2026-10-22 15:14:59.613 UTC [1393] LOG: background worker "logical replication launcher" (PID 1448) exited with exit code 11936server # [ 187.946384] postgres[1393]: 2026-10-22 15:14:59.653 UTC [1393] LOG: background worker "TimescaleDB Background Worker Launcher" (PID 1444) exited with exit code 11937server # [ 187.965047] postgres[1393]: 2026-10-22 15:14:59.675 UTC [1393] LOG: background worker "pg_net 0.20.4 worker" (PID 1475) exited with exit code 11938server # [ 187.989375] postgres[1432]: 2026-10-22 15:14:59.678 UTC [1432] LOG: shutting down1939server # [ 187.996907] postgres[1432]: 2026-10-22 15:14:59.700 UTC [1432] LOG: checkpoint starting: shutdown immediate1940server # [ 188.585535] postgres[1432]: 2026-10-22 15:15:00.294 UTC [1432] LOG: checkpoint complete: wrote 270 buffers (1.6%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.213 s, sync=0.302 s, total=0.614 s; sync files=136, longest=0.017 s, average=0.003 s; distance=1971 kB, estimate=1971 kB1941server # [ 188.813546] postgres[1393]: 2026-10-22 15:15:00.503 UTC [1393] LOG: database system is shut down1942server # [ 188.910043] systemd[1]: postgresql.service: Deactivated successfully.1943server # activating the configuration...1944server # [ 188.919149] systemd[1]: Stopped PostgreSQL Database Server.1945server # [ 188.919987] systemd[1]: postgresql.service: Consumed 41.658s CPU time, 125.6M memory peak, 54.9M written to disk, 135.4K incoming IP traffic, 94.4K outgoing IP traffic.1946server # setting up /etc...1947server # [ 197.889951] systemd[1]: Reload requested from client PID 2107 ('.switch-to-conf') (unit backdoor.service)...1948server # [ 197.896256] systemd[1]: Reloading...1949server # [ 204.981035] systemd[1]: Reloading finished in 7070 ms.1950server # restarting sysinit-reactivation.target1951server # [ 205.578505] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....1952server # [ 207.742108] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..1953server # [ 207.776229] systemd[1]: Reached target Reactivate sysinit units.1954server # reloading the following units: dbus.service1955server # [ 207.838323] systemd[1]: Reloading D-Bus System Message Bus...1956server # [ 208.577870] dbus-daemon[633]: Unknown username "systemd-timesync" in message bus configuration file1957server # [ 208.859238] dbus-daemon[633]: [system] Reloaded configuration1958server # [ 208.871263] dbus-send[2323]: method return time=1792682120.578559 sender=org.freedesktop.DBus -> destination=:1.5 serial=3 reply_serial=21959server # [ 209.148206] dbus-daemon[633]: Unknown username "systemd-timesync" in message bus configuration file1960server # [ 209.474668] dbus-daemon[633]: [system] Reloaded configuration1961server # [ 209.488244] systemd[1]: Reloaded D-Bus System Message Bus.1962server # starting the following units: postgresql.service, supabase-db-init.service1963server # [ 209.596778] systemd[1]: Reached target Remote File Systems.1964server # [ 209.607953] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore).1965server # [ 209.672087] systemd[1]: Starting Create SUID/SGID Wrappers...1966server # [ 209.684050] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).1967server # [ 209.694492] systemd[1]: Reached target Local File Systems.1968server # [ 209.695895] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met.1969server # [ 209.717609] systemd[1]: Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67).1970server # [ 209.719855] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).1971server # [ 209.739203] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).1972server # [ 209.748031] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).1973server # [ 209.953467] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki).1974server # [ 210.475473] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).1975server # [ 216.422753] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31976server # [ 217.885678] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1977server # [ 217.890855] systemd[1]: Finished Create SUID/SGID Wrappers.1978server # [ 217.897943] systemd[1]: suid-sgid-wrappers.service: Consumed 3.339s CPU time, 3.2M memory peak.1979server # [ 217.958720] systemd[1]: Starting linger-users.service...1980server # [ 218.014815] systemd[1]: Starting PostgreSQL Major Version Migration...1981server # [ 218.394581] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2457]: Starting pg_upgrade from 15 to 171982server # [ 218.440642] systemd[1]: linger-users.service: Deactivated successfully.1983server # [ 218.453634] systemd[1]: Finished linger-users.service.1984server # [ 219.306373] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: The files belonging to this database system will be owned by user "postgres".1985server # [ 219.312249] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: This user must also own the server process.1986server # [ 219.379907] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: The database cluster will be initialized with locale "en_US.UTF-8".1987server # [ 219.385711] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: The default database encoding has accordingly been set to "UTF8".1988server # [ 219.386704] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: The default text search configuration will be set to "english".1989server # [ 219.387769] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: Data page checksums are enabled.1990server # [ 219.399477] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: fixing permissions on existing directory /var/lib/postgresql/data-17 ... ok1991server # [ 219.430219] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: creating subdirectories ... ok1992server # [ 219.435168] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: selecting dynamic shared memory implementation ... posix1993server # [ 220.177632] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: selecting default "max_connections" ... 1001994server # [ 220.663332] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: selecting default "shared_buffers" ... 128MB1995server # [ 230.481210] systemd[1]: Starting Virtual Console Setup...1996server # [ 230.743688] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: selecting default time zone ... UTC1997server # [ 230.789932] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: creating configuration files ... ok1998server # [ 230.855654] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1999server # [ 230.869959] systemd[1]: Stopped Virtual Console Setup.2000server # [ 230.936997] systemd[1]: Starting Virtual Console Setup...2001server # [ 235.239454] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2002server # [ 235.407777] systemd[1]: Finished Virtual Console Setup.2003server # [ 236.325971] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: running bootstrap script ... ok2004server # [ 237.689563] systemd-logind[652]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2005server # [ 242.229993] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: performing post-bootstrap initialization ... ok2006server # [ 243.717052] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: syncing data to disk ... ok2007server # [ 243.718093] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: initdb: warning: enabling "trust" authentication for local connections2008server # [ 243.718471] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: 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.2009server # [ 243.718718] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: Success. You can now start the database server using:2010server # [ 243.719643] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2461]: /nix/store/2b08ap06lbcgyk3pnh18zsw06n7rp0vb-postgresql-and-plugins-17.11/bin/pg_ctl -D /var/lib/postgresql/data-17 -l logfile start2011server # [ 247.733965] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Performing Consistency Checks2012server # [ 247.816136] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: -----------------------------2013server # [ 247.838307] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking cluster versions ok2014server # [ 250.902716] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking database user is the install user ok2015server # [ 250.959671] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking database connection settings ok2016server # [ 251.040934] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking for prepared transactions ok2017server # [ 251.049380] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking for contrib/isn with bigint-passing mismatch ok2018server # [ 251.662456] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking data type usage ok2019server # [ 251.870543] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking for not-null constraint inconsistencies ok2020server # [ 252.495627] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Creating dump of global objects ok2021server # [ 254.934333] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Creating dump of database schemas ok2022server # [ 258.203813] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking for presence of required libraries ok2023server # [ 258.285803] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking database user is the install user ok2024server # [ 258.373750] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking for prepared transactions ok2025server # [ 258.374921] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking for new cluster tablespace directories ok2026server # [ 258.376736] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: If pg_upgrade fails after this point, you must re-initdb the2027server # [ 258.377797] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: new cluster before continuing.2028server # [ 258.380022] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Performing Upgrade2029server # [ 258.382087] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: ------------------2030server # [ 258.447500] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Setting locale and encoding for new cluster ok2031server # [ 260.637518] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Analyzing all rows in the new cluster ok2032server # [ 261.610111] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Freezing all rows in the new cluster ok2033server # [ 261.939461] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Deleting files from new pg_xact ok2034server # [ 262.068719] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Copying old pg_xact to new server ok2035server # [ 262.377837] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Setting oldest XID for new cluster ok2036server # [ 263.304956] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Setting next transaction ID and epoch for new cluster ok2037server # [ 263.310626] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Deleting files from new pg_multixact/offsets ok2038server # [ 263.443607] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Copying old pg_multixact/offsets to new server ok2039server # [ 263.446317] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Deleting files from new pg_multixact/members ok2040server # [ 263.574286] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Copying old pg_multixact/members to new server ok2041server # [ 263.864589] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Setting next multixact ID and offset for new cluster ok2042server # [ 264.153490] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Resetting WAL archives ok2043server # [ 266.440153] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Setting frozenxid and minmxid counters in new cluster ok2044server # [ 267.403074] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Restoring global objects in the new cluster ok2045server # [ 270.651743] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Restoring database schemas in the new cluster ok2046server # [ 271.450729] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Copying user relation files ok2047server # [ 271.761674] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Setting next OID for new cluster ok2048server # [ 273.359319] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Sync data directory to disk ok2049server # [ 273.363789] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Creating script to delete old cluster ok2050server # [ 277.194947] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Checking for extension updates notice2051server # [ 277.196548] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Your installation contains extensions that should be updated2052server # [ 277.201460] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: with the ALTER EXTENSION command. The file2053server # [ 277.202955] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: update_extensions.sql2054server # [ 277.205446] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: when executed by psql by the database superuser will update2055server # [ 277.207888] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: these extensions.2056server # [ 277.504908] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Upgrade Complete2057server # [ 277.506718] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: ----------------2058server # [ 277.507357] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Optimizer statistics are not transferred by pg_upgrade.2059server # [ 277.508697] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Once you start the new server, consider running:2060server # [ 277.509765] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: /nix/store/2b08ap06lbcgyk3pnh18zsw06n7rp0vb-postgresql-and-plugins-17.11/bin/vacuumdb -U supabase_admin --all --analyze-in-stages2061server # [ 277.511432] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: Running this script will delete the old cluster's data files:2062server # [ 277.513732] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2612]: ./delete_old_cluster.sh2063server # [ 277.538531] r3rnm2d07q4mm59ayprifm5pi0946cr2-postgresql-migrate[2457]: pg_upgrade completed successfully2064server # [ 277.562132] systemd[1]: Finished PostgreSQL Major Version Migration.2065server # [ 277.607792] systemd[1]: Starting PostgreSQL Database Server...2066server # [ 278.807111] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[2778]: Validating PostgreSQL configuration...2067server # [ 279.095952] bsy6dnz3c440mxlx9klpan0n803znp5j-postgresql-init[2790]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault2068server # [ 279.642629] postgres[2792]: 2026-10-22 15:16:31.347 UTC [2792] LOG: pgaudit extension initialized2069server # [ 279.928252] postgres[2792]: 2026-10-22 15:16:31.638 UTC [2792] LOG: pgsodium primary server secret key loaded2070server # [ 280.112925] postgres[2792]: 2026-10-22 15:16:31.824 UTC [2792] LOG: vault primary server secret key loaded2071server # [ 280.329303] postgres[2792]: 2026-10-22 15:16:32.040 UTC [2792] LOG: starting PostgreSQL 17.11 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit2072server # [ 280.339033] postgres[2792]: 2026-10-22 15:16:32.050 UTC [2792] LOG: listening on IPv4 address "0.0.0.0", port 54322073server # [ 280.342184] postgres[2792]: 2026-10-22 15:16:32.051 UTC [2792] LOG: listening on IPv6 address "::", port 54322074server # [ 280.355385] postgres[2792]: 2026-10-22 15:16:32.066 UTC [2792] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"2075server # [ 280.413838] postgres[2797]: 2026-10-22 15:16:32.121 UTC [2797] LOG: database system was shut down at 2026-10-22 15:16:29 UTC2076server # [ 280.502802] postgres[2792]: 2026-10-22 15:16:32.212 UTC [2792] LOG: database system is ready to accept connections2077server # [ 280.535519] systemd[1]: Started PostgreSQL Database Server.2078server # [ 280.591527] systemd[1]: Starting Supabase Database Initialization...2079server # [ 280.662350] postgres[2801]: 2026-10-22 15:16:32.362 UTC [2801] LOG: pg_cron scheduler started2080server # [ 280.809867] systemd[1]: Finished Supabase Database Initialization.2081server # the following new units were started: postgresql-migrate.service, sys-devices-platform-4010000000.pcie-pci0000:00-0000:00:0b.0-virtio9-virtio\x2dports-vport9p0.device, sys-devices-virtual-input-mice.device, sys-devices-virtual-misc-rfkill.device, sys-devices-virtual-misc-tun.device, sys-devices-virtual-mtd-mtd0ro.device, sysinit-reactivation.target, systemd-rfkill.socket, systemd-tmpfiles-resetup.service, systemd-vconsole-setup.service2082server # [ 281.106451] nixos[2107]: finished switching to system configuration /nix/store/wpyq7nr77a2pbgvz20nkqkpdcj9xaz8y-nixos-system-server-test2083server: waiting for unit postgresql.service2084server: (finished: waiting for unit postgresql.service, in 0.53 seconds)2085(finished: subtest: switch to postgresql 17, in 104.11 seconds)2086subtest: amcheck recreated fresh on PG 17, mirroring the EXTENSIONS_TO_DISABLE fix2087server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension if not exists amcheck cascade"2088server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension if not exists amcheck cascade", in 1.10 seconds)2089server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select default_version from pg_available_extensions where name = 'amcheck'"2090server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select default_version from pg_available_extensions where name = 'amcheck'", in 0.76 seconds)2091server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'"2092server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'", in 0.35 seconds)2093server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname"2094server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname", in 0.38 seconds)2095(finished: subtest: amcheck recreated fresh on PG 17, mirroring the EXTENSIONS_TO_DISABLE fix, in 2.58 seconds)2096subtest: The support workflow still works after the upgrade2097server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create table amcheck_heap(i int primary key) using heap; insert into amcheck_heap select generate_series(1, 100)"2098server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create table amcheck_heap(i int primary key) using heap; insert into amcheck_heap select generate_series(1, 100)", in 0.41 seconds)2099server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass)"2100server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass)", in 0.40 seconds)2101server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass, false, false)"2102server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('amcheck_heap_pkey'::regclass, false, false)", in 0.37 seconds)2103server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('auth.users_pkey'::regclass)"2104server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select pg_catalog.bt_index_check('auth.users_pkey'::regclass)", in 0.38 seconds)2105(finished: subtest: The support workflow still works after the upgrade, in 1.56 seconds)2106(finished: run the VM test script, in 287.54 seconds)2107test script finished in 287.88s2108cleanup2109kill machine (pid 9)2110qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/y88crn50yx35fiiwcjx6xqwi6ahk7mlq-python3-3.13.11/bin/python3.13)2111vde_switch: EOF data port: Interrupted system call2112kill vlan (pid 7)2113(finished: cleanup, in 0.00 seconds)2114vde_switch: Caught signal 15, cleaning up and exiting