nixbot

builds

cancelled checks.aarch64-linux.ext-amcheck-upgrade build #163 · raw · eval 31.0 s · 1.9 GiB allocated · ·

1these 13 derivations will be built:2  /nix/store/c2fy76sb4l1a9bircmk53qy752ymmh9h-postgresql-migrate.drv3  /nix/store/q2cyar3rvwil73pryzpxyd3ni38795rl-unit-postgresql-migrate.service.drv4  /nix/store/xbhbrbm7jn3fsknqsm7v2gdgvy4v9bvh-unit-postgresql.service.drv5  /nix/store/ifghd86p4zmd9373zwpyr5vn9dxiirjk-system-units.drv6  /nix/store/mrrr9xz4b4hd28yjc7qdjx6x7f37zy2a-etc.drv7  /nix/store/kn21khmc00g1xh07msy7svv2jm7zkzhk-activate.drv8  /nix/store/vzz9c6myxag79wjl0lv40d2369gzkvrb-nixos-system-server-test.drv9  /nix/store/kvzlnia3w0inrycnxpna91dz3zfkcpbn-nixos-system-server-test.drv10  /nix/store/gwhnzwz8i52vd7li7bzmc0qik50cgdaa-closure-info.drv11  /nix/store/4ld8h05ib8jzs3rm6rznrj9c0539c0h1-run-nixos-vm.drv12  /nix/store/8bfsyh4la14k9b6fcv5285r1nzzhjr2h-nixos-vm.drv13  /nix/store/dcpmksvr0syqkh95vb7dymfgwyg47plm-nixos-test-driver-amcheck-upgrade.drv14  /nix/store/yl6x1czp4vkmns2vcwdh9n3cqngxh7pr-vm-test-run-amcheck-upgrade.drv15this path will be fetched (14.9 KiB download, 61.1 KiB unpacked):16  /nix/store/3kiik8dkh8ish7bwxc1zs3lmwcbdl2vb-processed-postgresql-config-1717building '/nix/store/xbhbrbm7jn3fsknqsm7v2gdgvy4v9bvh-unit-postgresql.service.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247'18building '/nix/store/xbhbrbm7jn3fsknqsm7v2gdgvy4v9bvh-unit-postgresql.service.drv'19building '/nix/store/kvzlnia3w0inrycnxpna91dz3zfkcpbn-nixos-system-server-test.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247'20building '/nix/store/kvzlnia3w0inrycnxpna91dz3zfkcpbn-nixos-system-server-test.drv'21building '/nix/store/gwhnzwz8i52vd7li7bzmc0qik50cgdaa-closure-info.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247'22building '/nix/store/4ld8h05ib8jzs3rm6rznrj9c0539c0h1-run-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247'23building '/nix/store/4ld8h05ib8jzs3rm6rznrj9c0539c0h1-run-nixos-vm.drv'24building '/nix/store/8bfsyh4la14k9b6fcv5285r1nzzhjr2h-nixos-vm.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247'25building '/nix/store/dcpmksvr0syqkh95vb7dymfgwyg47plm-nixos-test-driver-amcheck-upgrade.drv' on 'ssh-ng://nixbot-remote-build@78.232.36.247'26building '/nix/store/yl6x1czp4vkmns2vcwdh9n3cqngxh7pr-vm-test-run-amcheck-upgrade.drv' on 'ssh-ng://builder@mac-linux-builder'27building '/nix/store/yl6x1czp4vkmns2vcwdh9n3cqngxh7pr-vm-test-run-amcheck-upgrade.drv'28vm-test-run-amcheck-upgrade> Machine state will be reset. To keep it, pass --keep-vm-state29vm-test-run-amcheck-upgrade> start all VLans30vm-test-run-amcheck-upgrade> start vlan31vm-test-run-amcheck-upgrade> running vlan (pid 7; ctl /build/vde1.ctl)32vm-test-run-amcheck-upgrade> (finished: start all VLans, in 0.00 seconds)33vm-test-run-amcheck-upgrade> Test will time out and terminate in 3600 seconds34vm-test-run-amcheck-upgrade> run the VM test script35vm-test-run-amcheck-upgrade> additionally exposed symbols:36vm-test-run-amcheck-upgrade>     server,37vm-test-run-amcheck-upgrade>     vlan1,38vm-test-run-amcheck-upgrade>     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, debug39vm-test-run-amcheck-upgrade> start all VMs40vm-test-run-amcheck-upgrade> server: starting vm41vm-test-run-amcheck-upgrade> mke2fs 1.47.3 (8-Jul-2025)42vm-test-run-amcheck-upgrade> qemu-system-aarch64: Could not access KVM kernel module: No such file or directory43vm-test-run-amcheck-upgrade> qemu-system-aarch64: failed to initialize kvm: No such file or directory44vm-test-run-amcheck-upgrade> qemu-system-aarch64: falling back to tcg45vm-test-run-amcheck-upgrade> server # Disk image does not exist, creating the virtualisation disk image...46vm-test-run-amcheck-upgrade> server: QEMU running (pid 9)47vm-test-run-amcheck-upgrade> server # Formatting '/build/vm-state-server/tmp.Ikn20cHflA', fmt=raw size=107374182448vm-test-run-amcheck-upgrade> server # Discarding device blocks:      0/262144             done49vm-test-run-amcheck-upgrade> server # Creating filesystem with 262144 4k blocks and 65536 inodes50vm-test-run-amcheck-upgrade> server # Filesystem UUID: 58b44652-d183-465a-a4c2-02a1807688ff51vm-test-run-amcheck-upgrade> server # Superblock backups stored on blocks:52vm-test-run-amcheck-upgrade> server # 	32768, 98304, 163840, 22937653vm-test-run-amcheck-upgrade> server # 54vm-test-run-amcheck-upgrade> server # Allocating group tables: 0/8   done55vm-test-run-amcheck-upgrade> server # Writing inode tables: 0/8   done56vm-test-run-amcheck-upgrade> server # Creating journal (8192 blocks): done57vm-test-run-amcheck-upgrade> server # Writing superblocks and filesystem accounting information: 0/8   done58vm-test-run-amcheck-upgrade> server # 59vm-test-run-amcheck-upgrade> server # Virtualisation disk image created.60vm-test-run-amcheck-upgrade> (finished: start all VMs, in 0.15 seconds)61vm-test-run-amcheck-upgrade> server: waiting for unit supabase-db-init.service62vm-test-run-amcheck-upgrade> server: waiting for the VM to finish booting63vm-test-run-amcheck-upgrade> server # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]64vm-test-run-amcheck-upgrade> server # [    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 202565vm-test-run-amcheck-upgrade> server # [    0.000000] KASLR enabled66vm-test-run-amcheck-upgrade> server # [    0.000000] random: crng init done67vm-test-run-amcheck-upgrade> server # [    0.000000] Machine model: linux,dummy-virt68vm-test-run-amcheck-upgrade> server # [    0.000000] efi: UEFI not found.69vm-test-run-amcheck-upgrade> server # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT70vm-test-run-amcheck-upgrade> server # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]71vm-test-run-amcheck-upgrade> server # [    0.000000] NODE_DATA(0) allocated [mem 0x13f602200-0x13f60593f]72vm-test-run-amcheck-upgrade> server # [    0.000000] Zone ranges:73vm-test-run-amcheck-upgrade> server # [    0.000000]   DMA      [mem 0x0000000040000000-0x00000000ffffffff]74vm-test-run-amcheck-upgrade> server # [    0.000000]   DMA32    empty75vm-test-run-amcheck-upgrade> server # [    0.000000]   Normal   [mem 0x0000000100000000-0x000000013fffffff]76vm-test-run-amcheck-upgrade> server # [    0.000000]   Device   empty77vm-test-run-amcheck-upgrade> server # [    0.000000] Movable zone start for each node78vm-test-run-amcheck-upgrade> server # [    0.000000] Early memory node ranges79vm-test-run-amcheck-upgrade> server # [    0.000000]   node   0: [mem 0x0000000040000000-0x000000013fffffff]80vm-test-run-amcheck-upgrade> server # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]81vm-test-run-amcheck-upgrade> server # [    0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -182vm-test-run-amcheck-upgrade> server # [    0.000000] psci: probing for conduit method from DT.83vm-test-run-amcheck-upgrade> server # [    0.000000] psci: PSCIv1.1 detected in firmware.84vm-test-run-amcheck-upgrade> server # [    0.000000] psci: Using standard PSCI v0.2 function IDs85vm-test-run-amcheck-upgrade> server # [    0.000000] psci: Trusted OS migration not required86vm-test-run-amcheck-upgrade> server # [    0.000000] psci: SMC Calling Convention v1.087vm-test-run-amcheck-upgrade> server # [    0.000000] percpu: Embedded 88 pages/cpu s180056 r65536 d114856 u36044888vm-test-run-amcheck-upgrade> server # [    0.000000] Detected PIPT I-cache on CPU089vm-test-run-amcheck-upgrade> server # [    0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)90vm-test-run-amcheck-upgrade> server # [    0.000000] CPU features: detected: GIC system register CPU interface91vm-test-run-amcheck-upgrade> server # [    0.000000] CPU features: detected: HCRX_EL2 register92vm-test-run-amcheck-upgrade> server # [    0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2)93vm-test-run-amcheck-upgrade> server # [    0.000000] CPU features: detected: Spectre-v494vm-test-run-amcheck-upgrade> server # [    0.000000] alternatives: applying boot alternatives95vm-test-run-amcheck-upgrade> server # [    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/c1qrwph6vbfgrdwf921g14p7iw27nyjb-nixos-system-server-test/init regInfo=/nix/store/s79pdk74w38r55gnk5vls6a3ycmgrmxf-closure-info/registration console=ttyAMA0,115200n8 console=tty096vm-test-run-amcheck-upgrade> server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/store/s79pdk74w38r55gnk5vls6a3ycmgrmxf-closure-info/registration", will be passed to user space.97vm-test-run-amcheck-upgrade> server # [    0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)98vm-test-run-amcheck-upgrade> server # [    0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)99vm-test-run-amcheck-upgrade> server # [    0.000000] Fallback order for Node 0: 0100vm-test-run-amcheck-upgrade> server # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1048576101vm-test-run-amcheck-upgrade> server # [    0.000000] Policy zone: Normal102vm-test-run-amcheck-upgrade> server # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off103vm-test-run-amcheck-upgrade> server # [    0.000000] software IO TLB: area num 2.104vm-test-run-amcheck-upgrade> server # [    0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)105vm-test-run-amcheck-upgrade> server # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1106vm-test-run-amcheck-upgrade> server # [    0.000000] allocated 8388608 bytes of page_ext107vm-test-run-amcheck-upgrade> server # [    0.000000] ftrace: allocating 72257 entries in 283 pages108vm-test-run-amcheck-upgrade> server # [    0.000000] ftrace: allocated 283 pages with 5 groups109vm-test-run-amcheck-upgrade> server # [    0.000000] rcu: Hierarchical RCU implementation.110vm-test-run-amcheck-upgrade> server # [    0.000000] rcu: 	RCU event tracing is enabled.111vm-test-run-amcheck-upgrade> server # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=2.112vm-test-run-amcheck-upgrade> server # [    0.000000] 	Rude variant of Tasks RCU enabled.113vm-test-run-amcheck-upgrade> server # [    0.000000] 	Tracing variant of Tasks RCU enabled.114vm-test-run-amcheck-upgrade> server # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.115vm-test-run-amcheck-upgrade> server # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2116vm-test-run-amcheck-upgrade> server # [    0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.117vm-test-run-amcheck-upgrade> server # [    0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2.118vm-test-run-amcheck-upgrade> server # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0119vm-test-run-amcheck-upgrade> server # [    0.000000] GICv3: 256 SPIs implemented120vm-test-run-amcheck-upgrade> server # [    0.000000] GICv3: 0 Extended SPIs implemented121vm-test-run-amcheck-upgrade> server # [    0.000000] Root IRQ handler: gic_handle_irq122vm-test-run-amcheck-upgrade> server # [    0.000000] GICv3: GICv3 features: 16 PPIs123vm-test-run-amcheck-upgrade> server # [    0.000000] GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0124vm-test-run-amcheck-upgrade> server # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000125vm-test-run-amcheck-upgrade> server # [    0.000000] ITS [mem 0x08080000-0x0809ffff]126vm-test-run-amcheck-upgrade> server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100ad0000 (indirect, esz 8, psz 64K, shr 1)127vm-test-run-amcheck-upgrade> server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100ae0000 (flat, esz 8, psz 64K, shr 1)128vm-test-run-amcheck-upgrade> server # [    0.000000] GICv3: using LPI property table @0x0000000100b00000129vm-test-run-amcheck-upgrade> server # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b10000130vm-test-run-amcheck-upgrade> server # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.131vm-test-run-amcheck-upgrade> server # [    0.000000] arch_timer: cp15 timer(s) running at 1000.00MHz (virt).132vm-test-run-amcheck-upgrade> server # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns133vm-test-run-amcheck-upgrade> server # [    0.000038] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns134vm-test-run-amcheck-upgrade> server # [    0.004546] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)135vm-test-run-amcheck-upgrade> server # [    0.016893] Console: colour dummy device 80x25136vm-test-run-amcheck-upgrade> server # [    0.018575] printk: legacy console [tty0] enabled137vm-test-run-amcheck-upgrade> server # [    0.024766] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)138vm-test-run-amcheck-upgrade> server # [    0.025456] pid_max: default: 32768 minimum: 301139vm-test-run-amcheck-upgrade> server # [    0.028046] LSM: initializing lsm=capability,landlock,yama,bpf140vm-test-run-amcheck-upgrade> server # [    0.030067] landlock: Up and running.141vm-test-run-amcheck-upgrade> server # [    0.030139] Yama: becoming mindful.142vm-test-run-amcheck-upgrade> server # [    0.034864] LSM support for eBPF active143vm-test-run-amcheck-upgrade> server # [    0.038906] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)144vm-test-run-amcheck-upgrade> server # [    0.039112] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)145vm-test-run-amcheck-upgrade> server # [    0.072866] cacheinfo: Unable to detect cache hierarchy for CPU 0146vm-test-run-amcheck-upgrade> server # [    0.087835] rcu: Hierarchical SRCU implementation.147vm-test-run-amcheck-upgrade> server # [    0.087942] rcu: 	Max phase no-delay instances is 1000.148vm-test-run-amcheck-upgrade> server # [    0.089513] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level149vm-test-run-amcheck-upgrade> server # [    0.097177] fsl-mc MSI: its@8080000 domain created150vm-test-run-amcheck-upgrade> server # [    0.099890] EFI services will not be available.151vm-test-run-amcheck-upgrade> server # [    0.102209] smp: Bringing up secondary CPUs ...152vm-test-run-amcheck-upgrade> server # [    0.107830] Detected PIPT I-cache on CPU1153vm-test-run-amcheck-upgrade> server # [    0.109221] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000154vm-test-run-amcheck-upgrade> server # [    0.109954] GICv3: CPU1: using allocated LPI pending table @0x0000000100b20000155vm-test-run-amcheck-upgrade> server # [    0.111721] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]156vm-test-run-amcheck-upgrade> server # [    0.115802] smp: Brought up 1 node, 2 CPUs157vm-test-run-amcheck-upgrade> server # [    0.115977] SMP: Total of 2 processors activated.158vm-test-run-amcheck-upgrade> server # [    0.116029] CPU: All CPU(s) started at EL1159vm-test-run-amcheck-upgrade> server # [    0.116216] CPU features: detected: Branch Target Identification160vm-test-run-amcheck-upgrade> server # [    0.116268] CPU features: detected: 32-bit EL0 Support161vm-test-run-amcheck-upgrade> server # [    0.116301] CPU features: detected: 32-bit EL1 Support162vm-test-run-amcheck-upgrade> server # [    0.116327] CPU features: detected: ARMv8.4 Translation Table Level163vm-test-run-amcheck-upgrade> server # [    0.116364] CPU features: detected: Instruction cache invalidation not required for I/D coherence164vm-test-run-amcheck-upgrade> server # [    0.116411] CPU features: detected: Data cache clean to the PoU not required for I/D coherence165vm-test-run-amcheck-upgrade> server # [    0.116480] CPU features: detected: Common not Private translations166vm-test-run-amcheck-upgrade> server # [    0.116506] CPU features: detected: CRC32 instructions167vm-test-run-amcheck-upgrade> server # [    0.116529] CPU features: detected: Data cache clean to Point of Deep Persistence168vm-test-run-amcheck-upgrade> server # [    0.116558] CPU features: detected: Data cache clean to Point of Persistence169vm-test-run-amcheck-upgrade> server # [    0.116586] CPU features: detected: Data independent timing control (DIT)170vm-test-run-amcheck-upgrade> server # [    0.116616] CPU features: detected: E0PD171vm-test-run-amcheck-upgrade> server # [    0.116637] CPU features: detected: Enhanced Counter Virtualization172vm-test-run-amcheck-upgrade> server # [    0.116667] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)173vm-test-run-amcheck-upgrade> server # [    0.116693] CPU features: detected: Enhanced Privileged Access Never174vm-test-run-amcheck-upgrade> server # [    0.116718] CPU features: detected: Enhanced Virtualization Traps175vm-test-run-amcheck-upgrade> server # [    0.116742] CPU features: detected: Fine Grained Traps176vm-test-run-amcheck-upgrade> server # [    0.116806] CPU features: detected: Generic authentication (IMP DEF algorithm)177vm-test-run-amcheck-upgrade> server # [    0.116896] CPU features: detected: RCpc load-acquire (LDAPR)178vm-test-run-amcheck-upgrade> server # [    0.116986] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)179vm-test-run-amcheck-upgrade> server # [    0.117019] CPU features: detected: LSE atomic instructions180vm-test-run-amcheck-upgrade> server # [    0.117043] CPU features: detected: Memory Copy and Memory Set instructions181vm-test-run-amcheck-upgrade> server # [    0.117069] CPU features: detected: Privileged Access Never182vm-test-run-amcheck-upgrade> server # [    0.117093] CPU features: detected: RAS Extension Support183vm-test-run-amcheck-upgrade> server # [    0.117116] CPU features: detected: Random Number Generator184vm-test-run-amcheck-upgrade> server # [    0.117143] CPU features: detected: Speculation barrier (SB)185vm-test-run-amcheck-upgrade> server # [    0.117168] CPU features: detected: Stage-2 Force Write-Back186vm-test-run-amcheck-upgrade> server # [    0.117195] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality187vm-test-run-amcheck-upgrade> server # [    0.117228] CPU features: detected: TLB range maintenance instructions188vm-test-run-amcheck-upgrade> server # [    0.117256] CPU features: detected: WFx with timeout189vm-test-run-amcheck-upgrade> server # [    0.117303] CPU features: detected: Speculative Store Bypassing Safe (SSBS)190vm-test-run-amcheck-upgrade> server # [    0.117336] CPU features: detected: Scalable Vector Extension191vm-test-run-amcheck-upgrade> server # [    0.126930] alternatives: applying system-wide alternatives192vm-test-run-amcheck-upgrade> server # [    0.149067] CPU features: detected: Hardware dirty bit management on CPU0-1193vm-test-run-amcheck-upgrade> server # [    0.149748] SVE: maximum available vector length 256 bytes per vector194vm-test-run-amcheck-upgrade> server # [    0.149840] SVE: default vector length 64 bytes per vector195vm-test-run-amcheck-upgrade> server # [    0.163699] Memory: 3922876K/4194304K available (23296K kernel code, 6546K rwdata, 24596K rodata, 4416K init, 1047K bss, 223164K reserved, 32768K cma-reserved)196vm-test-run-amcheck-upgrade> server # [    0.190498] devtmpfs: initialized197vm-test-run-amcheck-upgrade> server # [    0.225256] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns198vm-test-run-amcheck-upgrade> server # [    0.225823] futex hash table entries: 512 (order: 3, 32768 bytes, linear)199vm-test-run-amcheck-upgrade> server # [    0.229698] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL200vm-test-run-amcheck-upgrade> server # [    0.229798] 0 pages in range for non-PLT usage201vm-test-run-amcheck-upgrade> server # [    0.229842] 509248 pages in range for PLT usage202vm-test-run-amcheck-upgrade> server # [    0.233843] pinctrl core: initialized pinctrl subsystem203vm-test-run-amcheck-upgrade> server # [    0.245635] DMI not present or invalid.204vm-test-run-amcheck-upgrade> server # [    0.269639] NET: Registered PF_NETLINK/PF_ROUTE protocol family205vm-test-run-amcheck-upgrade> server # [    0.285594] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations206vm-test-run-amcheck-upgrade> server # [    0.287025] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations207vm-test-run-amcheck-upgrade> server # [    0.289205] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations208vm-test-run-amcheck-upgrade> server # [    0.289531] audit: initializing netlink subsys (disabled)209vm-test-run-amcheck-upgrade> server # [    0.292880] audit: type=2000 audit(0.204:1): state=initialized audit_enabled=0 res=1210vm-test-run-amcheck-upgrade> server # [    0.299728] thermal_sys: Registered thermal governor 'fair_share'211vm-test-run-amcheck-upgrade> server # [    0.299793] thermal_sys: Registered thermal governor 'bang_bang'212vm-test-run-amcheck-upgrade> server # [    0.299865] thermal_sys: Registered thermal governor 'step_wise'213vm-test-run-amcheck-upgrade> server # [    0.299896] thermal_sys: Registered thermal governor 'user_space'214vm-test-run-amcheck-upgrade> server # [    0.299928] thermal_sys: Registered thermal governor 'power_allocator'215vm-test-run-amcheck-upgrade> server # [    0.301213] cpuidle: using governor ladder216vm-test-run-amcheck-upgrade> server # [    0.301793] cpuidle: using governor menu217vm-test-run-amcheck-upgrade> server # [    0.303921] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.218vm-test-run-amcheck-upgrade> server # [    0.304879] ASID allocator initialised with 65536 entries219vm-test-run-amcheck-upgrade> server # [    0.312578] Serial: AMBA PL011 UART driver220vm-test-run-amcheck-upgrade> server # [    0.369647] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1221vm-test-run-amcheck-upgrade> server # [    0.371984] printk: legacy console [ttyAMA0] enabled222vm-test-run-amcheck-upgrade> server # [    0.409361] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages223vm-test-run-amcheck-upgrade> server # [    0.409971] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page224vm-test-run-amcheck-upgrade> server # [    0.410165] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages225vm-test-run-amcheck-upgrade> server # [    0.410590] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page226vm-test-run-amcheck-upgrade> server # [    0.411504] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages227vm-test-run-amcheck-upgrade> server # [    0.411622] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page228vm-test-run-amcheck-upgrade> server # [    0.412070] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages229vm-test-run-amcheck-upgrade> server # [    0.412292] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page230vm-test-run-amcheck-upgrade> server # [    0.425723] fbcon: Taking over console231vm-test-run-amcheck-upgrade> server # [    0.426371] ACPI: Interpreter disabled.232vm-test-run-amcheck-upgrade> server # [    0.434839] iommu: Default domain type: Translated233vm-test-run-amcheck-upgrade> server # [    0.435244] iommu: DMA domain TLB invalidation policy: strict mode234vm-test-run-amcheck-upgrade> server # [    0.439278] SCSI subsystem initialized235vm-test-run-amcheck-upgrade> server # [    0.443659] usbcore: registered new interface driver usbfs236vm-test-run-amcheck-upgrade> server # [    0.444010] usbcore: registered new interface driver hub237vm-test-run-amcheck-upgrade> server # [    0.444257] usbcore: registered new device driver usb238vm-test-run-amcheck-upgrade> server # [    0.447822] pps_core: LinuxPPS API ver. 1 registered239vm-test-run-amcheck-upgrade> server # [    0.447964] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>240vm-test-run-amcheck-upgrade> server # [    0.448201] PTP clock support registered241vm-test-run-amcheck-upgrade> server # [    0.448630] EDAC MC: Ver: 3.0.0242vm-test-run-amcheck-upgrade> server # [    0.452140] scmi_core: SCMI protocol bus registered243vm-test-run-amcheck-upgrade> server # [    0.456097] FPGA manager framework244vm-test-run-amcheck-upgrade> server # [    0.458924] Advanced Linux Sound Architecture Driver Initialized.245vm-test-run-amcheck-upgrade> server # [    0.468245] vgaarb: loaded246vm-test-run-amcheck-upgrade> server # [    0.473571] clocksource: Switched to clocksource arch_sys_counter247vm-test-run-amcheck-upgrade> server # [    0.479581] VFS: Disk quotas dquot_6.6.0248vm-test-run-amcheck-upgrade> server # [    0.479880] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)249vm-test-run-amcheck-upgrade> server # [    0.483433] netfs: FS-Cache loaded250vm-test-run-amcheck-upgrade> server # [    0.485625] pnp: PnP ACPI: disabled251vm-test-run-amcheck-upgrade> server # [    0.514185] NET: Registered PF_INET protocol family252vm-test-run-amcheck-upgrade> server # [    0.516847] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)253vm-test-run-amcheck-upgrade> server # [    0.641771] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)254vm-test-run-amcheck-upgrade> server # [    0.642978] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)255vm-test-run-amcheck-upgrade> server # [    0.643621] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)256vm-test-run-amcheck-upgrade> server # [    0.645808] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)257vm-test-run-amcheck-upgrade> server # [    0.646693] TCP: Hash tables configured (established 32768 bind 32768)258vm-test-run-amcheck-upgrade> server # [    0.648383] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)259vm-test-run-amcheck-upgrade> server # [    0.648849] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)260vm-test-run-amcheck-upgrade> server # [    0.649878] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)261vm-test-run-amcheck-upgrade> server # [    0.651639] NET: Registered PF_UNIX/PF_LOCAL protocol family262vm-test-run-amcheck-upgrade> server # [    0.652227] NET: Registered PF_XDP protocol family263vm-test-run-amcheck-upgrade> server # [    0.652444] PCI: CLS 0 bytes, default 64264vm-test-run-amcheck-upgrade> server # [    0.656540] Trying to unpack rootfs image as initramfs...265vm-test-run-amcheck-upgrade> server # [    0.658706] kvm [1]: HYP mode not available266vm-test-run-amcheck-upgrade> server # [    0.786641] Initialise system trusted keyrings267vm-test-run-amcheck-upgrade> server # [    0.788364] workingset: timestamp_bits=42 max_order=20 bucket_order=0268vm-test-run-amcheck-upgrade> server # [    0.795148] squashfs: version 4.0 (2009/01/31) Phillip Lougher269vm-test-run-amcheck-upgrade> server # [    0.795974] 9p: Installing v9fs 9p2000 file system support270vm-test-run-amcheck-upgrade> server # [    0.861870] Key type asymmetric registered271vm-test-run-amcheck-upgrade> server # [    0.862537] Asymmetric key parser 'x509' registered272vm-test-run-amcheck-upgrade> server # [    0.863271] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244)273vm-test-run-amcheck-upgrade> server # [    0.864280] io scheduler mq-deadline registered274vm-test-run-amcheck-upgrade> server # [    0.864421] io scheduler kyber registered275vm-test-run-amcheck-upgrade> server # [    0.893636] pl061_gpio 9030000.pl061: PL061 GPIO chip registered276vm-test-run-amcheck-upgrade> server # [    0.902128] ledtrig-cpu: registered to indicate activity on CPUs277vm-test-run-amcheck-upgrade> server # [    0.906629] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:278vm-test-run-amcheck-upgrade> server # [    0.907376] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000279vm-test-run-amcheck-upgrade> server # [    0.907957] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000280vm-test-run-amcheck-upgrade> server # [    0.908159] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000281vm-test-run-amcheck-upgrade> server # [    0.908877] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits282vm-test-run-amcheck-upgrade> server # [    0.910285] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]283vm-test-run-amcheck-upgrade> server # [    0.911839] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00284vm-test-run-amcheck-upgrade> server # [    0.912222] pci_bus 0000:00: root bus resource [bus 00-ff]285vm-test-run-amcheck-upgrade> server # [    0.912400] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]286vm-test-run-amcheck-upgrade> server # [    0.912531] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]287vm-test-run-amcheck-upgrade> server # [    0.912896] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]288vm-test-run-amcheck-upgrade> server # [    0.915592] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint289vm-test-run-amcheck-upgrade> server # [    0.919052] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint290vm-test-run-amcheck-upgrade> server # [    0.919409] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]291vm-test-run-amcheck-upgrade> server # [    0.919560] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]292vm-test-run-amcheck-upgrade> server # [    0.919715] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]293vm-test-run-amcheck-upgrade> server # [    0.919891] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]294vm-test-run-amcheck-upgrade> server # [    0.920491] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint295vm-test-run-amcheck-upgrade> server # [    0.920661] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]296vm-test-run-amcheck-upgrade> server # [    0.920770] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]297vm-test-run-amcheck-upgrade> server # [    0.920893] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298vm-test-run-amcheck-upgrade> server # [    0.921885] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint299vm-test-run-amcheck-upgrade> server # [    0.922890] pci 0000:00:03.0: BAR 0 [io  0x0000-0x003f]300vm-test-run-amcheck-upgrade> server # [    0.923012] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]301vm-test-run-amcheck-upgrade> server # [    0.923138] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]302vm-test-run-amcheck-upgrade> server # [    0.923723] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint303vm-test-run-amcheck-upgrade> server # [    0.923878] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]304vm-test-run-amcheck-upgrade> server # [    0.923984] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]305vm-test-run-amcheck-upgrade> server # [    0.924100] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]306vm-test-run-amcheck-upgrade> server # [    0.924589] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint307vm-test-run-amcheck-upgrade> server # [    0.924757] pci 0000:00:05.0: BAR 0 [io  0x0000-0x001f]308vm-test-run-amcheck-upgrade> server # [    0.924859] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]309vm-test-run-amcheck-upgrade> server # [    0.925007] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]310vm-test-run-amcheck-upgrade> server # [    0.925877] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint311vm-test-run-amcheck-upgrade> server # [    0.926382] pci 0000:00:06.0: BAR 0 [io  0x0000-0x007f]312vm-test-run-amcheck-upgrade> server # [    0.926511] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]313vm-test-run-amcheck-upgrade> server # [    0.926645] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]314vm-test-run-amcheck-upgrade> server # [    0.927185] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint315vm-test-run-amcheck-upgrade> server # [    0.927635] pci 0000:00:07.0: BAR 0 [io  0x0000-0x001f]316vm-test-run-amcheck-upgrade> server # [    0.927755] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]317vm-test-run-amcheck-upgrade> server # [    0.927879] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]318vm-test-run-amcheck-upgrade> server # [    0.928005] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]319vm-test-run-amcheck-upgrade> server # [    0.928561] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint320vm-test-run-amcheck-upgrade> server # [    0.928721] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]321vm-test-run-amcheck-upgrade> server # [    0.928840] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]322vm-test-run-amcheck-upgrade> server # [    0.929463] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint323vm-test-run-amcheck-upgrade> server # [    0.930564] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]324vm-test-run-amcheck-upgrade> server # [    0.930708] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]325vm-test-run-amcheck-upgrade> server # [    0.931312] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint326vm-test-run-amcheck-upgrade> server # [    0.931475] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]327vm-test-run-amcheck-upgrade> server # [    0.931955] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint328vm-test-run-amcheck-upgrade> server # [    0.932417] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]329vm-test-run-amcheck-upgrade> server # [    0.932876] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]330vm-test-run-amcheck-upgrade> server # [    0.933759] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]331vm-test-run-amcheck-upgrade> server # [    0.934307] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint332vm-test-run-amcheck-upgrade> server # [    0.934940] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]333vm-test-run-amcheck-upgrade> server # [    0.935170] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]334vm-test-run-amcheck-upgrade> server # [    0.935304] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]335vm-test-run-amcheck-upgrade> server # [    0.938689] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned336vm-test-run-amcheck-upgrade> server # [    0.939259] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned337vm-test-run-amcheck-upgrade> server # [    0.939687] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned338vm-test-run-amcheck-upgrade> server # [    0.939934] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned339vm-test-run-amcheck-upgrade> server # [    0.940106] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned340vm-test-run-amcheck-upgrade> server # [    0.940247] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned341vm-test-run-amcheck-upgrade> server # [    0.940385] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned342vm-test-run-amcheck-upgrade> server # [    0.940529] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned343vm-test-run-amcheck-upgrade> server # [    0.940667] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned344vm-test-run-amcheck-upgrade> server # [    0.940808] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned345vm-test-run-amcheck-upgrade> server # [    0.940981] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned346vm-test-run-amcheck-upgrade> server # [    0.941127] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned347vm-test-run-amcheck-upgrade> server # [    0.941374] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned348vm-test-run-amcheck-upgrade> server # [    0.942263] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned349vm-test-run-amcheck-upgrade> server # [    0.942415] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned350vm-test-run-amcheck-upgrade> server # [    0.942532] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned351vm-test-run-amcheck-upgrade> server # [    0.942648] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned352vm-test-run-amcheck-upgrade> server # [    0.942760] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned353vm-test-run-amcheck-upgrade> server # [    0.942873] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned354vm-test-run-amcheck-upgrade> server # [    0.942986] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned355vm-test-run-amcheck-upgrade> server # [    0.943107] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned356vm-test-run-amcheck-upgrade> server # [    0.943227] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned357vm-test-run-amcheck-upgrade> server # [    0.943342] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned358vm-test-run-amcheck-upgrade> server # [    0.943457] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned359vm-test-run-amcheck-upgrade> server # [    0.943570] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned360vm-test-run-amcheck-upgrade> server # [    0.943691] pci 0000:00:06.0: BAR 0 [io  0x1000-0x107f]: assigned361vm-test-run-amcheck-upgrade> server # [    0.943820] pci 0000:00:03.0: BAR 0 [io  0x1080-0x10bf]: assigned362vm-test-run-amcheck-upgrade> server # [    0.943925] pci 0000:00:0b.0: BAR 0 [io  0x10c0-0x10ff]: assigned363vm-test-run-amcheck-upgrade> server # [    0.944031] pci 0000:00:01.0: BAR 0 [io  0x1100-0x111f]: assigned364vm-test-run-amcheck-upgrade> server # [    0.944135] pci 0000:00:02.0: BAR 0 [io  0x1120-0x113f]: assigned365vm-test-run-amcheck-upgrade> server # [    0.944240] pci 0000:00:04.0: BAR 0 [io  0x1140-0x115f]: assigned366vm-test-run-amcheck-upgrade> server # [    0.944344] pci 0000:00:05.0: BAR 0 [io  0x1160-0x117f]: assigned367vm-test-run-amcheck-upgrade> server # [    0.944455] pci 0000:00:07.0: BAR 0 [io  0x1180-0x119f]: assigned368vm-test-run-amcheck-upgrade> server # [    0.944563] pci 0000:00:0c.0: BAR 0 [io  0x11a0-0x11bf]: assigned369vm-test-run-amcheck-upgrade> server # [    0.944878] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]370vm-test-run-amcheck-upgrade> server # [    0.946479] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]371vm-test-run-amcheck-upgrade> server # [    0.947143] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]372vm-test-run-amcheck-upgrade> server # [    0.948473] pci 0000:00:0a.0: enabling device (0000 -> 0002)373vm-test-run-amcheck-upgrade> server # [    1.018082] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)374vm-test-run-amcheck-upgrade> server # [    1.022737] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)375vm-test-run-amcheck-upgrade> server # [    1.024893] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)376vm-test-run-amcheck-upgrade> server # [    1.027769] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)377vm-test-run-amcheck-upgrade> server # [    1.030647] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)378vm-test-run-amcheck-upgrade> server # [    1.032694] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)379vm-test-run-amcheck-upgrade> server # [    1.034902] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)380vm-test-run-amcheck-upgrade> server # [    1.037041] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)381vm-test-run-amcheck-upgrade> server # [    1.039520] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)382vm-test-run-amcheck-upgrade> server # [    1.042782] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)383vm-test-run-amcheck-upgrade> server # [    1.045332] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)384vm-test-run-amcheck-upgrade> server # [    1.064344] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled385vm-test-run-amcheck-upgrade> server # [    1.075655] msm_serial: driver initialized386vm-test-run-amcheck-upgrade> server # [    1.077286] SuperH (H)SCI(F) driver initialized387vm-test-run-amcheck-upgrade> server # [    1.078687] STM32 USART driver initialized388vm-test-run-amcheck-upgrade> server # [    1.136404] loop: module loaded389vm-test-run-amcheck-upgrade> server # [    1.137146] virtio_blk virtio5: 2/0/0 default/read/poll queues390vm-test-run-amcheck-upgrade> server # [    1.142549] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)391vm-test-run-amcheck-upgrade> server # [    1.157493] megasas: 07.727.03.00-rc1392vm-test-run-amcheck-upgrade> server # [    1.159786] Freeing initrd memory: 10684K393vm-test-run-amcheck-upgrade> server # [    1.163884] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]394vm-test-run-amcheck-upgrade> server # [    1.167841] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000395vm-test-run-amcheck-upgrade> server # [    1.168516] Intel/Sharp Extended Query Table at 0x0031396vm-test-run-amcheck-upgrade> server # [    1.171181] Using buffer write method397vm-test-run-amcheck-upgrade> server # [    1.172218] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]398vm-test-run-amcheck-upgrade> server # [    1.174830] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000399vm-test-run-amcheck-upgrade> server # [    1.175095] Intel/Sharp Extended Query Table at 0x0031400vm-test-run-amcheck-upgrade> server # [    1.176793] Using buffer write method401vm-test-run-amcheck-upgrade> server # [    1.177446] Concatenating MTD devices:402vm-test-run-amcheck-upgrade> server # [    1.177615] (0): "0.flash"403vm-test-run-amcheck-upgrade> server # [    1.179463] (1): "0.flash"404vm-test-run-amcheck-upgrade> server # [    1.180048] into device "0.flash"405vm-test-run-amcheck-upgrade> server # [    1.207467] tun: Universal TUN/TAP device driver, 1.6406vm-test-run-amcheck-upgrade> server # [    1.222970] thunder_xcv, ver 1.0407vm-test-run-amcheck-upgrade> server # [    1.223266] thunder_bgx, ver 1.0408vm-test-run-amcheck-upgrade> server # [    1.223437] nicpf, ver 1.0409vm-test-run-amcheck-upgrade> server # [    1.226574] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version410vm-test-run-amcheck-upgrade> server # [    1.226794] hns3: Copyright (c) 2017 Huawei Corporation.411vm-test-run-amcheck-upgrade> server # [    1.227370] hclge is initializing412vm-test-run-amcheck-upgrade> server # [    1.227763] e1000: Intel(R) PRO/1000 Network Driver413vm-test-run-amcheck-upgrade> server # [    1.227859] e1000: Copyright (c) 1999-2006 Intel Corporation.414vm-test-run-amcheck-upgrade> server # [    1.228135] e1000e: Intel(R) PRO/1000 Network Driver415vm-test-run-amcheck-upgrade> server # [    1.228403] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.416vm-test-run-amcheck-upgrade> server # [    1.229096] igb: Intel(R) Gigabit Ethernet Network Driver417vm-test-run-amcheck-upgrade> server # [    1.229239] igb: Copyright (c) 2007-2014 Intel Corporation.418vm-test-run-amcheck-upgrade> server # [    1.230844] igbvf: Intel(R) Gigabit Virtual Function Network Driver419vm-test-run-amcheck-upgrade> server # [    1.231204] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.420vm-test-run-amcheck-upgrade> server # [    1.232736] sky2: driver version 1.30421vm-test-run-amcheck-upgrade> server # [    1.243636] ehci-pci 0000:00:0a.0: EHCI Host Controller422vm-test-run-amcheck-upgrade> server # [    1.244162] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1423vm-test-run-amcheck-upgrade> server # [    1.245181] usbcore: registered new interface driver usb-storage424vm-test-run-amcheck-upgrade> server # [    1.247397] usbcore: registered new interface driver usbserial_generic425vm-test-run-amcheck-upgrade> server # [    1.248121] usbserial: USB Serial support registered for generic426vm-test-run-amcheck-upgrade> server # [    1.249011] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000427vm-test-run-amcheck-upgrade> server # [    1.258157] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00428vm-test-run-amcheck-upgrade> server # [    1.259420] rtc-pl031 9010000.pl031: registered as rtc0429vm-test-run-amcheck-upgrade> server # [    1.260064] rtc-pl031 9010000.pl031: setting system clock to 2026-10-07T20:37:08 UTC (1791405428)430vm-test-run-amcheck-upgrade> server # [    1.262464] i2c_dev: i2c /dev entries driver431vm-test-run-amcheck-upgrade> server # [    1.267269] hub 1-0:1.0: USB hub found432vm-test-run-amcheck-upgrade> server # [    1.267887] hub 1-0:1.0: 6 ports detected433vm-test-run-amcheck-upgrade> server # [    1.283951] sdhci: Secure Digital Host Controller Interface driver434vm-test-run-amcheck-upgrade> server # [    1.284141] sdhci: Copyright(c) Pierre Ossman435vm-test-run-amcheck-upgrade> server # [    1.287300] Synopsys Designware Multimedia Card Interface Driver436vm-test-run-amcheck-upgrade> server # [    1.289523] sdhci-pltfm: SDHCI platform and OF driver helper437vm-test-run-amcheck-upgrade> server # [    1.299954] hid: raw HID events driver (C) Jiri Kosina438vm-test-run-amcheck-upgrade> server # [    1.303893] usbcore: registered new interface driver usbhid439vm-test-run-amcheck-upgrade> server # [    1.304313] usbhid: USB HID core driver440vm-test-run-amcheck-upgrade> server # [    1.314550] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available441vm-test-run-amcheck-upgrade> server # [    1.330700] drop_monitor: Initializing network drop monitor service442vm-test-run-amcheck-upgrade> server # [    1.332143] NET: Registered PF_INET6 protocol family443vm-test-run-amcheck-upgrade> server # [    1.353640] Segment Routing with IPv6444vm-test-run-amcheck-upgrade> server # [    1.354556] In-situ OAM (IOAM) with IPv6445vm-test-run-amcheck-upgrade> server # [    1.355333] NET: Registered PF_PACKET protocol family446vm-test-run-amcheck-upgrade> server # [    1.357234] 9pnet: Installing 9P2000 support447vm-test-run-amcheck-upgrade> server # [    1.362457] Key type dns_resolver registered448vm-test-run-amcheck-upgrade> server # [    1.399834] registered taskstats version 1449vm-test-run-amcheck-upgrade> server # [    1.403841] Loading compiled-in X.509 certificates450vm-test-run-amcheck-upgrade> server # [    1.466535] Demotion targets for Node 0: null451vm-test-run-amcheck-upgrade> server # [    1.470367] Key type .fscrypt registered452vm-test-run-amcheck-upgrade> server # [    1.470626] Key type fscrypt-provisioning registered453vm-test-run-amcheck-upgrade> server # [    1.480096] input: gpio-keys as /devices/platform/gpio-keys/input/input0454vm-test-run-amcheck-upgrade> server # [    1.522938] usb 1-1: new high-speed USB device number 2 using ehci-pci455vm-test-run-amcheck-upgrade> server # [    1.529265] clk: Disabling unused clocks456vm-test-run-amcheck-upgrade> server # [    1.530474] PM: genpd: Disabling unused power domains457vm-test-run-amcheck-upgrade> server # [    1.530859] ALSA device list:458vm-test-run-amcheck-upgrade> server # [    1.531044]   No soundcards found.459vm-test-run-amcheck-upgrade> server # [    1.619083] Freeing unused kernel memory: 4416K460vm-test-run-amcheck-upgrade> server # [    1.621910] Run /init as init process461vm-test-run-amcheck-upgrade> server # [    1.745249] 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/input1462vm-test-run-amcheck-upgrade> server # [    1.908698] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0463vm-test-run-amcheck-upgrade> server # [    2.030181] usb 1-2: new high-speed USB device number 3 using ehci-pci464vm-test-run-amcheck-upgrade> server # [    2.216650] 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/input2465vm-test-run-amcheck-upgrade> server # [    2.227513] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0466vm-test-run-amcheck-upgrade> server # [    2.315279] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev467vm-test-run-amcheck-upgrade> server # [    2.461416] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0468vm-test-run-amcheck-upgrade> server # [    2.462482] [drm] features: -virgl +edid -resource_blob -host_visible469vm-test-run-amcheck-upgrade> server # [    2.462510] [drm] features: -context_init470vm-test-run-amcheck-upgrade> server # [    2.464817] [drm] number of scanouts: 1471vm-test-run-amcheck-upgrade> server # [    2.465005] [drm] number of cap sets: 0472vm-test-run-amcheck-upgrade> server # [    2.476711] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0473vm-test-run-amcheck-upgrade> server # [    2.516607] Console: switching to colour frame buffer device 160x50474vm-test-run-amcheck-upgrade> server # [    2.529678] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device475vm-test-run-amcheck-upgrade> server # [    5.663004] EXT4-fs (vda): mounted filesystem 58b44652-d183-465a-a4c2-02a1807688ff r/w with ordered data mode. Quota mode: none.476vm-test-run-amcheck-upgrade> server # [    8.416639] EXT4-fs (vda): re-mounted 58b44652-d183-465a-a4c2-02a1807688ff.477vm-test-run-amcheck-upgrade> server # [    8.438291] booting system configuration /nix/store/c1qrwph6vbfgrdwf921g14p7iw27nyjb-nixos-system-server-test478vm-test-run-amcheck-upgrade> server # [   18.986686] 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)479vm-test-run-amcheck-upgrade> server # [   18.998590] systemd[1]: Detected virtualization qemu.480vm-test-run-amcheck-upgrade> server # [   19.002882] systemd[1]: Detected architecture arm64.481vm-test-run-amcheck-upgrade> server # [   19.007745] systemd[1]: Detected first boot.482vm-test-run-amcheck-upgrade> server # [   19.034830] systemd[1]: Initializing machine ID from random generator.483vm-test-run-amcheck-upgrade> server # [   19.067542] systemd[1]: Hostname set to <server>.484vm-test-run-amcheck-upgrade> server # [   20.384103] systemd[1]: bpf-restrict-fs: LSM BPF program attached485vm-test-run-amcheck-upgrade> server # [   21.733548] systemd[1]: Applying preset policy.486vm-test-run-amcheck-upgrade> server # [   24.907703] systemd[1]: Populated /etc with preset unit settings.487vm-test-run-amcheck-upgrade> server # [   28.222291] systemd[1]: Queued start job for default target Multi-User System.488vm-test-run-amcheck-upgrade> server # [   28.435841] systemd[1]: Created slice Slice /system/getty.489vm-test-run-amcheck-upgrade> server # [   28.450634] systemd[1]: Created slice Slice /system/modprobe.490vm-test-run-amcheck-upgrade> server # [   28.463606] systemd[1]: Created slice User and Session Slice.491vm-test-run-amcheck-upgrade> server # [   28.471494] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.492vm-test-run-amcheck-upgrade> server # [   28.476938] systemd[1]: Started Forward Password Requests to Wall Directory Watch.493vm-test-run-amcheck-upgrade> server # [   28.482576] systemd[1]: Expecting device /dev/hvc0...494vm-test-run-amcheck-upgrade> server # [   28.486924] systemd[1]: Expecting device /dev/ttyAMA0...495vm-test-run-amcheck-upgrade> server # [   28.491097] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1...496vm-test-run-amcheck-upgrade> server # [   28.495165] systemd[1]: Reached target Local Encrypted Volumes.497vm-test-run-amcheck-upgrade> server # [   28.498559] systemd[1]: Reached target Virtual Machines and Containers.498vm-test-run-amcheck-upgrade> server # [   28.501419] systemd[1]: Reached target Path Units.499vm-test-run-amcheck-upgrade> server # [   28.506953] systemd[1]: Reached target Remote File Systems.500vm-test-run-amcheck-upgrade> server # [   28.511909] systemd[1]: Reached target Slice Units.501vm-test-run-amcheck-upgrade> server # [   28.517267] systemd[1]: Reached target Swaps.502vm-test-run-amcheck-upgrade> server # [   28.552702] systemd[1]: Listening on Process Core Dump Socket.503vm-test-run-amcheck-upgrade> server # [   28.576524] systemd[1]: Listening on Credential Encryption/Decryption.504vm-test-run-amcheck-upgrade> server # [   28.587721] systemd[1]: Listening on Journal Audit Socket.505vm-test-run-amcheck-upgrade> server # [   28.595062] systemd[1]: Listening on Journal Socket (/dev/log).506vm-test-run-amcheck-upgrade> server # [   28.601204] systemd[1]: Listening on Journal Sockets.507vm-test-run-amcheck-upgrade> server # [   28.610748] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.508vm-test-run-amcheck-upgrade> server # [   28.615878] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki).509vm-test-run-amcheck-upgrade> server # [   28.623086] systemd[1]: Listening on udev Control Socket.510vm-test-run-amcheck-upgrade> server # [   28.630458] systemd[1]: Listening on udev Kernel Socket.511vm-test-run-amcheck-upgrade> server # [   28.681951] systemd[1]: Mounting Huge Pages File System...512vm-test-run-amcheck-upgrade> server # [   28.722980] systemd[1]: Mounting POSIX Message Queue File System...513vm-test-run-amcheck-upgrade> server # [   28.766854] systemd[1]: Mounting Kernel Debug File System...514vm-test-run-amcheck-upgrade> server # [   28.823808] systemd[1]: Mounting Kernel Trace File System...515vm-test-run-amcheck-upgrade> server: Guest root shell did not produce any data yet...516vm-test-run-amcheck-upgrade> server:   To debug, enter the VM and run 'systemctl status backdoor.service'.517vm-test-run-amcheck-upgrade> server # [   28.968870] systemd[1]: Starting Create List of Static Device Nodes...518vm-test-run-amcheck-upgrade> server # [   29.068770] systemd[1]: Starting Load Kernel Module 9pnet_virtio...519vm-test-run-amcheck-upgrade> server # [   29.086835] systemd[1]: Load Kernel Module configfs was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!configfs).520vm-test-run-amcheck-upgrade> server # [   29.255773] systemd[1]: Mounting Kernel Configuration File System...521vm-test-run-amcheck-upgrade> server # [   29.275342] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm).522vm-test-run-amcheck-upgrade> server # [   29.299927] systemd[1]: Load Kernel Module efi_pstore was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!efi_pstore).523vm-test-run-amcheck-upgrade> server # [   29.422794] systemd[1]: Starting Load Kernel Module fuse...524vm-test-run-amcheck-upgrade> server # [   29.431445] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).525vm-test-run-amcheck-upgrade> server # [   29.440850] 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).526vm-test-run-amcheck-upgrade> server # [   29.532882] systemd[1]: Starting Journal Service...527vm-test-run-amcheck-upgrade> server # [   29.602603] systemd[1]: Starting Load Kernel Modules...528vm-test-run-amcheck-upgrade> server # [   29.664048] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...529vm-test-run-amcheck-upgrade> server # [   29.717313] systemd[1]: Starting Remount Root and Kernel File Systems...530vm-test-run-amcheck-upgrade> server # [   29.731937] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).531vm-test-run-amcheck-upgrade> server # [   29.802983] systemd[1]: Starting Coldplug All udev Devices...532vm-test-run-amcheck-upgrade> server # [   29.880751] systemd[1]: Mounted Huge Pages File System.533vm-test-run-amcheck-upgrade> server # [   29.892129] systemd[1]: Mounted POSIX Message Queue File System.534vm-test-run-amcheck-upgrade> server # [   29.906952] systemd[1]: Mounted Kernel Debug File System.535vm-test-run-amcheck-upgrade> server # [   29.918718] systemd[1]: Mounted Kernel Trace File System.536vm-test-run-amcheck-upgrade> server # [   29.949020] systemd[1]: Finished Create List of Static Device Nodes.537vm-test-run-amcheck-upgrade> server # [   29.968623] systemd[1]: Mounted Kernel Configuration File System.538vm-test-run-amcheck-upgrade> server # [   30.044623] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...539vm-test-run-amcheck-upgrade> server # [   30.340404] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.540vm-test-run-amcheck-upgrade> server # [   30.360709] systemd[1]: Finished Load Kernel Module 9pnet_virtio.541vm-test-run-amcheck-upgrade> server # [   30.747791] systemd[1]: Finished Load Kernel Modules.542vm-test-run-amcheck-upgrade> server # [   30.811521] systemd[1]: Starting Firewall...543vm-test-run-amcheck-upgrade> server # [   30.868553] systemd[1]: Starting Apply Kernel Variables...544vm-test-run-amcheck-upgrade> server # [   30.940669] fuse: init (API version 7.41)545vm-test-run-amcheck-upgrade> server # [   31.002785] EXT4-fs (vda): re-mounted 58b44652-d183-465a-a4c2-02a1807688ff.546vm-test-run-amcheck-upgrade> server # [   31.028056] systemd[1]: modprobe@fuse.service: Deactivated successfully.547vm-test-run-amcheck-upgrade> server # [   31.044067] systemd[1]: Finished Load Kernel Module fuse.548vm-test-run-amcheck-upgrade> server # [   31.116309] systemd[1]: Mounting FUSE Control File System...549vm-test-run-amcheck-upgrade> server # [   31.186073] systemd[1]: Finished Remount Root and Kernel File Systems.550vm-test-run-amcheck-upgrade> server # [   31.214276] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).551vm-test-run-amcheck-upgrade> server # [   31.317262] systemd[1]: Starting Load/Save OS Random Seed...552vm-test-run-amcheck-upgrade> server # [   31.331926] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).553vm-test-run-amcheck-upgrade> server # [   31.428893] systemd[1]: Mounted FUSE Control File System.554vm-test-run-amcheck-upgrade> server # [   31.632361] systemd-journald[398]: Collecting audit messages is enabled.555vm-test-run-amcheck-upgrade> server # [   32.441740] systemd[1]: Finished Load/Save OS Random Seed.556vm-test-run-amcheck-upgrade> server # [   32.456731] systemd[1]: Reached target First Boot Complete.557vm-test-run-amcheck-upgrade> server # [   32.641717] systemd[1]: Finished Apply Kernel Variables.558vm-test-run-amcheck-upgrade> server # [   32.688261] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.559vm-test-run-amcheck-upgrade> server # [   32.774081] systemd[1]: Starting Create Static Device Nodes in /dev...560vm-test-run-amcheck-upgrade> server # [   32.787969] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.561vm-test-run-amcheck-upgrade> server # [   33.714067] systemd[1]: Finished Create Static Device Nodes in /dev.562vm-test-run-amcheck-upgrade> server # [   33.756119] systemd[1]: Reached target Preparation for Local File Systems.563vm-test-run-amcheck-upgrade> server # [   33.792106] systemd[1]: Mounting /run/wrappers...564vm-test-run-amcheck-upgrade> server # [   33.861219] systemd[1]: Starting Rule-based Manager for Device Events and Files...565vm-test-run-amcheck-upgrade> server # [   34.338181] systemd[1]: Mounted /run/wrappers.566vm-test-run-amcheck-upgrade> server # [   34.350708] systemd[1]: Reached target Local File Systems.567vm-test-run-amcheck-upgrade> server # [   34.379023] systemd[1]: Listening on Boot Entries Service Socket.568vm-test-run-amcheck-upgrade> server # [   34.438865] systemd[1]: Starting Create SUID/SGID Wrappers...569vm-test-run-amcheck-upgrade> server # [   34.444370] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met.570vm-test-run-amcheck-upgrade> server # [   34.507013] systemd[1]: Starting Save Transient machine-id to Disk...571vm-test-run-amcheck-upgrade> server # [   34.525370] systemd[1]: Started Journal Service.572vm-test-run-amcheck-upgrade> server # [   34.409175] systemd-modules-load[399]: Module 'atkbd' is built in573vm-test-run-amcheck-upgrade> server # [   34.479094] systemd-modules-load[399]: Module 'loop' is built in574vm-test-run-amcheck-upgrade> server # [   34.562716] systemd-oomd[400]: No swap; memory pressure usage will be degraded575vm-test-run-amcheck-upgrade> server # [   34.613927] systemd[1]: Starting Flush Journal to Persistent Storage...576vm-test-run-amcheck-upgrade> server # [   35.412930] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.577vm-test-run-amcheck-upgrade> server # [   35.450340] systemd[1]: Finished Save Transient machine-id to Disk.578vm-test-run-amcheck-upgrade> server # [   35.597349] systemd-journald[398]: Received client request to flush runtime journal.579vm-test-run-amcheck-upgrade> server # [   36.075737] systemd-udevd[427]: Using default interface naming scheme 'v258'.580vm-test-run-amcheck-upgrade> server # [   36.110325] systemd[1]: Finished Flush Journal to Persistent Storage.581vm-test-run-amcheck-upgrade> server # [   36.152905] systemd[1]: Starting Create System Files and Directories...582vm-test-run-amcheck-upgrade> server # [   38.010247] systemd[1]: Started Rule-based Manager for Device Events and Files.583vm-test-run-amcheck-upgrade> server # [   38.210985] systemd[1]: Finished Create System Files and Directories.584vm-test-run-amcheck-upgrade> server # [   38.333216] systemd[1]: Starting Rebuild Journal Catalog...585vm-test-run-amcheck-upgrade> server # [   38.440944] systemd[1]: Starting Record System Boot/Shutdown in UTMP...586vm-test-run-amcheck-upgrade> server # [   39.631448] systemd[1]: Finished Record System Boot/Shutdown in UTMP.587vm-test-run-amcheck-upgrade> server # [   40.618808] systemd[1]: Finished Rebuild Journal Catalog.588vm-test-run-amcheck-upgrade> server # [   40.722124] systemd[1]: Starting Update is Completed...589vm-test-run-amcheck-upgrade> server # [   41.341610] systemd[1]: Finished Update is Completed.590vm-test-run-amcheck-upgrade> server # [   44.719203] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.591vm-test-run-amcheck-upgrade> server # [   44.725441] systemd[1]: Finished Create SUID/SGID Wrappers.592vm-test-run-amcheck-upgrade> server # [   44.727932] systemd[1]: suid-sgid-wrappers.service: Consumed 2.827s CPU time, 5.5M memory peak.593vm-test-run-amcheck-upgrade> server # [   47.051581] systemd[1]: Finished Firewall.594vm-test-run-amcheck-upgrade> server # [   48.886023] systemd[1]: Finished Coldplug All udev Devices.595vm-test-run-amcheck-upgrade> server # [   48.912564] systemd[1]: Reached target System Initialization.596vm-test-run-amcheck-upgrade> server # [   48.918891] systemd[1]: Started Discard unused filesystem blocks once a week.597vm-test-run-amcheck-upgrade> server # [   48.940394] systemd[1]: Started Daily Cleanup of Temporary Directories.598vm-test-run-amcheck-upgrade> server # [   48.949990] systemd[1]: Reached target Timer Units.599vm-test-run-amcheck-upgrade> server # [   48.955222] systemd[1]: Listening on D-Bus System Message Bus Socket.600vm-test-run-amcheck-upgrade> server # [   48.967076] systemd[1]: Listening on Nix Daemon Socket.601vm-test-run-amcheck-upgrade> server # [   48.971557] systemd[1]: Listening on Hostname Service Socket.602vm-test-run-amcheck-upgrade> server # [   48.977413] systemd[1]: Reached target Socket Units.603vm-test-run-amcheck-upgrade> server # [   48.990395] systemd[1]: Reached target Basic System.604vm-test-run-amcheck-upgrade> server # [   49.012873] systemd[1]: Starting Import lastlog data into lastlog2 database...605vm-test-run-amcheck-upgrade> server # [   49.049286] systemd[1]: Starting Name Service Cache Daemon (nsncd)...606vm-test-run-amcheck-upgrade> server # [   49.113359] systemd[1]: Started Reset console on configuration changes.607vm-test-run-amcheck-upgrade> server # [   49.158443] systemd[1]: Starting resolvconf update...608vm-test-run-amcheck-upgrade> server # [   49.235581] systemd[1]: Starting D-Bus System Message Bus...609vm-test-run-amcheck-upgrade> server # [   50.409981] systemd[1]: Finished Import lastlog data into lastlog2 database.610vm-test-run-amcheck-upgrade> server # [   50.669747] systemd[1]: Started Name Service Cache Daemon (nsncd).611vm-test-run-amcheck-upgrade> server # [   50.686512] systemd[1]: Reached target Host and Network Name Lookups.612vm-test-run-amcheck-upgrade> server # [   50.718776] nsncd[629]: Oct 07 20:37:57.993 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"613vm-test-run-amcheck-upgrade> server # [   50.747735] systemd[1]: Reached target User and Group Name Lookups.614vm-test-run-amcheck-upgrade> server # [   50.801889] systemd[1]: Starting User Login Management...615vm-test-run-amcheck-upgrade> server # [   51.090538] dbus-daemon[632]: dbus[632]: Unknown username "systemd-timesync" in message bus configuration file616vm-test-run-amcheck-upgrade> server # [   51.714949] systemd[1]: Started D-Bus System Message Bus.617vm-test-run-amcheck-upgrade> server # [   52.470707] systemd-logind[651]: New seat seat0.618vm-test-run-amcheck-upgrade> server # [   52.529945] systemd[1]: Started User Login Management.619vm-test-run-amcheck-upgrade> server # [   52.588392] systemd[1]: Starting linger-users.service...620vm-test-run-amcheck-upgrade> server # [   52.780327] systemd[1]: Stopped target Host and Network Name Lookups.621vm-test-run-amcheck-upgrade> server # [   52.791737] systemd[1]: Stopping Host and Network Name Lookups...622vm-test-run-amcheck-upgrade> server # [   52.798404] systemd[1]: Stopped target User and Group Name Lookups.623vm-test-run-amcheck-upgrade> server # [   52.810433] systemd[1]: Stopping User and Group Name Lookups...624vm-test-run-amcheck-upgrade> server # [   52.819378] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...625vm-test-run-amcheck-upgrade> server # [   52.835420] systemd[1]: nscd.service: Deactivated successfully.626vm-test-run-amcheck-upgrade> server # [   52.862410] systemd[1]: Stopped Name Service Cache Daemon (nsncd).627vm-test-run-amcheck-upgrade> server # [   53.090785] systemd[1]: Starting Name Service Cache Daemon (nsncd)...628vm-test-run-amcheck-upgrade> server # [   53.202249] systemd[1]: linger-users.service: Deactivated successfully.629vm-test-run-amcheck-upgrade> server # [   53.231788] systemd[1]: Finished linger-users.service.630vm-test-run-amcheck-upgrade> server # [   53.782169] nsncd[691]: Oct 07 20:38:01.138 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"631vm-test-run-amcheck-upgrade> server # [   53.795252] systemd[1]: Started Name Service Cache Daemon (nsncd).632vm-test-run-amcheck-upgrade> server # [   53.806670] systemd[1]: Reached target Host and Network Name Lookups.633vm-test-run-amcheck-upgrade> server # [   53.815560] systemd[1]: Reached target User and Group Name Lookups.634vm-test-run-amcheck-upgrade> server # [   54.569103] systemd[1]: Finished resolvconf update.635vm-test-run-amcheck-upgrade> server # [   54.597107] systemd[1]: Reached target Preparation for Network.636vm-test-run-amcheck-upgrade> server # [   54.656884] systemd[1]: Starting DHCP Client...637vm-test-run-amcheck-upgrade> server # [   56.225959] dhcpcd[740]: dhcpcd-10.2.4 starting638vm-test-run-amcheck-upgrade> server # [   56.377004] dhcpcd[753]: dev: loaded udev639vm-test-run-amcheck-upgrade> server # [   56.931839] 8021q: 802.1Q VLAN Support v1.8640vm-test-run-amcheck-upgrade> server # [   57.468433] cfg80211: Loading compiled-in X.509 certificates for regulatory database641vm-test-run-amcheck-upgrade> server # [   57.763756] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'642vm-test-run-amcheck-upgrade> server # [   57.770620] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'643vm-test-run-amcheck-upgrade> server # [   57.803259] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2644vm-test-run-amcheck-upgrade> server # [   57.808355] cfg80211: failed to load regulatory.db645vm-test-run-amcheck-upgrade> server # [   58.608515] 8021q: adding VLAN 0 to HW filter on device eth0646vm-test-run-amcheck-upgrade> server # [   58.502323] dhcpcd[753]: eth0: waiting for carrier647vm-test-run-amcheck-upgrade> server # [   58.510080] dhcpcd[753]: eth0: carrier acquired648vm-test-run-amcheck-upgrade> server # [   58.615142] dhcpcd[753]: DUID 00:01:00:01:32:59:6a:2d:52:54:00:12:34:56649vm-test-run-amcheck-upgrade> server # [   58.619178] dhcpcd[753]: eth0: IAID 00:12:34:56650vm-test-run-amcheck-upgrade> server # [   58.621398] dhcpcd[753]: eth0: adding address fe80::5054:ff:fe12:3456651vm-test-run-amcheck-upgrade> server: Guest root shell did not produce any data yet...652vm-test-run-amcheck-upgrade> server:   To debug, enter the VM and run 'systemctl status backdoor.service'.653vm-test-run-amcheck-upgrade> server # [   59.852044] systemd[1]: Found device /dev/hvc0.654vm-test-run-amcheck-upgrade> server # [   60.045638] dhcpcd[753]: eth0: soliciting a DHCP lease655vm-test-run-amcheck-upgrade> server # [   60.058898] dhcpcd[753]: eth0: offered 10.0.2.15 from 10.0.2.2656vm-test-run-amcheck-upgrade> server # [   60.087311] dhcpcd[753]: eth0: probing address 10.0.2.15/24657vm-test-run-amcheck-upgrade> server # [   60.318536] systemd[1]: Found device /dev/ttyAMA0.658vm-test-run-amcheck-upgrade> server # [   60.374750] systemd[1]: Started backdoor.service.659vm-test-run-amcheck-upgrade> server # [   60.474818] (udev-worker)[794]: Network interface NamePolicy= disabled on kernel command line.660vm-test-run-amcheck-upgrade> server # [   60.665637] (udev-worker)[788]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.661vm-test-run-amcheck-upgrade> server # [   60.685919] (udev-worker)[788]: Network interface NamePolicy= disabled on kernel command line.662vm-test-run-amcheck-upgrade> server # connecting to host...663vm-test-run-amcheck-upgrade> server: Guest shell says: b'Spawning backdoor root shell...\n'664vm-test-run-amcheck-upgrade> server: connected to guest root shell665vm-test-run-amcheck-upgrade> server: (connecting took 62.55 seconds)666vm-test-run-amcheck-upgrade> server: (finished: waiting for the VM to finish booting, in 62.55 seconds)667vm-test-run-amcheck-upgrade> server # [   61.405835] dhcpcd[753]: eth0: soliciting an IPv6 router668vm-test-run-amcheck-upgrade> server # [   61.407491] dhcpcd[753]: eth0: Router Advertisement from fe80::2669vm-test-run-amcheck-upgrade> server # [   61.415530] dhcpcd[753]: eth0: adding address fec0::5054:ff:fe12:3456/64670vm-test-run-amcheck-upgrade> server # [   61.423469] dhcpcd[753]: eth0: adding route to fec0::/64671vm-test-run-amcheck-upgrade> server # [   61.427495] dhcpcd[753]: eth0: adding default route via fe80::2672vm-test-run-amcheck-upgrade> server # [   61.868798] dhcpcd[753]: eth0: IAID 00:12:34:56673vm-test-run-amcheck-upgrade> server # [   61.974124] dhcpcd[753]: eth0: soliciting an IPv6 router674vm-test-run-amcheck-upgrade> server # [   62.025914] systemd[1]: Found device Virtio network device.675vm-test-run-amcheck-upgrade> server # [   62.039742] systemd[1]: Starting Address configuration of eth1...676vm-test-run-amcheck-upgrade> server # [   62.707175] dhcpcd[753]: eth0: soliciting a DHCP lease677vm-test-run-amcheck-upgrade> server # [   62.710726] dhcpcd[753]: eth0: offered 10.0.2.15 from 10.0.2.2678vm-test-run-amcheck-upgrade> server # [   62.711896] dhcpcd[753]: eth0: probing address 10.0.2.15/24679vm-test-run-amcheck-upgrade> server # [   63.147148] 8021q: adding VLAN 0 to HW filter on device eth1680vm-test-run-amcheck-upgrade> server # [   63.384031] network-addresses-eth1-start[813]: adding address 192.168.1.1/24... done681vm-test-run-amcheck-upgrade> server # [   63.619582] network-addresses-eth1-start[813]: adding address 2001:db8:1::1/64... done682vm-test-run-amcheck-upgrade> server # [   63.955885] systemd[1]: Finished Address configuration of eth1.683vm-test-run-amcheck-upgrade> server # [   64.015481] systemd[1]: Starting Networking Setup...684vm-test-run-amcheck-upgrade> server # [   66.755718] systemd[1]: Finished Networking Setup.685vm-test-run-amcheck-upgrade> server # [   66.779583] systemd[1]: Reached target Network.686vm-test-run-amcheck-upgrade> server # [   66.827858] systemd[1]: Starting PostgreSQL Database Server...687vm-test-run-amcheck-upgrade> server # [   66.882154] systemd[1]: Starting Permit User Sessions...688vm-test-run-amcheck-upgrade> server # [   67.592026] systemd[1]: Finished Permit User Sessions.689vm-test-run-amcheck-upgrade> server # [   67.673468] systemd[1]: Started Getty on tty1.690vm-test-run-amcheck-upgrade> server # [   67.674736] systemd[1]: Reached target Login Prompts.691vm-test-run-amcheck-upgrade> server # [   67.991457] dhcpcd[753]: eth0: leased 10.0.2.15 for 86400 seconds692vm-test-run-amcheck-upgrade> server # [   68.013786] dhcpcd[753]: eth0: adding route to 10.0.2.0/24693vm-test-run-amcheck-upgrade> server # [   68.030450] dhcpcd[753]: eth0: adding default route via 10.0.2.2694vm-test-run-amcheck-upgrade> server # [   68.551688] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[928]: Initializing database at /var/lib/postgresql/data695vm-test-run-amcheck-upgrade> server # [   70.794580] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: The files belonging to this database system will be owned by user "postgres".696vm-test-run-amcheck-upgrade> server # [   70.807589] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: This user must also own the server process.697vm-test-run-amcheck-upgrade> server # [   70.877592] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: The database cluster will be initialized with locale "en_US.UTF-8".698vm-test-run-amcheck-upgrade> server # [   70.879232] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: The default database encoding has accordingly been set to "UTF8".699vm-test-run-amcheck-upgrade> server # [   70.880155] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: The default text search configuration will be set to "english".700vm-test-run-amcheck-upgrade> server # [   70.886251] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: Data page checksums are enabled.701vm-test-run-amcheck-upgrade> server # [   70.888136] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: fixing permissions on existing directory /var/lib/postgresql/data ... ok702vm-test-run-amcheck-upgrade> server # [   70.921961] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: creating subdirectories ... ok703vm-test-run-amcheck-upgrade> server # [   70.934926] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: selecting dynamic shared memory implementation ... posix704vm-test-run-amcheck-upgrade> server # [   72.775894] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: selecting default max_connections ... 100705vm-test-run-amcheck-upgrade> server # [   73.094963] systemd[1]: Started DHCP Client.706vm-test-run-amcheck-upgrade> server # [   73.963539] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: selecting default shared_buffers ... 128MB707vm-test-run-amcheck-upgrade> server # [   77.333539] systemd-logind[651]: Watching system buttons on /dev/input/event0 (gpio-keys)708vm-test-run-amcheck-upgrade> server # [   86.239463] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: selecting default time zone ... UTC709vm-test-run-amcheck-upgrade> server # [   86.270421] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: creating configuration files ... ok710vm-test-run-amcheck-upgrade> server # [   86.584169] mousedev: PS/2 mouse device common for all mice711vm-test-run-amcheck-upgrade> server # [   90.583151] systemd-logind[651]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)712vm-test-run-amcheck-upgrade> server # [   91.264018] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: running bootstrap script ... ok713vm-test-run-amcheck-upgrade> server # [  105.482967] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: performing post-bootstrap initialization ... ok714vm-test-run-amcheck-upgrade> server # [  108.496028] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: syncing data to disk ... ok715vm-test-run-amcheck-upgrade> server # [  108.498755] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: initdb: warning: enabling "trust" authentication for local connections716vm-test-run-amcheck-upgrade> server # [  108.499364] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: 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.717vm-test-run-amcheck-upgrade> server # [  108.503348] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]: Success. You can now start the database server using:718vm-test-run-amcheck-upgrade> server # [  108.506593] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[939]:     /nix/store/2bhdbvpk81xy3mkfgqrpc719ip588cba-postgresql-and-plugins-15.19/bin/pg_ctl -D /var/lib/postgresql/data -l logfile start719vm-test-run-amcheck-upgrade> server # [  110.613997] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[928]: Validating PostgreSQL configuration...720vm-test-run-amcheck-upgrade> server # [  111.111600] 0kr7wx8rrfnvnx1fblkl6id4af4rvych-postgresql-init[1374]: pg_stat_statements, pgaudit, plpgsql, plpgsql_check, pg_cron, pg_net, pgsodium, timescaledb, auto_explain, pg_tle, plan_filter, supabase_vault721vm-test-run-amcheck-upgrade> server # [  112.743887] postgres[1380]:  2026-10-07 20:39:00.088 UTC [1380] LOG:  pgaudit extension initialized722vm-test-run-amcheck-upgrade> server # [  113.695521] postgres[1380]:  2026-10-07 20:39:01.059 UTC [1380] LOG:  pgsodium primary server secret key loaded723vm-test-run-amcheck-upgrade> server # [  114.238800] postgres[1380]:  2026-10-07 20:39:01.586 UTC [1380] LOG:  vault primary server secret key loaded724vm-test-run-amcheck-upgrade> server # [  115.125163] postgres[1380]:  2026-10-07 20:39:02.489 UTC [1380] LOG:  starting PostgreSQL 15.19 on aarch64-unknown-linux-gnu, compiled by gcc (GCC) 15.2.0, 64-bit725vm-test-run-amcheck-upgrade> server # [  115.151894] postgres[1380]:  2026-10-07 20:39:02.516 UTC [1380] LOG:  listening on IPv4 address "0.0.0.0", port 5432726vm-test-run-amcheck-upgrade> server # [  115.155089] postgres[1380]:  2026-10-07 20:39:02.519 UTC [1380] LOG:  listening on IPv6 address "::", port 5432727vm-test-run-amcheck-upgrade> server # [  115.177027] postgres[1380]:  2026-10-07 20:39:02.538 UTC [1380] LOG:  listening on Unix socket "/run/postgresql/.s.PGSQL.5432"728vm-test-run-amcheck-upgrade> server # [  115.494577] postgres[1429]:  2026-10-07 20:39:02.839 UTC [1429] LOG:  database system was shut down at 2026-10-07 20:38:52 UTC729vm-test-run-amcheck-upgrade> server # [  116.015705] postgres[1380]:  2026-10-07 20:39:03.355 UTC [1380] LOG:  database system is ready to accept connections730vm-test-run-amcheck-upgrade> server # [  116.047504] systemd[1]: Started PostgreSQL Database Server.731vm-test-run-amcheck-upgrade> server # [  116.187162] postgres[1438]:  2026-10-07 20:39:03.505 UTC [1438] LOG:  TimescaleDB background worker launcher connected to shared catalogs732vm-test-run-amcheck-upgrade> server # [  116.205118] systemd[1]: Starting Supabase Database Initialization...733vm-test-run-amcheck-upgrade> server # [  116.263252] postgres[1440]:  2026-10-07 20:39:03.537 UTC [1440] FATAL:  role "postgres" does not exist734vm-test-run-amcheck-upgrade> server # [  116.663393] postgres[1380]:  2026-10-07 20:39:04.026 UTC [1380] LOG:  background worker "pg_net 0.20.4 worker" (PID 1440) exited with exit code 1735vm-test-run-amcheck-upgrade> server # [  116.923379] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Waiting for PostgreSQL to be ready...736vm-test-run-amcheck-upgrade> server # [  117.160441] postgres[1441]:  2026-10-07 20:39:04.497 UTC [1441] LOG:  pg_cron scheduler started737vm-test-run-amcheck-upgrade> server # [  117.636894] postgres[1450]: ::1 2026-10-07 20:39:04.995 UTC [1450] root@root FATAL:  role "root" does not exist738vm-test-run-amcheck-upgrade> server # [  117.681900] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: PostgreSQL is ready739vm-test-run-amcheck-upgrade> server # [  117.687805] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Creating postgres role...740vm-test-run-amcheck-upgrade> server # [  117.771991] postgres[1452]:  2026-10-07 20:39:05.127 UTC [1452] FATAL:  role "postgres" does not exist741vm-test-run-amcheck-upgrade> server # [  117.877119] postgres[1380]:  2026-10-07 20:39:05.233 UTC [1380] LOG:  background worker "pg_net 0.20.4 worker" (PID 1452) exited with exit code 1742vm-test-run-amcheck-upgrade> server # [  118.309535] postgres[1456]: ::1 2026-10-07 20:39:05.651 UTC [1456] supabase_admin@postgres LOG:  statement: CREATE ROLE postgres SUPERUSER LOGIN;743vm-test-run-amcheck-upgrade> server # [  118.356793] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1451]: CREATE ROLE744vm-test-run-amcheck-upgrade> server # [  118.889029] postgres[1459]: ::1 2026-10-07 20:39:06.213 UTC [1459] supabase_admin@postgres LOG:  statement: ALTER DATABASE postgres OWNER TO postgres;745vm-test-run-amcheck-upgrade> server # [  118.935268] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1458]: ALTER DATABASE746vm-test-run-amcheck-upgrade> server # [  119.018677] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000000-initial-schema.sql747vm-test-run-amcheck-upgrade> server # [  119.493030] postgres[1471]: ::1 2026-10-07 20:39:06.838 UTC [1471] postgres@postgres LOG:  statement: create publication supabase_realtime;748vm-test-run-amcheck-upgrade> server # [  119.514732] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: CREATE PUBLICATION749vm-test-run-amcheck-upgrade> server # [  119.529396] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: ALTER ROLE750vm-test-run-amcheck-upgrade> server # [  119.531444] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: CREATE ROLE751vm-test-run-amcheck-upgrade> server # [  119.534724] postgres[1471]: ::1 2026-10-07 20:39:06.871 UTC [1471] postgres@postgres LOG:  statement: alter user  supabase_admin with superuser createdb createrole replication bypassrls;752vm-test-run-amcheck-upgrade> server # [  119.536049] postgres[1471]: ::1 2026-10-07 20:39:06.879 UTC [1471] postgres@postgres LOG:  statement: create user supabase_replication_admin with login replication;753vm-test-run-amcheck-upgrade> server # [  119.538227] postgres[1471]: ::1 2026-10-07 20:39:06.888 UTC [1471] postgres@postgres LOG:  statement: create user supabase_etl_admin with login replication bypassrls;754vm-test-run-amcheck-upgrade> server # [  119.545068] postgres[1471]: ::1 2026-10-07 20:39:06.902 UTC [1471] postgres@postgres LOG:  statement: grant pg_read_all_data to supabase_etl_admin;755vm-test-run-amcheck-upgrade> server # [  119.547928] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: CREATE ROLE756vm-test-run-amcheck-upgrade> server # [  119.561443] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: GRANT ROLE757vm-test-run-amcheck-upgrade> server # [  119.562973] postgres[1471]: ::1 2026-10-07 20:39:06.926 UTC [1471] postgres@postgres LOG:  statement: grant create on database postgres to supabase_etl_admin;758vm-test-run-amcheck-upgrade> server # [  119.576982] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: GRANT759vm-test-run-amcheck-upgrade> server # [  119.579711] postgres[1471]: ::1 2026-10-07 20:39:06.944 UTC [1471] postgres@postgres LOG:  statement: create role supabase_read_only_user with login bypassrls;760vm-test-run-amcheck-upgrade> server # [  119.609474] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: CREATE ROLE761vm-test-run-amcheck-upgrade> server # [  119.617749] postgres[1471]: ::1 2026-10-07 20:39:06.969 UTC [1471] postgres@postgres LOG:  statement: grant pg_read_all_data to supabase_read_only_user;762vm-test-run-amcheck-upgrade> server # [  119.632876] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: GRANT ROLE763vm-test-run-amcheck-upgrade> server # [  119.641516] postgres[1471]: ::1 2026-10-07 20:39:07.002 UTC [1471] postgres@postgres LOG:  statement: create schema if not exists extensions;764vm-test-run-amcheck-upgrade> server # [  119.668063] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: CREATE SCHEMA765vm-test-run-amcheck-upgrade> server # [  119.682837] postgres[1471]: ::1 2026-10-07 20:39:07.041 UTC [1471] postgres@postgres LOG:  statement: create extension if not exists "uuid-ossp"      with schema extensions;766vm-test-run-amcheck-upgrade> server # [  123.018591] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: CREATE EXTENSION767vm-test-run-amcheck-upgrade> server # [  123.036030] postgres[1471]: ::1 2026-10-07 20:39:10.378 UTC [1471] postgres@postgres LOG:  statement: create extension if not exists pgcrypto         with schema extensions;768vm-test-run-amcheck-upgrade> server # [  124.321356] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: CREATE EXTENSION769vm-test-run-amcheck-upgrade> server # [  124.334665] postgres[1471]: ::1 2026-10-07 20:39:11.679 UTC [1471] postgres@postgres LOG:  statement: create role anon                nologin noinherit;770vm-test-run-amcheck-upgrade> server # [  124.339140] postgres[1471]: ::1 2026-10-07 20:39:11.699 UTC [1471] postgres@postgres LOG:  statement: create role authenticated       nologin noinherit;771vm-test-run-amcheck-upgrade> server # [  124.341396] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: CREATE ROLE772vm-test-run-amcheck-upgrade> server # [  124.347974] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: CREATE ROLE773vm-test-run-amcheck-upgrade> server # [  124.357539] postgres[1471]: ::1 2026-10-07 20:39:11.716 UTC [1471] postgres@postgres LOG:  statement: create role service_role        nologin noinherit bypassrls;774vm-test-run-amcheck-upgrade> server # [  124.380034] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: CREATE ROLE775vm-test-run-amcheck-upgrade> server # [  124.381285] postgres[1471]: ::1 2026-10-07 20:39:11.735 UTC [1471] postgres@postgres LOG:  statement: create user authenticator noinherit;776vm-test-run-amcheck-upgrade> server # [  124.389220] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: CREATE ROLE777vm-test-run-amcheck-upgrade> server # [  124.390708] postgres[1471]: ::1 2026-10-07 20:39:11.753 UTC [1471] postgres@postgres LOG:  statement: grant anon              to authenticator;778vm-test-run-amcheck-upgrade> server # [  124.413062] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: GRANT ROLE779vm-test-run-amcheck-upgrade> server # [  124.414094] postgres[1471]: ::1 2026-10-07 20:39:11.778 UTC [1471] postgres@postgres LOG:  statement: grant authenticated     to authenticator;780vm-test-run-amcheck-upgrade> server # [  124.429444] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: GRANT ROLE781vm-test-run-amcheck-upgrade> server # [  124.431950] postgres[1471]: ::1 2026-10-07 20:39:11.795 UTC [1471] postgres@postgres LOG:  statement: grant service_role      to authenticator;782vm-test-run-amcheck-upgrade> server # [  124.446888] postgres[1471]: ::1 2026-10-07 20:39:11.811 UTC [1471] postgres@postgres LOG:  statement: grant supabase_admin    to authenticator;783vm-test-run-amcheck-upgrade> server # [  124.448326] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: GRANT ROLE784vm-test-run-amcheck-upgrade> server # [  124.461544] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: GRANT ROLE785vm-test-run-amcheck-upgrade> server # [  124.462820] postgres[1471]: ::1 2026-10-07 20:39:11.827 UTC [1471] postgres@postgres LOG:  statement: grant usage                     on schema public to postgres, anon, authenticated, service_role;786vm-test-run-amcheck-upgrade> server # [  124.493539] postgres[1471]: ::1 2026-10-07 20:39:11.840 UTC [1471] postgres@postgres LOG:  statement: alter default privileges in schema public grant all on tables to postgres, anon, authenticated, service_role;787vm-test-run-amcheck-upgrade> server # [  124.511755] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: GRANT788vm-test-run-amcheck-upgrade> server # [  124.515964] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: ALTER DEFAULT PRIVILEGES789vm-test-run-amcheck-upgrade> server # [  124.521621] postgres[1471]: ::1 2026-10-07 20:39:11.873 UTC [1471] postgres@postgres LOG:  statement: alter default privileges in schema public grant all on functions to postgres, anon, authenticated, service_role;790vm-test-run-amcheck-upgrade> server # [  124.545022] postgres[1471]: ::1 2026-10-07 20:39:11.892 UTC [1471] postgres@postgres LOG:  statement: alter default privileges in schema public grant all on sequences to postgres, anon, authenticated, service_role;791vm-test-run-amcheck-upgrade> server # [  124.563051] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: ALTER DEFAULT PRIVILEGES792vm-test-run-amcheck-upgrade> server # [  124.563896] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: ALTER DEFAULT PRIVILEGES793vm-test-run-amcheck-upgrade> server # [  124.564304] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: GRANT794vm-test-run-amcheck-upgrade> server # [  124.573858] postgres[1471]: ::1 2026-10-07 20:39:11.910 UTC [1471] postgres@postgres LOG:  statement: grant usage                     on schema extensions to postgres, anon, authenticated, service_role;795vm-test-run-amcheck-upgrade> server # [  124.584834] postgres[1471]: ::1 2026-10-07 20:39:11.924 UTC [1471] postgres@postgres LOG:  statement: alter user supabase_admin SET search_path TO public, extensions;796vm-test-run-amcheck-upgrade> server # [  124.592072] postgres[1471]: ::1 2026-10-07 20:39:11.944 UTC [1471] postgres@postgres LOG:  statement: alter default privileges for user supabase_admin in schema public grant all797vm-test-run-amcheck-upgrade> server # [  124.598701] postgres[1471]: 	    on sequences to postgres, anon, authenticated, service_role;798vm-test-run-amcheck-upgrade> server # [  124.605482] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: ALTER ROLE799vm-test-run-amcheck-upgrade> server # [  124.606901] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: ALTER DEFAULT PRIVILEGES800vm-test-run-amcheck-upgrade> server # [  124.611572] postgres[1471]: ::1 2026-10-07 20:39:11.961 UTC [1471] postgres@postgres LOG:  statement: alter default privileges for user supabase_admin in schema public grant all801vm-test-run-amcheck-upgrade> server # [  124.618791] postgres[1471]: 	    on tables to postgres, anon, authenticated, service_role;802vm-test-run-amcheck-upgrade> server # [  124.627436] postgres[1471]: ::1 2026-10-07 20:39:11.981 UTC [1471] postgres@postgres LOG:  statement: alter default privileges for user supabase_admin in schema public grant all803vm-test-run-amcheck-upgrade> server # [  124.634709] postgres[1471]: 	    on functions to postgres, anon, authenticated, service_role;804vm-test-run-amcheck-upgrade> server # [  124.638734] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: ALTER DEFAULT PRIVILEGES805vm-test-run-amcheck-upgrade> server # [  124.652879] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: ALTER DEFAULT PRIVILEGES806vm-test-run-amcheck-upgrade> server # [  124.654878] postgres[1471]: ::1 2026-10-07 20:39:11.997 UTC [1471] postgres@postgres LOG:  statement: alter role anon set statement_timeout = '3s';807vm-test-run-amcheck-upgrade> server # [  124.678393] postgres[1471]: ::1 2026-10-07 20:39:12.013 UTC [1471] postgres@postgres LOG:  statement: alter role authenticated set statement_timeout = '8s';808vm-test-run-amcheck-upgrade> server # [  124.686617] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: ALTER ROLE809vm-test-run-amcheck-upgrade> server # [  124.703976] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1465]: ALTER ROLE810vm-test-run-amcheck-upgrade> server # [  124.742621] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000001-auth-schema.sql811vm-test-run-amcheck-upgrade> server # [  125.106070] postgres[1516]: ::1 2026-10-07 20:39:12.463 UTC [1516] postgres@postgres LOG:  statement: CREATE SCHEMA IF NOT EXISTS auth AUTHORIZATION supabase_admin;812vm-test-run-amcheck-upgrade> server # [  125.127251] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE SCHEMA813vm-test-run-amcheck-upgrade> server # [  125.128456] postgres[1516]: ::1 2026-10-07 20:39:12.487 UTC [1516] postgres@postgres LOG:  statement: CREATE TABLE auth.users (814vm-test-run-amcheck-upgrade> server # [  125.138097] postgres[1516]: 	    instance_id uuid NULL,815vm-test-run-amcheck-upgrade> server # [  125.139616] postgres[1516]: 	    id uuid NOT NULL UNIQUE,816vm-test-run-amcheck-upgrade> server # [  125.145244] postgres[1516]: 	    aud varchar(255) NULL,817vm-test-run-amcheck-upgrade> server # [  125.146339] postgres[1516]: 	    "role" varchar(255) NULL,818vm-test-run-amcheck-upgrade> server # [  125.147508] postgres[1516]: 	    email varchar(255) NULL UNIQUE,819vm-test-run-amcheck-upgrade> server # [  125.153494] postgres[1516]: 	    encrypted_password varchar(255) NULL,820vm-test-run-amcheck-upgrade> server # [  125.154947] postgres[1516]: 	    confirmed_at timestamptz NULL,821vm-test-run-amcheck-upgrade> server # [  125.155418] postgres[1516]: 	    invited_at timestamptz NULL,822vm-test-run-amcheck-upgrade> server # [  125.156150] postgres[1516]: 	    confirmation_token varchar(255) NULL,823vm-test-run-amcheck-upgrade> server # [  125.162763] postgres[1516]: 	    confirmation_sent_at timestamptz NULL,824vm-test-run-amcheck-upgrade> server # [  125.165348] postgres[1516]: 	    recovery_token varchar(255) NULL,825vm-test-run-amcheck-upgrade> server # [  125.166556] postgres[1516]: 	    recovery_sent_at timestamptz NULL,826vm-test-run-amcheck-upgrade> server # [  125.167479] postgres[1516]: 	    email_change_token varchar(255) NULL,827vm-test-run-amcheck-upgrade> server # [  125.174587] postgres[1516]: 	    email_change varchar(255) NULL,828vm-test-run-amcheck-upgrade> server # [  125.176812] postgres[1516]: 	    email_change_sent_at timestamptz NULL,829vm-test-run-amcheck-upgrade> server # [  125.178355] postgres[1516]: 	    last_sign_in_at timestamptz NULL,830vm-test-run-amcheck-upgrade> server # [  125.182542] postgres[1516]: 	    raw_app_meta_data jsonb NULL,831vm-test-run-amcheck-upgrade> server # [  125.183581] postgres[1516]: 	    raw_user_meta_data jsonb NULL,832vm-test-run-amcheck-upgrade> server # [  125.185965] postgres[1516]: 	    is_super_admin bool NULL,833vm-test-run-amcheck-upgrade> server # [  125.186408] postgres[1516]: 	    created_at timestamptz NULL,834vm-test-run-amcheck-upgrade> server # [  125.188448] postgres[1516]: 	    updated_at timestamptz NULL,835vm-test-run-amcheck-upgrade> server # [  125.190810] postgres[1516]: 	    CONSTRAINT users_pkey PRIMARY KEY (id)836vm-test-run-amcheck-upgrade> server # [  125.191287] postgres[1516]: 	);837vm-test-run-amcheck-upgrade> server # [  125.287104] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE TABLE838vm-test-run-amcheck-upgrade> server # [  125.295067] postgres[1516]: ::1 2026-10-07 20:39:12.658 UTC [1516] postgres@postgres LOG:  statement: CREATE INDEX users_instance_id_email_idx ON auth.users USING btree (instance_id, email);839vm-test-run-amcheck-upgrade> server # [  125.331611] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE INDEX840vm-test-run-amcheck-upgrade> server # [  125.337947] postgres[1516]: ::1 2026-10-07 20:39:12.699 UTC [1516] postgres@postgres LOG:  statement: CREATE INDEX users_instance_id_idx ON auth.users USING btree (instance_id);841vm-test-run-amcheck-upgrade> server # [  125.368045] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE INDEX842vm-test-run-amcheck-upgrade> server # [  125.370592] postgres[1516]: ::1 2026-10-07 20:39:12.735 UTC [1516] postgres@postgres LOG:  statement: comment on table auth.users is 'Auth: Stores user login data within a secure schema.';843vm-test-run-amcheck-upgrade> server # [  125.387980] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: COMMENT844vm-test-run-amcheck-upgrade> server # [  125.393817] postgres[1516]: ::1 2026-10-07 20:39:12.752 UTC [1516] postgres@postgres LOG:  statement: CREATE TABLE auth.refresh_tokens (845vm-test-run-amcheck-upgrade> server # [  125.395889] postgres[1516]: 	    instance_id uuid NULL,846vm-test-run-amcheck-upgrade> server # [  125.397491] postgres[1516]: 	    id bigserial NOT NULL,847vm-test-run-amcheck-upgrade> server # [  125.397933] postgres[1516]: 	    "token" varchar(255) NULL,848vm-test-run-amcheck-upgrade> server # [  125.398393] postgres[1516]: 	    user_id varchar(255) NULL,849vm-test-run-amcheck-upgrade> server # [  125.398699] postgres[1516]: 	    revoked bool NULL,850vm-test-run-amcheck-upgrade> server # [  125.399006] postgres[1516]: 	    created_at timestamptz NULL,851vm-test-run-amcheck-upgrade> server # [  125.399331] postgres[1516]: 	    updated_at timestamptz NULL,852vm-test-run-amcheck-upgrade> server # [  125.399591] postgres[1516]: 	    CONSTRAINT refresh_tokens_pkey PRIMARY KEY (id)853vm-test-run-amcheck-upgrade> server # [  125.401491] postgres[1516]: 	);854vm-test-run-amcheck-upgrade> server # [  125.501423] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE TABLE855vm-test-run-amcheck-upgrade> server # [  125.505448] postgres[1516]: ::1 2026-10-07 20:39:12.869 UTC [1516] postgres@postgres LOG:  statement: CREATE INDEX refresh_tokens_instance_id_idx ON auth.refresh_tokens USING btree (instance_id);856vm-test-run-amcheck-upgrade> server # [  125.537283] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE INDEX857vm-test-run-amcheck-upgrade> server # [  125.543068] postgres[1516]: ::1 2026-10-07 20:39:12.903 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);858vm-test-run-amcheck-upgrade> server # [  125.565769] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE INDEX859vm-test-run-amcheck-upgrade> server # [  125.571226] postgres[1516]: ::1 2026-10-07 20:39:12.935 UTC [1516] postgres@postgres LOG:  statement: CREATE INDEX refresh_tokens_token_idx ON auth.refresh_tokens USING btree (token);860vm-test-run-amcheck-upgrade> server # [  125.604673] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE INDEX861vm-test-run-amcheck-upgrade> server # [  125.614223] postgres[1516]: ::1 2026-10-07 20:39:12.973 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.';862vm-test-run-amcheck-upgrade> server # [  125.619460] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: COMMENT863vm-test-run-amcheck-upgrade> server # [  125.626727] postgres[1516]: ::1 2026-10-07 20:39:12.988 UTC [1516] postgres@postgres LOG:  statement: CREATE TABLE auth.instances (864vm-test-run-amcheck-upgrade> server # [  125.627892] postgres[1516]: 	    id uuid NOT NULL,865vm-test-run-amcheck-upgrade> server # [  125.629410] postgres[1516]: 	    uuid uuid NULL,866vm-test-run-amcheck-upgrade> server # [  125.630949] postgres[1516]: 	    raw_base_config text NULL,867vm-test-run-amcheck-upgrade> server # [  125.631345] postgres[1516]: 	    created_at timestamptz NULL,868vm-test-run-amcheck-upgrade> server # [  125.633336] postgres[1516]: 	    updated_at timestamptz NULL,869vm-test-run-amcheck-upgrade> server # [  125.634572] postgres[1516]: 	    CONSTRAINT instances_pkey PRIMARY KEY (id)870vm-test-run-amcheck-upgrade> server # [  125.636100] postgres[1516]: 	);871vm-test-run-amcheck-upgrade> server # [  125.701633] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE TABLE872vm-test-run-amcheck-upgrade> server # [  125.703523] postgres[1516]: ::1 2026-10-07 20:39:13.068 UTC [1516] postgres@postgres LOG:  statement: comment on table auth.instances is 'Auth: Manages users across multiple sites.';873vm-test-run-amcheck-upgrade> server # [  125.712544] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: COMMENT874vm-test-run-amcheck-upgrade> server # [  125.717882] postgres[1516]: ::1 2026-10-07 20:39:13.083 UTC [1516] postgres@postgres LOG:  statement: CREATE TABLE auth.audit_log_entries (875vm-test-run-amcheck-upgrade> server # [  125.720658] postgres[1516]: 	    instance_id uuid NULL,876vm-test-run-amcheck-upgrade> server # [  125.721238] postgres[1516]: 	    id uuid NOT NULL,877vm-test-run-amcheck-upgrade> server # [  125.722416] postgres[1516]: 	    payload json NULL,878vm-test-run-amcheck-upgrade> server # [  125.723399] postgres[1516]: 	    created_at timestamptz NULL,879vm-test-run-amcheck-upgrade> server # [  125.724743] postgres[1516]: 	    CONSTRAINT audit_log_entries_pkey PRIMARY KEY (id)880vm-test-run-amcheck-upgrade> server # [  125.726389] postgres[1516]: 	);881vm-test-run-amcheck-upgrade> server # [  125.789266] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE TABLE882vm-test-run-amcheck-upgrade> server # [  125.790754] postgres[1516]: ::1 2026-10-07 20:39:13.154 UTC [1516] postgres@postgres LOG:  statement: CREATE INDEX audit_logs_instance_id_idx ON auth.audit_log_entries USING btree (instance_id);883vm-test-run-amcheck-upgrade> server # [  125.817834] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE INDEX884vm-test-run-amcheck-upgrade> server # [  125.825185] postgres[1516]: ::1 2026-10-07 20:39:13.187 UTC [1516] postgres@postgres LOG:  statement: comment on table auth.audit_log_entries is 'Auth: Audit trail for user actions.';885vm-test-run-amcheck-upgrade> server # [  125.833702] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: COMMENT886vm-test-run-amcheck-upgrade> server # [  125.840821] postgres[1516]: ::1 2026-10-07 20:39:13.202 UTC [1516] postgres@postgres LOG:  statement: CREATE TABLE auth.schema_migrations (887vm-test-run-amcheck-upgrade> server # [  125.842989] postgres[1516]: 	    "version" varchar(255) NOT NULL,888vm-test-run-amcheck-upgrade> server # [  125.863530] postgres[1516]: 	    CONSTRAINT schema_migrations_pkey PRIMARY KEY ("version")889vm-test-run-amcheck-upgrade> server # [  125.865387] postgres[1516]: 	);890vm-test-run-amcheck-upgrade> server # [  125.935540] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE TABLE891vm-test-run-amcheck-upgrade> server # [  125.944113] postgres[1516]: ::1 2026-10-07 20:39:13.301 UTC [1516] postgres@postgres LOG:  statement: comment on table auth.schema_migrations is 'Auth: Manages updates to the auth system.';892vm-test-run-amcheck-upgrade> server # [  125.952451] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: COMMENT893vm-test-run-amcheck-upgrade> server # [  125.998651] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: INSERT 0 7894vm-test-run-amcheck-upgrade> server # [  126.009234] postgres[1516]: ::1 2026-10-07 20:39:13.371 UTC [1516] postgres@postgres LOG:  statement: create or replace function auth.uid() returns uuid as $$895vm-test-run-amcheck-upgrade> server # [  126.011206] postgres[1516]: 	  select nullif(current_setting('request.jwt.claim.sub', true), '')::uuid;896vm-test-run-amcheck-upgrade> server # [  126.022805] postgres[1516]: 	$$ language sql stable;897vm-test-run-amcheck-upgrade> server # [  126.035462] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE FUNCTION898vm-test-run-amcheck-upgrade> server # [  126.039604] postgres[1516]: ::1 2026-10-07 20:39:13.401 UTC [1516] postgres@postgres LOG:  statement: create or replace function auth.role() returns text as $$899vm-test-run-amcheck-upgrade> server # [  126.042899] postgres[1516]: 	  select nullif(current_setting('request.jwt.claim.role', true), '')::text;900vm-test-run-amcheck-upgrade> server # [  126.046059] postgres[1516]: 	$$ language sql stable;901vm-test-run-amcheck-upgrade> server # [  126.061574] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE FUNCTION902vm-test-run-amcheck-upgrade> server # [  126.075981] postgres[1516]: ::1 2026-10-07 20:39:13.438 UTC [1516] postgres@postgres LOG:  statement: create or replace function auth.email() returns text as $$903vm-test-run-amcheck-upgrade> server # [  126.086352] postgres[1516]: 	  select nullif(current_setting('request.jwt.claim.email', true), '')::text;904vm-test-run-amcheck-upgrade> server # [  126.087475] postgres[1516]: 	$$ language sql stable;905vm-test-run-amcheck-upgrade> server # [  126.098487] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE FUNCTION906vm-test-run-amcheck-upgrade> server # [  126.129541] postgres[1516]: ::1 2026-10-07 20:39:13.464 UTC [1516] postgres@postgres LOG:  statement: GRANT USAGE ON SCHEMA auth TO anon, authenticated, service_role;907vm-test-run-amcheck-upgrade> server # [  126.131516] postgres[1516]: ::1 2026-10-07 20:39:13.484 UTC [1516] postgres@postgres LOG:  statement: CREATE USER supabase_auth_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;908vm-test-run-amcheck-upgrade> server # [  126.160385] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: GRANT909vm-test-run-amcheck-upgrade> server # [  126.162848] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: CREATE ROLE910vm-test-run-amcheck-upgrade> server # [  126.164116] postgres[1516]: ::1 2026-10-07 20:39:13.507 UTC [1516] postgres@postgres LOG:  statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;911vm-test-run-amcheck-upgrade> server # [  126.171261] postgres[1516]: ::1 2026-10-07 20:39:13.526 UTC [1516] postgres@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;912vm-test-run-amcheck-upgrade> server # [  126.186877] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: GRANT913vm-test-run-amcheck-upgrade> server # [  126.187783] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: GRANT914vm-test-run-amcheck-upgrade> server # [  126.203969] postgres[1516]: ::1 2026-10-07 20:39:13.551 UTC [1516] postgres@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;915vm-test-run-amcheck-upgrade> server # [  126.208458] postgres[1516]: ::1 2026-10-07 20:39:13.568 UTC [1516] postgres@postgres LOG:  statement: ALTER USER supabase_auth_admin SET search_path = "auth";916vm-test-run-amcheck-upgrade> server # [  126.231489] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: GRANT917vm-test-run-amcheck-upgrade> server # [  126.237959] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: ALTER ROLE918vm-test-run-amcheck-upgrade> server # [  126.239027] postgres[1516]: ::1 2026-10-07 20:39:13.595 UTC [1516] postgres@postgres LOG:  statement: ALTER table "auth".users OWNER TO supabase_auth_admin;919vm-test-run-amcheck-upgrade> server # [  126.258610] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: ALTER TABLE920vm-test-run-amcheck-upgrade> server # [  126.260052] postgres[1516]: ::1 2026-10-07 20:39:13.624 UTC [1516] postgres@postgres LOG:  statement: ALTER table "auth".refresh_tokens OWNER TO supabase_auth_admin;921vm-test-run-amcheck-upgrade> server # [  126.294664] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: ALTER TABLE922vm-test-run-amcheck-upgrade> server # [  126.295589] postgres[1516]: ::1 2026-10-07 20:39:13.659 UTC [1516] postgres@postgres LOG:  statement: ALTER table "auth".audit_log_entries OWNER TO supabase_auth_admin;923vm-test-run-amcheck-upgrade> server # [  126.323057] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: ALTER TABLE924vm-test-run-amcheck-upgrade> server # [  126.334606] postgres[1516]: ::1 2026-10-07 20:39:13.692 UTC [1516] postgres@postgres LOG:  statement: ALTER table "auth".instances OWNER TO supabase_auth_admin;925vm-test-run-amcheck-upgrade> server # [  126.346900] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: ALTER TABLE926vm-test-run-amcheck-upgrade> server # [  126.353614] postgres[1516]: ::1 2026-10-07 20:39:13.711 UTC [1516] postgres@postgres LOG:  statement: ALTER table "auth".schema_migrations OWNER TO supabase_auth_admin;927vm-test-run-amcheck-upgrade> server # [  126.381998] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1515]: ALTER TABLE928vm-test-run-amcheck-upgrade> server # [  126.461441] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000002-storage-schema.sql929vm-test-run-amcheck-upgrade> server # [  126.935448] postgres[1536]: ::1 2026-10-07 20:39:14.288 UTC [1536] postgres@postgres LOG:  statement: CREATE SCHEMA IF NOT EXISTS storage AUTHORIZATION supabase_admin;930vm-test-run-amcheck-upgrade> server # [  126.991333] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1529]: CREATE SCHEMA931vm-test-run-amcheck-upgrade> server # [  126.994409] postgres[1536]: ::1 2026-10-07 20:39:14.330 UTC [1536] postgres@postgres LOG:  statement: CREATE USER supabase_storage_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;932vm-test-run-amcheck-upgrade> server # [  126.996329] postgres[1536]: ::1 2026-10-07 20:39:14.346 UTC [1536] postgres@postgres LOG:  statement: ALTER USER supabase_storage_admin SET search_path = "storage";933vm-test-run-amcheck-upgrade> server # [  127.009022] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1529]: CREATE ROLE934vm-test-run-amcheck-upgrade> server # [  127.012236] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1529]: ALTER ROLE935vm-test-run-amcheck-upgrade> server # [  127.019135] postgres[1536]: ::1 2026-10-07 20:39:14.383 UTC [1536] postgres@postgres LOG:  statement: GRANT CREATE ON DATABASE postgres TO supabase_storage_admin;936vm-test-run-amcheck-upgrade> server # [  127.059078] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1529]: GRANT937vm-test-run-amcheck-upgrade> server # [  127.140207] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1529]: DO938vm-test-run-amcheck-upgrade> server # [  127.217723] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running init-script: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/init-scripts/00000000000003-post-setup.sql939vm-test-run-amcheck-upgrade> server # [  127.723362] postgres[1544]: ::1 2026-10-07 20:39:15.078 UTC [1544] postgres@postgres LOG:  statement: ALTER ROLE supabase_admin SET search_path TO "\$user",public,auth,extensions;940vm-test-run-amcheck-upgrade> server # [  127.746742] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: ALTER ROLE941vm-test-run-amcheck-upgrade> server # [  127.750377] postgres[1544]: ::1 2026-10-07 20:39:15.111 UTC [1544] postgres@postgres LOG:  statement: ALTER ROLE postgres SET search_path TO "\$user",public,extensions;942vm-test-run-amcheck-upgrade> server # [  127.757474] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: ALTER ROLE943vm-test-run-amcheck-upgrade> server # [  127.764989] postgres[1544]: ::1 2026-10-07 20:39:15.125 UTC [1544] postgres@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access()944vm-test-run-amcheck-upgrade> server # [  127.765912] postgres[1544]: 	RETURNS event_trigger945vm-test-run-amcheck-upgrade> server # [  127.767122] postgres[1544]: 	LANGUAGE plpgsql946vm-test-run-amcheck-upgrade> server # [  127.767826] postgres[1544]: 	AS $$947vm-test-run-amcheck-upgrade> server # [  127.773878] postgres[1544]: 	DECLARE948vm-test-run-amcheck-upgrade> server # [  127.775217] postgres[1544]: 	  schema_is_cron bool;949vm-test-run-amcheck-upgrade> server # [  127.776937] postgres[1544]: 	BEGIN950vm-test-run-amcheck-upgrade> server # [  127.778384] postgres[1544]: 	  schema_is_cron = (951vm-test-run-amcheck-upgrade> server # [  127.779274] postgres[1544]: 	    SELECT n.nspname = 'cron'952vm-test-run-amcheck-upgrade> server # [  127.779904] postgres[1544]: 	    FROM pg_event_trigger_ddl_commands() AS ev953vm-test-run-amcheck-upgrade> server # [  127.782366] postgres[1544]: 	    LEFT JOIN pg_catalog.pg_namespace AS n954vm-test-run-amcheck-upgrade> server # [  127.783279] postgres[1544]: 	      ON ev.objid = n.oid955vm-test-run-amcheck-upgrade> server # [  127.784421] postgres[1544]: 	  );956vm-test-run-amcheck-upgrade> server # [  127.785784] postgres[1544]:957vm-test-run-amcheck-upgrade> server # [  127.786655] postgres[1544]: 	  IF schema_is_cron958vm-test-run-amcheck-upgrade> server # [  127.787236] postgres[1544]: 	  THEN959vm-test-run-amcheck-upgrade> server # [  127.787882] postgres[1544]: 	    grant usage on schema cron to postgres with grant option;960vm-test-run-amcheck-upgrade> server # [  127.788223] postgres[1544]:961vm-test-run-amcheck-upgrade> server # [  127.789392] postgres[1544]: 	    alter default privileges in schema cron grant all on tables to postgres with grant option;962vm-test-run-amcheck-upgrade> server # [  127.790653] postgres[1544]: 	    alter default privileges in schema cron grant all on functions to postgres with grant option;963vm-test-run-amcheck-upgrade> server # [  127.791595] postgres[1544]: 	    alter default privileges in schema cron grant all on sequences to postgres with grant option;964vm-test-run-amcheck-upgrade> server # [  127.793182] postgres[1544]:965vm-test-run-amcheck-upgrade> server # [  127.793635] postgres[1544]: 	    alter default privileges for user supabase_admin in schema cron grant all966vm-test-run-amcheck-upgrade> server # [  127.794061] postgres[1544]: 	        on sequences to postgres with grant option;967vm-test-run-amcheck-upgrade> server # [  127.795459] postgres[1544]: 	    alter default privileges for user supabase_admin in schema cron grant all968vm-test-run-amcheck-upgrade> server # [  127.797375] postgres[1544]: 	        on tables to postgres with grant option;969vm-test-run-amcheck-upgrade> server # [  127.797884] postgres[1544]: 	    alter default privileges for user supabase_admin in schema cron grant all970vm-test-run-amcheck-upgrade> server # [  127.798874] postgres[1544]: 	        on functions to postgres with grant option;971vm-test-run-amcheck-upgrade> server # [  127.801024] postgres[1544]:972vm-test-run-amcheck-upgrade> server # [  127.801441] postgres[1544]: 	    grant all privileges on all tables in schema cron to postgres with grant option;973vm-test-run-amcheck-upgrade> server # [  127.802378] postgres[1544]:974vm-test-run-amcheck-upgrade> server # [  127.803251] postgres[1544]: 	  END IF;975vm-test-run-amcheck-upgrade> server # [  127.804516] postgres[1544]:976vm-test-run-amcheck-upgrade> server # [  127.804966] postgres[1544]: 	END;977vm-test-run-amcheck-upgrade> server # [  127.805912] postgres[1544]: 	$$;978vm-test-run-amcheck-upgrade> server # [  127.813209] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: CREATE FUNCTION979vm-test-run-amcheck-upgrade> server # [  127.814421] postgres[1544]: ::1 2026-10-07 20:39:15.176 UTC [1544] postgres@postgres LOG:  statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end WHEN TAG in ('CREATE SCHEMA')980vm-test-run-amcheck-upgrade> server # [  127.814918] postgres[1544]: 	EXECUTE PROCEDURE extensions.grant_pg_cron_access();981vm-test-run-amcheck-upgrade> server # [  127.823430] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: CREATE EVENT TRIGGER982vm-test-run-amcheck-upgrade> server # [  127.829900] postgres[1544]: ::1 2026-10-07 20:39:15.189 UTC [1544] postgres@postgres LOG:  statement: COMMENT ON FUNCTION extensions.grant_pg_cron_access IS 'Grants access to pg_cron';983vm-test-run-amcheck-upgrade> server # [  127.835987] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: COMMENT984vm-test-run-amcheck-upgrade> server # [  127.840560] postgres[1544]: ::1 2026-10-07 20:39:15.205 UTC [1544] postgres@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_net_access()985vm-test-run-amcheck-upgrade> server # [  127.846063] postgres[1544]: 	RETURNS event_trigger986vm-test-run-amcheck-upgrade> server # [  127.846661] postgres[1544]: 	LANGUAGE plpgsql987vm-test-run-amcheck-upgrade> server # [  127.847636] postgres[1544]: 	AS $$988vm-test-run-amcheck-upgrade> server # [  127.857789] postgres[1544]: 	BEGIN989vm-test-run-amcheck-upgrade> server # [  127.858615] postgres[1544]: 	  IF EXISTS (990vm-test-run-amcheck-upgrade> server # [  127.859449] postgres[1544]: 	    SELECT 1991vm-test-run-amcheck-upgrade> server # [  127.873514] postgres[1544]: 	    FROM pg_event_trigger_ddl_commands() AS ev992vm-test-run-amcheck-upgrade> server # [  127.874998] postgres[1544]: 	    JOIN pg_extension AS ext993vm-test-run-amcheck-upgrade> server # [  127.875978] postgres[1544]: 	    ON ev.objid = ext.oid994vm-test-run-amcheck-upgrade> server # [  127.881325] postgres[1544]: 	    WHERE ext.extname = 'pg_net'995vm-test-run-amcheck-upgrade> server # [  127.882111] postgres[1544]: 	  )996vm-test-run-amcheck-upgrade> server # [  127.882565] postgres[1544]: 	  THEN997vm-test-run-amcheck-upgrade> server # [  127.883229] postgres[1544]: 	    IF NOT EXISTS (998vm-test-run-amcheck-upgrade> server # [  127.883895] postgres[1544]: 	      SELECT 1999vm-test-run-amcheck-upgrade> server # [  127.897174] postgres[1544]: 	      FROM pg_roles1000vm-test-run-amcheck-upgrade> server # [  127.900136] postgres[1544]: 	      WHERE rolname = 'supabase_functions_admin'1001vm-test-run-amcheck-upgrade> server # [  127.907367] postgres[1544]: 	    )1002vm-test-run-amcheck-upgrade> server # [  127.909765] postgres[1544]: 	    THEN1003vm-test-run-amcheck-upgrade> server # [  127.910489] postgres[1544]: 	      CREATE USER supabase_functions_admin NOINHERIT CREATEROLE LOGIN NOREPLICATION;1004vm-test-run-amcheck-upgrade> server # [  127.911102] postgres[1544]: 	    END IF;1005vm-test-run-amcheck-upgrade> server # [  127.917484] postgres[1544]:1006vm-test-run-amcheck-upgrade> server # [  127.918970] postgres[1544]: 	    GRANT USAGE ON SCHEMA net TO supabase_functions_admin, postgres, anon, authenticated, service_role;1007vm-test-run-amcheck-upgrade> server # [  127.919474] postgres[1544]:1008vm-test-run-amcheck-upgrade> server # [  127.920087] postgres[1544]: 	    ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1009vm-test-run-amcheck-upgrade> server # [  127.927293] postgres[1544]: 	    ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SECURITY DEFINER;1010vm-test-run-amcheck-upgrade> server # [  127.934378] postgres[1544]:1011vm-test-run-amcheck-upgrade> server # [  127.935044] postgres[1544]: 	    ALTER function net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1012vm-test-run-amcheck-upgrade> server # [  127.935897] postgres[1544]: 	    ALTER function net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) SET search_path = net;1013vm-test-run-amcheck-upgrade> server # [  127.941981] postgres[1544]:1014vm-test-run-amcheck-upgrade> server # [  127.942708] postgres[1544]: 	    REVOKE ALL ON FUNCTION net.http_get(url text, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1015vm-test-run-amcheck-upgrade> server # [  127.944196] postgres[1544]: 	    REVOKE ALL ON FUNCTION net.http_post(url text, body jsonb, params jsonb, headers jsonb, timeout_milliseconds integer) FROM PUBLIC;1016vm-test-run-amcheck-upgrade> server # [  127.950103] postgres[1544]:1017vm-test-run-amcheck-upgrade> server # [  127.950526] 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;1018vm-test-run-amcheck-upgrade> server # [  127.951639] 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;1019vm-test-run-amcheck-upgrade> server # [  127.961800] postgres[1544]: 	  END IF;1020vm-test-run-amcheck-upgrade> server # [  127.962409] postgres[1544]: 	END;1021vm-test-run-amcheck-upgrade> server # [  127.962950] postgres[1544]: 	$$;1022vm-test-run-amcheck-upgrade> server # [  127.963416] postgres[1544]: ::1 2026-10-07 20:39:15.236 UTC [1544] postgres@postgres LOG:  statement: COMMENT ON FUNCTION extensions.grant_pg_net_access IS 'Grants access to pg_net';1023vm-test-run-amcheck-upgrade> server # [  127.974319] postgres[1544]: ::1 2026-10-07 20:39:15.272 UTC [1544] postgres@postgres LOG:  statement: CREATE ROLE dashboard_user NOSUPERUSER CREATEDB CREATEROLE REPLICATION;1024vm-test-run-amcheck-upgrade> server # [  127.975533] postgres[1544]: ::1 2026-10-07 20:39:15.288 UTC [1544] postgres@postgres LOG:  statement: GRANT ALL ON DATABASE postgres TO dashboard_user;1025vm-test-run-amcheck-upgrade> server # [  127.983627] postgres[1544]: ::1 2026-10-07 20:39:15.299 UTC [1544] postgres@postgres LOG:  statement: GRANT ALL ON SCHEMA auth TO dashboard_user;1026vm-test-run-amcheck-upgrade> server # [  127.989871] postgres[1544]: ::1 2026-10-07 20:39:15.308 UTC [1544] postgres@postgres LOG:  statement: GRANT ALL ON SCHEMA extensions TO dashboard_user;1027vm-test-run-amcheck-upgrade> server # [  127.990789] postgres[1544]: ::1 2026-10-07 20:39:15.323 UTC [1544] postgres@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO dashboard_user;1028vm-test-run-amcheck-upgrade> server # [  128.001780] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: CREATE FUNCTION1029vm-test-run-amcheck-upgrade> server # [  128.002929] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: COMMENT1030vm-test-run-amcheck-upgrade> server # [  128.004587] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: DO1031vm-test-run-amcheck-upgrade> server # [  128.006243] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: CREATE ROLE1032vm-test-run-amcheck-upgrade> server # [  128.007769] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: GRANT1033vm-test-run-amcheck-upgrade> server # [  128.009135] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: GRANT1034vm-test-run-amcheck-upgrade> server # [  128.009826] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: GRANT1035vm-test-run-amcheck-upgrade> server # [  128.010811] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: GRANT1036vm-test-run-amcheck-upgrade> server # [  128.011195] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: GRANT1037vm-test-run-amcheck-upgrade> server # [  128.011803] postgres[1544]: ::1 2026-10-07 20:39:15.351 UTC [1544] postgres@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO dashboard_user;1038vm-test-run-amcheck-upgrade> server # [  128.012830] postgres[1544]: ::1 2026-10-07 20:39:15.362 UTC [1544] postgres@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO dashboard_user;1039vm-test-run-amcheck-upgrade> server # [  128.014173] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: GRANT1040vm-test-run-amcheck-upgrade> server # [  128.014686] postgres[1544]: ::1 2026-10-07 20:39:15.379 UTC [1544] postgres@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO dashboard_user;1041vm-test-run-amcheck-upgrade> server # [  128.021009] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: GRANT1042vm-test-run-amcheck-upgrade> server # [  128.022875] postgres[1544]: ::1 2026-10-07 20:39:15.384 UTC [1544] postgres@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO dashboard_user;1043vm-test-run-amcheck-upgrade> server # [  128.038884] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: GRANT1044vm-test-run-amcheck-upgrade> server # [  128.042786] postgres[1544]: ::1 2026-10-07 20:39:15.406 UTC [1544] postgres@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO dashboard_user;1045vm-test-run-amcheck-upgrade> server # [  128.093217] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: GRANT1046vm-test-run-amcheck-upgrade> server # [  128.109110] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1540]: DO1047vm-test-run-amcheck-upgrade> server # [  128.164039] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running pgbouncer auth schema...1048vm-test-run-amcheck-upgrade> server # [  128.535555] postgres[1546]: ::1 2026-10-07 20:39:15.889 UTC [1546] postgres@postgres LOG:  statement: CREATE USER pgbouncer;1049vm-test-run-amcheck-upgrade> server # [  128.582425] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1545]: CREATE ROLE1050vm-test-run-amcheck-upgrade> server # [  128.583552] postgres[1546]: ::1 2026-10-07 20:39:15.927 UTC [1546] postgres@postgres LOG:  statement: REVOKE ALL PRIVILEGES ON SCHEMA public FROM pgbouncer;1051vm-test-run-amcheck-upgrade> server # [  128.587188] postgres[1546]: ::1 2026-10-07 20:39:15.944 UTC [1546] postgres@postgres LOG:  statement: CREATE SCHEMA pgbouncer AUTHORIZATION pgbouncer;1052vm-test-run-amcheck-upgrade> server # [  128.595225] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1545]: REVOKE1053vm-test-run-amcheck-upgrade> server # [  128.635610] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1545]: CREATE SCHEMA1054vm-test-run-amcheck-upgrade> server # [  128.641244] postgres[1546]: ::1 2026-10-07 20:39:16.003 UTC [1546] postgres@postgres LOG:  statement: CREATE OR REPLACE FUNCTION pgbouncer.get_auth(p_usename TEXT)1055vm-test-run-amcheck-upgrade> server # [  128.643333] postgres[1546]: 	RETURNS TABLE(username TEXT, password TEXT) AS1056vm-test-run-amcheck-upgrade> server # [  128.649812] postgres[1546]: 	$$1057vm-test-run-amcheck-upgrade> server # [  128.650877] postgres[1546]: 	BEGIN1058vm-test-run-amcheck-upgrade> server # [  128.651986] postgres[1546]: 	    RAISE WARNING 'PgBouncer auth request: %', p_usename;1059vm-test-run-amcheck-upgrade> server # [  128.654557] postgres[1546]:1060vm-test-run-amcheck-upgrade> server # [  128.660343] postgres[1546]: 	    RETURN QUERY1061vm-test-run-amcheck-upgrade> server # [  128.664361] postgres[1546]: 	    SELECT usename::TEXT, passwd::TEXT FROM pg_catalog.pg_shadow1062vm-test-run-amcheck-upgrade> server # [  128.666187] postgres[1546]: 	    WHERE usename = p_usename;1063vm-test-run-amcheck-upgrade> server # [  128.666861] postgres[1546]: 	END;1064vm-test-run-amcheck-upgrade> server # [  128.667140] postgres[1546]: 	$$ LANGUAGE plpgsql1065vm-test-run-amcheck-upgrade> server # [  128.667506] postgres[1546]: 	SET search_path = ''1066vm-test-run-amcheck-upgrade> server # [  128.668337] postgres[1546]: 	SECURITY DEFINER;1067vm-test-run-amcheck-upgrade> server # [  128.678296] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1545]: CREATE FUNCTION1068vm-test-run-amcheck-upgrade> server # [  128.683293] postgres[1546]: ::1 2026-10-07 20:39:16.039 UTC [1546] postgres@postgres LOG:  statement: REVOKE ALL ON FUNCTION pgbouncer.get_auth(p_usename TEXT) FROM PUBLIC;1069vm-test-run-amcheck-upgrade> server # [  128.692970] postgres[1546]: ::1 2026-10-07 20:39:16.052 UTC [1546] postgres@postgres LOG:  statement: GRANT EXECUTE ON FUNCTION pgbouncer.get_auth(p_usename TEXT) TO pgbouncer;1070vm-test-run-amcheck-upgrade> server # [  128.694198] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1545]: REVOKE1071vm-test-run-amcheck-upgrade> server # [  128.698929] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1545]: GRANT1072vm-test-run-amcheck-upgrade> server # [  128.763191] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running stat extension...1073vm-test-run-amcheck-upgrade> server # [  129.147491] postgres[1552]: ::1 2026-10-07 20:39:16.503 UTC [1552] postgres@postgres LOG:  statement: CREATE SCHEMA IF NOT exists extensions;1074vm-test-run-amcheck-upgrade> server # [  129.169968] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1551]: psql:/nix/store/vgajqkksdcv2cbrba1cgngx3rrkdykp1-stat-extension.sql:1: NOTICE:  schema "extensions" already exists, skipping1075vm-test-run-amcheck-upgrade> server # [  129.195853] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1551]: CREATE SCHEMA1076vm-test-run-amcheck-upgrade> server # [  129.198792] postgres[1552]: ::1 2026-10-07 20:39:16.563 UTC [1552] postgres@postgres LOG:  statement: CREATE EXTENSION IF NOT EXISTS pg_stat_statements with schema extensions;1077vm-test-run-amcheck-upgrade> server # [  130.886265] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1551]: CREATE EXTENSION1078vm-test-run-amcheck-upgrade> server # [  130.971299] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/10000000000000_demote-postgres.sql1079vm-test-run-amcheck-upgrade> server # [  131.423733] postgres[1578]: ::1 2026-10-07 20:39:18.760 UTC [1578] supabase_admin@postgres LOG:  statement: GRANT ALL ON DATABASE postgres TO postgres;1080vm-test-run-amcheck-upgrade> server # [  131.424714] postgres[1578]: ::1 2026-10-07 20:39:18.789 UTC [1578] supabase_admin@postgres LOG:  statement: GRANT ALL ON SCHEMA auth TO postgres;1081vm-test-run-amcheck-upgrade> server # [  131.439388] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1577]: GRANT1082vm-test-run-amcheck-upgrade> server # [  131.446212] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1577]: GRANT1083vm-test-run-amcheck-upgrade> server # [  131.451596] postgres[1578]: ::1 2026-10-07 20:39:18.814 UTC [1578] supabase_admin@postgres LOG:  statement: GRANT ALL ON SCHEMA extensions TO postgres;1084vm-test-run-amcheck-upgrade> server # [  131.458203] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1577]: GRANT1085vm-test-run-amcheck-upgrade> server # [  131.463922] postgres[1578]: ::1 2026-10-07 20:39:18.824 UTC [1578] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres;1086vm-test-run-amcheck-upgrade> server # [  131.473218] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1577]: GRANT1087vm-test-run-amcheck-upgrade> server # [  131.478453] postgres[1578]: ::1 2026-10-07 20:39:18.838 UTC [1578] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA extensions TO postgres;1088vm-test-run-amcheck-upgrade> server # [  131.482783] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1577]: GRANT1089vm-test-run-amcheck-upgrade> server # [  131.487064] postgres[1578]: ::1 2026-10-07 20:39:18.851 UTC [1578] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres;1090vm-test-run-amcheck-upgrade> server # [  131.497066] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1577]: GRANT1091vm-test-run-amcheck-upgrade> server # [  131.501471] postgres[1578]: ::1 2026-10-07 20:39:18.865 UTC [1578] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA extensions TO postgres;1092vm-test-run-amcheck-upgrade> server # [  131.503564] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1577]: GRANT1093vm-test-run-amcheck-upgrade> server # [  131.508613] postgres[1578]: ::1 2026-10-07 20:39:18.873 UTC [1578] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres;1094vm-test-run-amcheck-upgrade> server # [  131.525342] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1577]: GRANT1095vm-test-run-amcheck-upgrade> server # [  131.526250] postgres[1578]: ::1 2026-10-07 20:39:18.889 UTC [1578] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA extensions TO postgres;1096vm-test-run-amcheck-upgrade> server # [  131.559371] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1577]: GRANT1097vm-test-run-amcheck-upgrade> server # [  131.585163] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1577]: DO1098vm-test-run-amcheck-upgrade> server # [  131.590301] postgres[1578]: ::1 2026-10-07 20:39:18.953 UTC [1578] supabase_admin@postgres LOG:  statement: ALTER ROLE postgres NOSUPERUSER CREATEDB CREATEROLE LOGIN REPLICATION BYPASSRLS;1099vm-test-run-amcheck-upgrade> server # [  131.598707] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1577]: ALTER ROLE1100vm-test-run-amcheck-upgrade> server # [  131.648359] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211115181400_update-auth-permissions.sql1101vm-test-run-amcheck-upgrade> server # [  131.915874] postgres[1580]: ::1 2026-10-07 20:39:19.272 UTC [1580] supabase_admin@postgres LOG:  statement: GRANT ALL PRIVILEGES ON SCHEMA auth TO supabase_auth_admin;1102vm-test-run-amcheck-upgrade> server # [  131.935800] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: GRANT1103vm-test-run-amcheck-upgrade> server # [  131.942810] postgres[1580]: ::1 2026-10-07 20:39:19.295 UTC [1580] supabase_admin@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL TABLES IN SCHEMA auth TO supabase_auth_admin;1104vm-test-run-amcheck-upgrade> server # [  131.956880] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: GRANT1105vm-test-run-amcheck-upgrade> server # [  131.957913] postgres[1580]: ::1 2026-10-07 20:39:19.321 UTC [1580] supabase_admin@postgres LOG:  statement: GRANT ALL PRIVILEGES ON ALL SEQUENCES IN SCHEMA auth TO supabase_auth_admin;1106vm-test-run-amcheck-upgrade> server # [  131.969707] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: GRANT1107vm-test-run-amcheck-upgrade> server # [  131.973493] postgres[1580]: ::1 2026-10-07 20:39:19.336 UTC [1580] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".users OWNER TO supabase_auth_admin;1108vm-test-run-amcheck-upgrade> server # [  131.986122] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: ALTER TABLE1109vm-test-run-amcheck-upgrade> server # [  131.988524] postgres[1580]: ::1 2026-10-07 20:39:19.353 UTC [1580] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".refresh_tokens OWNER TO supabase_auth_admin;1110vm-test-run-amcheck-upgrade> server # [  131.998732] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: ALTER TABLE1111vm-test-run-amcheck-upgrade> server # [  132.004000] postgres[1580]: ::1 2026-10-07 20:39:19.366 UTC [1580] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".audit_log_entries OWNER TO supabase_auth_admin;1112vm-test-run-amcheck-upgrade> server # [  132.013791] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: ALTER TABLE1113vm-test-run-amcheck-upgrade> server # [  132.022951] postgres[1580]: ::1 2026-10-07 20:39:19.381 UTC [1580] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".instances OWNER TO supabase_auth_admin;1114vm-test-run-amcheck-upgrade> server # [  132.028963] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: ALTER TABLE1115vm-test-run-amcheck-upgrade> server # [  132.034241] postgres[1580]: ::1 2026-10-07 20:39:19.397 UTC [1580] supabase_admin@postgres LOG:  statement: ALTER table IF EXISTS "auth".schema_migrations OWNER TO supabase_auth_admin;1116vm-test-run-amcheck-upgrade> server # [  132.041992] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: ALTER TABLE1117vm-test-run-amcheck-upgrade> server # [  132.043225] postgres[1580]: ::1 2026-10-07 20:39:19.407 UTC [1580] supabase_admin@postgres LOG:  statement: GRANT USAGE ON SCHEMA auth TO postgres;1118vm-test-run-amcheck-upgrade> server # [  132.054002] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: GRANT1119vm-test-run-amcheck-upgrade> server # [  132.054887] postgres[1580]: ::1 2026-10-07 20:39:19.416 UTC [1580] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA auth TO postgres, dashboard_user;1120vm-test-run-amcheck-upgrade> server # [  132.063765] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: GRANT1121vm-test-run-amcheck-upgrade> server # [  132.069634] postgres[1580]: ::1 2026-10-07 20:39:19.432 UTC [1580] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA auth TO postgres, dashboard_user;1122vm-test-run-amcheck-upgrade> server # [  132.075899] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: GRANT1123vm-test-run-amcheck-upgrade> server # [  132.078504] postgres[1580]: ::1 2026-10-07 20:39:19.441 UTC [1580] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA auth TO postgres, dashboard_user;1124vm-test-run-amcheck-upgrade> server # [  132.092915] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: GRANT1125vm-test-run-amcheck-upgrade> server # [  132.094480] postgres[1580]: ::1 2026-10-07 20:39:19.456 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;1126vm-test-run-amcheck-upgrade> server # [  132.107126] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: ALTER DEFAULT PRIVILEGES1127vm-test-run-amcheck-upgrade> server # [  132.109971] postgres[1580]: ::1 2026-10-07 20:39:19.475 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;1128vm-test-run-amcheck-upgrade> server # [  132.120100] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: ALTER DEFAULT PRIVILEGES1129vm-test-run-amcheck-upgrade> server # [  132.122411] postgres[1580]: ::1 2026-10-07 20:39:19.486 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;1130vm-test-run-amcheck-upgrade> server # [  132.135990] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1579]: ALTER DEFAULT PRIVILEGES1131vm-test-run-amcheck-upgrade> server # [  132.212429] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211118015519_create-realtime-schema.sql1132vm-test-run-amcheck-upgrade> server # [  132.523527] postgres[1582]: ::1 2026-10-07 20:39:19.863 UTC [1582] supabase_admin@postgres LOG:  statement: CREATE SCHEMA IF NOT EXISTS realtime;1133vm-test-run-amcheck-upgrade> server # [  132.589939] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1581]: CREATE SCHEMA1134vm-test-run-amcheck-upgrade> server # [  132.601396] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211122051245_update-realtime-permissions.sql1135vm-test-run-amcheck-upgrade> server # [  133.059137] postgres[1593]: ::1 2026-10-07 20:39:20.411 UTC [1593] supabase_admin@postgres LOG:  statement: GRANT USAGE ON SCHEMA realtime TO postgres;1136vm-test-run-amcheck-upgrade> server # [  133.130648] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1587]: GRANT1137vm-test-run-amcheck-upgrade> server # [  133.138501] postgres[1593]: ::1 2026-10-07 20:39:20.455 UTC [1593] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL TABLES IN SCHEMA realtime TO postgres, dashboard_user;1138vm-test-run-amcheck-upgrade> server # [  133.153256] postgres[1593]: ::1 2026-10-07 20:39:20.471 UTC [1593] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL SEQUENCES IN SCHEMA realtime TO postgres, dashboard_user;1139vm-test-run-amcheck-upgrade> server # [  133.154527] postgres[1593]: ::1 2026-10-07 20:39:20.480 UTC [1593] supabase_admin@postgres LOG:  statement: GRANT ALL ON ALL ROUTINES IN SCHEMA realtime TO postgres, dashboard_user;1140vm-test-run-amcheck-upgrade> server # [  133.155595] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1587]: GRANT1141vm-test-run-amcheck-upgrade> server # [  133.165035] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1587]: GRANT1142vm-test-run-amcheck-upgrade> server # [  133.166257] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1587]: GRANT1143vm-test-run-amcheck-upgrade> server # [  133.189403] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211124212715_update-auth-owner.sql1144vm-test-run-amcheck-upgrade> server # [  133.819088] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: DO1145vm-test-run-amcheck-upgrade> server # [  133.828699] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: DO1146vm-test-run-amcheck-upgrade> server # [  133.848772] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1595]: DO1147vm-test-run-amcheck-upgrade> server # [  133.921804] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20211130151719_update-realtime-permissions.sql1148vm-test-run-amcheck-upgrade> server # [  134.372985] postgres[1612]: ::1 2026-10-07 20:39:21.735 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;1149vm-test-run-amcheck-upgrade> server # [  134.404277] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1607]: ALTER DEFAULT PRIVILEGES1150vm-test-run-amcheck-upgrade> server # [  134.406301] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1607]: ALTER DEFAULT PRIVILEGES1151vm-test-run-amcheck-upgrade> server # [  134.407003] postgres[1612]: ::1 2026-10-07 20:39:21.760 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;1152vm-test-run-amcheck-upgrade> server # [  134.409192] postgres[1612]: ::1 2026-10-07 20:39:21.773 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;1153vm-test-run-amcheck-upgrade> server # [  134.424198] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1607]: ALTER DEFAULT PRIVILEGES1154vm-test-run-amcheck-upgrade> server # [  134.457497] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220118070449_enable-safeupdate-postgrest.sql1155vm-test-run-amcheck-upgrade> server # [  134.843612] postgres[1617]: ::1 2026-10-07 20:39:22.201 UTC [1617] supabase_admin@postgres LOG:  statement: ALTER ROLE authenticator SET session_preload_libraries = 'safeupdate';1156vm-test-run-amcheck-upgrade> server # [  134.875464] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1613]: ALTER ROLE1157vm-test-run-amcheck-upgrade> server # [  134.942505] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql1158vm-test-run-amcheck-upgrade> server # [  135.331810] postgres[1620]: ::1 2026-10-07 20:39:22.692 UTC [1620] supabase_admin@postgres LOG:  statement: drop event trigger if exists api_restart;1159vm-test-run-amcheck-upgrade> server # [  135.347146] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:3: NOTICE:  event trigger "api_restart" does not exist, skipping1160vm-test-run-amcheck-upgrade> server # [  135.357369] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: DROP EVENT TRIGGER1161vm-test-run-amcheck-upgrade> server # [  135.358690] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:4: NOTICE:  function extensions.notify_api_restart() does not exist, skipping1162vm-test-run-amcheck-upgrade> server # [  135.363820] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: DROP FUNCTION1163vm-test-run-amcheck-upgrade> server # [  135.370106] postgres[1620]: ::1 2026-10-07 20:39:22.707 UTC [1620] supabase_admin@postgres LOG:  statement: drop function if exists extensions.notify_api_restart();1164vm-test-run-amcheck-upgrade> server # [  135.371403] postgres[1620]: ::1 2026-10-07 20:39:22.717 UTC [1620] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1165vm-test-run-amcheck-upgrade> server # [  135.372582] postgres[1620]: 	DECLARE1166vm-test-run-amcheck-upgrade> server # [  135.375026] postgres[1620]: 	  cmd record;1167vm-test-run-amcheck-upgrade> server # [  135.381526] postgres[1620]: 	BEGIN1168vm-test-run-amcheck-upgrade> server # [  135.382043] postgres[1620]: 	  FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1169vm-test-run-amcheck-upgrade> server # [  135.382931] postgres[1620]: 	  LOOP1170vm-test-run-amcheck-upgrade> server # [  135.383980] postgres[1620]: 	    IF cmd.command_tag IN (1171vm-test-run-amcheck-upgrade> server # [  135.409463] postgres[1620]: 	      'CREATE SCHEMA', 'ALTER SCHEMA'1172vm-test-run-amcheck-upgrade> server # [  135.410545] postgres[1620]: 	    , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1173vm-test-run-amcheck-upgrade> server # [  135.411218] postgres[1620]: 	    , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1174vm-test-run-amcheck-upgrade> server # [  135.412032] postgres[1620]: 	    , 'CREATE VIEW', 'ALTER VIEW'1175vm-test-run-amcheck-upgrade> server # [  135.418222] postgres[1620]: 	    , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1176vm-test-run-amcheck-upgrade> server # [  135.420210] postgres[1620]: 	    , 'CREATE FUNCTION', 'ALTER FUNCTION'1177vm-test-run-amcheck-upgrade> server # [  135.430495] postgres[1620]: 	    , 'CREATE TRIGGER'1178vm-test-run-amcheck-upgrade> server # [  135.431078] postgres[1620]: 	    , 'CREATE TYPE'1179vm-test-run-amcheck-upgrade> server # [  135.432545] postgres[1620]: 	    , 'CREATE RULE'1180vm-test-run-amcheck-upgrade> server # [  135.438086] postgres[1620]: 	    , 'COMMENT'1181vm-test-run-amcheck-upgrade> server # [  135.438791] postgres[1620]: 	    )1182vm-test-run-amcheck-upgrade> server # [  135.439901] postgres[1620]: 	    -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1183vm-test-run-amcheck-upgrade> server # [  135.447732] postgres[1620]: 	    AND cmd.schema_name is distinct from 'pg_temp'1184vm-test-run-amcheck-upgrade> server # [  135.451879] postgres[1620]: 	    THEN1185vm-test-run-amcheck-upgrade> server # [  135.453354] postgres[1620]: 	      NOTIFY pgrst, 'reload schema';1186vm-test-run-amcheck-upgrade> server # [  135.454493] postgres[1620]: 	    END IF;1187vm-test-run-amcheck-upgrade> server # [  135.461774] postgres[1620]: 	  END LOOP;1188vm-test-run-amcheck-upgrade> server # [  135.465357] postgres[1620]: 	END; $$ LANGUAGE plpgsql;1189vm-test-run-amcheck-upgrade> server # [  135.467038] postgres[1620]: ::1 2026-10-07 20:39:22.744 UTC [1620] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1190vm-test-run-amcheck-upgrade> server # [  135.467821] postgres[1620]: 	DECLARE1191vm-test-run-amcheck-upgrade> server # [  135.471801] postgres[1620]: 	  obj record;1192vm-test-run-amcheck-upgrade> server # [  135.473936] postgres[1620]: 	BEGIN1193vm-test-run-amcheck-upgrade> server # [  135.488458] postgres[1620]: 	  FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1194vm-test-run-amcheck-upgrade> server # [  135.502943] postgres[1620]: 	  LOOP1195vm-test-run-amcheck-upgrade> server # [  135.514274] postgres[1620]: 	    IF obj.object_type IN (1196vm-test-run-amcheck-upgrade> server # [  135.515863] postgres[1620]: 	      'schema'1197vm-test-run-amcheck-upgrade> server # [  135.519812] postgres[1620]: 	    , 'table'1198vm-test-run-amcheck-upgrade> server # [  135.526328] postgres[1620]: 	    , 'foreign table'1199vm-test-run-amcheck-upgrade> server # [  135.526935] postgres[1620]: 	    , 'view'1200vm-test-run-amcheck-upgrade> server # [  135.531390] postgres[1620]: 	    , 'materialized view'1201vm-test-run-amcheck-upgrade> server # [  135.539162] postgres[1620]: 	    , 'function'1202vm-test-run-amcheck-upgrade> server # [  135.550331] postgres[1620]: 	    , 'trigger'1203vm-test-run-amcheck-upgrade> server # [  135.551251] postgres[1620]: 	    , 'type'1204vm-test-run-amcheck-upgrade> server # [  135.551635] postgres[1620]: 	    , 'rule'1205vm-test-run-amcheck-upgrade> server # [  135.552308] postgres[1620]: 	    )1206vm-test-run-amcheck-upgrade> server # [  135.552548] postgres[1620]: 	    AND obj.is_temporary IS false -- no pg_temp objects1207vm-test-run-amcheck-upgrade> server # [  135.553051] postgres[1620]: 	    THEN1208vm-test-run-amcheck-upgrade> server # [  135.562013] postgres[1620]: 	      NOTIFY pgrst, 'reload schema';1209vm-test-run-amcheck-upgrade> server # [  135.568053] postgres[1620]: 	    END IF;1210vm-test-run-amcheck-upgrade> server # [  135.573604] postgres[1620]: 	  END LOOP;1211vm-test-run-amcheck-upgrade> server # [  135.574327] postgres[1620]: 	END; $$ LANGUAGE plpgsql;1212vm-test-run-amcheck-upgrade> server # [  135.575518] postgres[1620]: ::1 2026-10-07 20:39:22.767 UTC [1620] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1213vm-test-run-amcheck-upgrade> server # [  135.579536] postgres[1620]: ::1 2026-10-07 20:39:22.787 UTC [1620] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_ddl_watch1214vm-test-run-amcheck-upgrade> server # [  135.591004] postgres[1620]: 	  ON ddl_command_end1215vm-test-run-amcheck-upgrade> server # [  135.595710] postgres[1620]: 	  EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1216vm-test-run-amcheck-upgrade> server # [  135.603629] postgres[1620]: ::1 2026-10-07 20:39:22.804 UTC [1620] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1217vm-test-run-amcheck-upgrade> server # [  135.606936] postgres[1620]: ::1 2026-10-07 20:39:22.832 UTC [1620] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_drop_watch1218vm-test-run-amcheck-upgrade> server # [  135.610671] postgres[1620]: 	  ON sql_drop1219vm-test-run-amcheck-upgrade> server # [  135.611355] postgres[1620]: 	  EXECUTE PROCEDURE extensions.pgrst_drop_watch();1220vm-test-run-amcheck-upgrade> server # [  135.613170] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: CREATE FUNCTION1221vm-test-run-amcheck-upgrade> server # [  135.614203] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: CREATE FUNCTION1222vm-test-run-amcheck-upgrade> server # [  135.614779] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:59: NOTICE:  event trigger "pgrst_ddl_watch" does not exist, skipping1223vm-test-run-amcheck-upgrade> server # [  135.617159] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: DROP EVENT TRIGGER1224vm-test-run-amcheck-upgrade> server # [  135.618424] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: CREATE EVENT TRIGGER1225vm-test-run-amcheck-upgrade> server # [  135.619335] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220126121436_finer-postgrest-triggers.sql:64: NOTICE:  event trigger "pgrst_drop_watch" does not exist, skipping1226vm-test-run-amcheck-upgrade> server # [  135.623291] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: DROP EVENT TRIGGER1227vm-test-run-amcheck-upgrade> server # [  135.627966] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1619]: CREATE EVENT TRIGGER1228vm-test-run-amcheck-upgrade> server # [  135.630218] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220224211803_fix-postgrest-supautils.sql1229vm-test-run-amcheck-upgrade> server # [  136.681380] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1621]: DO1230vm-test-run-amcheck-upgrade> server # [  136.715361] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql1231vm-test-run-amcheck-upgrade> server # [  137.297685] postgres[1639]: ::1 2026-10-07 20:39:24.660 UTC [1639] supabase_admin@postgres LOG:  statement: create schema if not exists graphql_public;1232vm-test-run-amcheck-upgrade> server # [  137.385568] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: CREATE SCHEMA1233vm-test-run-amcheck-upgrade> server # [  137.386917] postgres[1639]: ::1 2026-10-07 20:39:24.729 UTC [1639] supabase_admin@postgres LOG:  statement: drop function if exists graphql_public.graphql(text, text, jsonb);1234vm-test-run-amcheck-upgrade> server # [  137.387526] postgres[1639]: ::1 2026-10-07 20:39:24.747 UTC [1639] supabase_admin@postgres LOG:  statement: create or replace function graphql_public.graphql(1235vm-test-run-amcheck-upgrade> server # [  137.401668] postgres[1639]: 	    "operationName" text default null,1236vm-test-run-amcheck-upgrade> server # [  137.403071] postgres[1639]: 	    query text default null,1237vm-test-run-amcheck-upgrade> server # [  137.416270] postgres[1639]: 	    variables jsonb default null,1238vm-test-run-amcheck-upgrade> server # [  137.433917] postgres[1639]: 	    extensions jsonb default null1239vm-test-run-amcheck-upgrade> server # [  137.449409] postgres[1639]: 	)1240vm-test-run-amcheck-upgrade> server # [  137.451547] postgres[1639]: 	    returns jsonb1241vm-test-run-amcheck-upgrade> server # [  137.452172] postgres[1639]: 	    language plpgsql1242vm-test-run-amcheck-upgrade> server # [  137.467882] postgres[1639]: 	as $$1243vm-test-run-amcheck-upgrade> server # [  137.476021] postgres[1639]: 	    DECLARE1244vm-test-run-amcheck-upgrade> server # [  137.479867] postgres[1639]: 	        server_version float;1245vm-test-run-amcheck-upgrade> server # [  137.487589] postgres[1639]: 	    BEGIN1246vm-test-run-amcheck-upgrade> server # [  137.502046] postgres[1639]: 	        server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1247vm-test-run-amcheck-upgrade> server # [  137.513723] postgres[1639]:1248vm-test-run-amcheck-upgrade> server # [  137.514612] postgres[1639]: 	        IF server_version >= 14 THEN1249vm-test-run-amcheck-upgrade> server # [  137.515056] postgres[1639]: 	            RETURN jsonb_build_object(1250vm-test-run-amcheck-upgrade> server # [  137.523970] postgres[1639]: 	                'data', null::jsonb,1251vm-test-run-amcheck-upgrade> server # [  137.526982] postgres[1639]: 	                'errors', array['pg_graphql extension is not enabled.']1252vm-test-run-amcheck-upgrade> server # [  137.533500] postgres[1639]: 	            );1253vm-test-run-amcheck-upgrade> server # [  137.535033] postgres[1639]: 	        ELSE1254vm-test-run-amcheck-upgrade> server # [  137.535486] postgres[1639]: 	            RETURN jsonb_build_object(1255vm-test-run-amcheck-upgrade> server # [  137.535995] postgres[1639]: 	                'data', null::jsonb,1256vm-test-run-amcheck-upgrade> server # [  137.541509] postgres[1639]: 	                'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1257vm-test-run-amcheck-upgrade> server # [  137.543284] postgres[1639]: 	            );1258vm-test-run-amcheck-upgrade> server # [  137.545401] postgres[1639]: 	        END IF;1259vm-test-run-amcheck-upgrade> server # [  137.546370] postgres[1639]: 	    END;1260vm-test-run-amcheck-upgrade> server # [  137.547954] postgres[1639]: 	$$;1261vm-test-run-amcheck-upgrade> server # [  137.560446] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:5: NOTICE:  function graphql_public.graphql(text,text,jsonb) does not exist, skipping1262vm-test-run-amcheck-upgrade> server # [  137.561702] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: DROP FUNCTION1263vm-test-run-amcheck-upgrade> server # [  137.562831] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: CREATE FUNCTION1264vm-test-run-amcheck-upgrade> server # [  137.563584] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: GRANT1265vm-test-run-amcheck-upgrade> server # [  137.564570] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: ALTER DEFAULT PRIVILEGES1266vm-test-run-amcheck-upgrade> server # [  137.569425] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: ALTER DEFAULT PRIVILEGES1267vm-test-run-amcheck-upgrade> server # [  137.571875] postgres[1639]: ::1 2026-10-07 20:39:24.811 UTC [1639] supabase_admin@postgres LOG:  statement: grant usage on schema graphql_public to postgres, anon, authenticated, service_role;1268vm-test-run-amcheck-upgrade> server # [  137.574460] postgres[1639]: ::1 2026-10-07 20:39:24.875 UTC [1639] supabase_admin@postgres LOG:  statement: alter default privileges in schema graphql_public grant all on tables to postgres, anon, authenticated, service_role;1269vm-test-run-amcheck-upgrade> server # [  137.575396] postgres[1639]: ::1 2026-10-07 20:39:24.899 UTC [1639] supabase_admin@postgres LOG:  statement: alter default privileges in schema graphql_public grant all on functions to postgres, anon, authenticated, service_role;1270vm-test-run-amcheck-upgrade> server # [  137.576170] postgres[1639]: ::1 2026-10-07 20:39:24.925 UTC [1639] supabase_admin@postgres LOG:  statement: alter default privileges in schema graphql_public grant all on sequences to postgres, anon, authenticated, service_role;1271vm-test-run-amcheck-upgrade> server # [  137.583102] postgres[1639]: ::1 2026-10-07 20:39:24.942 UTC [1639] supabase_admin@postgres LOG:  statement: alter default privileges for user supabase_admin in schema graphql_public grant all1272vm-test-run-amcheck-upgrade> server # [  137.585203] postgres[1639]: 	    on sequences to postgres, anon, authenticated, service_role;1273vm-test-run-amcheck-upgrade> server # [  137.587778] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: ALTER DEFAULT PRIVILEGES1274vm-test-run-amcheck-upgrade> server # [  137.595883] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: ALTER DEFAULT PRIVILEGES1275vm-test-run-amcheck-upgrade> server # [  137.598610] postgres[1639]: ::1 2026-10-07 20:39:24.959 UTC [1639] supabase_admin@postgres LOG:  statement: alter default privileges for user supabase_admin in schema graphql_public grant all1276vm-test-run-amcheck-upgrade> server # [  137.600057] postgres[1639]: 	    on tables to postgres, anon, authenticated, service_role;1277vm-test-run-amcheck-upgrade> server # [  137.609934] postgres[1639]: ::1 2026-10-07 20:39:24.972 UTC [1639] supabase_admin@postgres LOG:  statement: alter default privileges for user supabase_admin in schema graphql_public grant all1278vm-test-run-amcheck-upgrade> server # [  137.611291] postgres[1639]: 	    on functions to postgres, anon, authenticated, service_role;1279vm-test-run-amcheck-upgrade> server # [  137.611931] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: ALTER DEFAULT PRIVILEGES1280vm-test-run-amcheck-upgrade> server # [  137.618146] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: ALTER DEFAULT PRIVILEGES1281vm-test-run-amcheck-upgrade> server # [  137.629087] postgres[1639]: ::1 2026-10-07 20:39:24.992 UTC [1639] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_graphql_access()1282vm-test-run-amcheck-upgrade> server # [  137.630073] postgres[1639]: 	RETURNS event_trigger1283vm-test-run-amcheck-upgrade> server # [  137.630456] postgres[1639]: 	LANGUAGE plpgsql1284vm-test-run-amcheck-upgrade> server # [  137.630719] postgres[1639]: 	AS $func$1285vm-test-run-amcheck-upgrade> server # [  137.631159] postgres[1639]: 	    DECLARE1286vm-test-run-amcheck-upgrade> server # [  137.631442] postgres[1639]: 	    func_is_graphql_resolve bool;1287vm-test-run-amcheck-upgrade> server # [  137.636853] postgres[1639]: 	    BEGIN1288vm-test-run-amcheck-upgrade> server # [  137.637582] postgres[1639]: 	    func_is_graphql_resolve = (1289vm-test-run-amcheck-upgrade> server # [  137.638794] postgres[1639]: 	        SELECT n.proname = 'resolve'1290vm-test-run-amcheck-upgrade> server # [  137.639325] postgres[1639]: 	        FROM pg_event_trigger_ddl_commands() AS ev1291vm-test-run-amcheck-upgrade> server # [  137.639970] postgres[1639]: 	        LEFT JOIN pg_catalog.pg_proc AS n1292vm-test-run-amcheck-upgrade> server # [  137.645596] postgres[1639]: 	        ON ev.objid = n.oid1293vm-test-run-amcheck-upgrade> server # [  137.646181] postgres[1639]: 	    );1294vm-test-run-amcheck-upgrade> server # [  137.646584] postgres[1639]:1295vm-test-run-amcheck-upgrade> server # [  137.646893] postgres[1639]: 	    IF func_is_graphql_resolve1296vm-test-run-amcheck-upgrade> server # [  137.647183] postgres[1639]: 	    THEN1297vm-test-run-amcheck-upgrade> server # [  137.647637] postgres[1639]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;1298vm-test-run-amcheck-upgrade> server # [  137.655128] postgres[1639]: 	        grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1299vm-test-run-amcheck-upgrade> server # [  137.658126] postgres[1639]:1300vm-test-run-amcheck-upgrade> server # [  137.659130] postgres[1639]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1301vm-test-run-amcheck-upgrade> server # [  137.659948] postgres[1639]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1302vm-test-run-amcheck-upgrade> server # [  137.666299] postgres[1639]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1303vm-test-run-amcheck-upgrade> server # [  137.668083] postgres[1639]:1304vm-test-run-amcheck-upgrade> server # [  137.672916] postgres[1639]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;1305vm-test-run-amcheck-upgrade> server # [  137.673764] postgres[1639]: 	        create or replace function graphql_public.graphql(1306vm-test-run-amcheck-upgrade> server # [  137.674370] postgres[1639]: 	            "operationName" text default null,1307vm-test-run-amcheck-upgrade> server # [  137.674686] postgres[1639]: 	            query text default null,1308vm-test-run-amcheck-upgrade> server # [  137.675178] postgres[1639]: 	            variables jsonb default null,1309vm-test-run-amcheck-upgrade> server # [  137.675438] postgres[1639]: 	            extensions jsonb default null1310vm-test-run-amcheck-upgrade> server # [  137.682227] postgres[1639]: 	        )1311vm-test-run-amcheck-upgrade> server # [  137.683041] postgres[1639]: 	            returns jsonb1312vm-test-run-amcheck-upgrade> server # [  137.683391] postgres[1639]: 	            language sql1313vm-test-run-amcheck-upgrade> server # [  137.684071] postgres[1639]: 	        as $$1314vm-test-run-amcheck-upgrade> server # [  137.684368] postgres[1639]: 	            SELECT graphql.resolve(query, coalesce(variables, '{}'));1315vm-test-run-amcheck-upgrade> server # [  137.685980] postgres[1639]: 	        $$;1316vm-test-run-amcheck-upgrade> server # [  137.686979] postgres[1639]:1317vm-test-run-amcheck-upgrade> server # [  137.687303] postgres[1639]: 	        grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1318vm-test-run-amcheck-upgrade> server # [  137.690889] postgres[1639]: 	    END IF;1319vm-test-run-amcheck-upgrade> server # [  137.692379] postgres[1639]:1320vm-test-run-amcheck-upgrade> server # [  137.699173] postgres[1639]: 	    END;1321vm-test-run-amcheck-upgrade> server # [  137.699988] postgres[1639]: 	$func$;1322vm-test-run-amcheck-upgrade> server # [  137.705841] postgres[1639]: ::1 2026-10-07 20:39:25.004 UTC [1639] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS issue_pg_graphql_access;1323vm-test-run-amcheck-upgrade> server # [  137.706746] postgres[1639]: ::1 2026-10-07 20:39:25.011 UTC [1639] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER issue_pg_graphql_access ON ddl_command_end WHEN TAG in ('CREATE FUNCTION')1324vm-test-run-amcheck-upgrade> server # [  137.713965] postgres[1639]: 	EXECUTE PROCEDURE extensions.grant_pg_graphql_access();1325vm-test-run-amcheck-upgrade> server # [  137.714686] postgres[1639]: ::1 2026-10-07 20:39:25.024 UTC [1639] supabase_admin@postgres LOG:  statement: COMMENT ON FUNCTION extensions.grant_pg_graphql_access IS 'Grants access to pg_graphql';1326vm-test-run-amcheck-upgrade> server # [  137.715113] postgres[1639]: ::1 2026-10-07 20:39:25.039 UTC [1639] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1327vm-test-run-amcheck-upgrade> server # [  137.715471] postgres[1639]: 	RETURNS event_trigger1328vm-test-run-amcheck-upgrade> server # [  137.721503] postgres[1639]: 	LANGUAGE plpgsql1329vm-test-run-amcheck-upgrade> server # [  137.722748] postgres[1639]: 	AS $func$1330vm-test-run-amcheck-upgrade> server # [  137.723333] postgres[1639]: 	    DECLARE1331vm-test-run-amcheck-upgrade> server # [  137.723792] postgres[1639]: 	    graphql_is_dropped bool;1332vm-test-run-amcheck-upgrade> server # [  137.729965] postgres[1639]: 	    BEGIN1333vm-test-run-amcheck-upgrade> server # [  137.730737] postgres[1639]: 	    graphql_is_dropped = (1334vm-test-run-amcheck-upgrade> server # [  137.732124] postgres[1639]: 	        SELECT ev.schema_name = 'graphql_public'1335vm-test-run-amcheck-upgrade> server # [  137.742415] postgres[1639]: 	        FROM pg_event_trigger_dropped_objects() AS ev1336vm-test-run-amcheck-upgrade> server # [  137.745525] postgres[1639]: 	        WHERE ev.schema_name = 'graphql_public'1337vm-test-run-amcheck-upgrade> server # [  137.746469] postgres[1639]: 	    );1338vm-test-run-amcheck-upgrade> server # [  137.746824] postgres[1639]:1339vm-test-run-amcheck-upgrade> server # [  137.747509] postgres[1639]: 	    IF graphql_is_dropped1340vm-test-run-amcheck-upgrade> server # [  137.753300] postgres[1639]: 	    THEN1341vm-test-run-amcheck-upgrade> server # [  137.755302] postgres[1639]: 	        create or replace function graphql_public.graphql(1342vm-test-run-amcheck-upgrade> server # [  137.755813] postgres[1639]: 	            "operationName" text default null,1343vm-test-run-amcheck-upgrade> server # [  137.758798] postgres[1639]: 	            query text default null,1344vm-test-run-amcheck-upgrade> server # [  137.765927] postgres[1639]: 	            variables jsonb default null,1345vm-test-run-amcheck-upgrade> server # [  137.766863] postgres[1639]: 	            extensions jsonb default null1346vm-test-run-amcheck-upgrade> server # [  137.767765] postgres[1639]: 	        )1347vm-test-run-amcheck-upgrade> server # [  137.768072] postgres[1639]: 	            returns jsonb1348vm-test-run-amcheck-upgrade> server # [  137.772757] postgres[1639]: 	            language plpgsql1349vm-test-run-amcheck-upgrade> server # [  137.773530] postgres[1639]: 	        as $$1350vm-test-run-amcheck-upgrade> server # [  137.773978] postgres[1639]: 	            DECLARE1351vm-test-run-amcheck-upgrade> server # [  137.774443] postgres[1639]: 	                server_version float;1352vm-test-run-amcheck-upgrade> server # [  137.776529] postgres[1639]: 	            BEGIN1353vm-test-run-amcheck-upgrade> server # [  137.778317] postgres[1639]: 	                server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1354vm-test-run-amcheck-upgrade> server # [  137.779220] postgres[1639]:1355vm-test-run-amcheck-upgrade> server # [  137.780374] postgres[1639]: 	                IF server_version >= 14 THEN1356vm-test-run-amcheck-upgrade> server # [  137.790245] postgres[1639]: 	                    RETURN jsonb_build_object(1357vm-test-run-amcheck-upgrade> server # [  137.790972] postgres[1639]: 	                        'data', null::jsonb,1358vm-test-run-amcheck-upgrade> server # [  137.792581] postgres[1639]: 	                        'errors', array['pg_graphql extension is not enabled.']1359vm-test-run-amcheck-upgrade> server # [  137.802662] postgres[1639]: 	                    );1360vm-test-run-amcheck-upgrade> server # [  137.804870] postgres[1639]: 	                ELSE1361vm-test-run-amcheck-upgrade> server # [  137.808145] postgres[1639]: 	                    RETURN jsonb_build_object(1362vm-test-run-amcheck-upgrade> server # [  137.816237] postgres[1639]: 	                        'data', null::jsonb,1363vm-test-run-amcheck-upgrade> server # [  137.818828] postgres[1639]: 	                        'errors', array['pg_graphql is only available on projects running Postgres 14 onwards.']1364vm-test-run-amcheck-upgrade> server # [  137.827810] postgres[1639]: 	                    );1365vm-test-run-amcheck-upgrade> server # [  137.839235] postgres[1639]: 	                END IF;1366vm-test-run-amcheck-upgrade> server # [  137.846213] postgres[1639]: 	            END;1367vm-test-run-amcheck-upgrade> server # [  137.847297] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: CREATE FUNCTION1368vm-test-run-amcheck-upgrade> server # [  137.852650] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:90: NOTICE:  event trigger "issue_pg_graphql_access" does not exist, skipping1369vm-test-run-amcheck-upgrade> server # [  137.854350] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: DROP EVENT TRIGGER1370vm-test-run-amcheck-upgrade> server # [  137.855416] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: CREATE EVENT TRIGGER1371vm-test-run-amcheck-upgrade> server # [  137.856372] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: COMMENT1372vm-test-run-amcheck-upgrade> server # [  137.865370] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: CREATE FUNCTION1373vm-test-run-amcheck-upgrade> server # [  137.867205] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220317095840_pg_graphql.sql:143: NOTICE:  event trigger "issue_graphql_placeholder" does not exist, skipping1374vm-test-run-amcheck-upgrade> server # [  137.873295] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: DROP EVENT TRIGGER1375vm-test-run-amcheck-upgrade> server # [  137.875836] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: CREATE EVENT TRIGGER1376vm-test-run-amcheck-upgrade> server # [  137.884833] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1635]: COMMENT1377vm-test-run-amcheck-upgrade> server # [  137.886707] postgres[1639]: 	        $$;1378vm-test-run-amcheck-upgrade> server # [  137.887828] postgres[1639]: 	    END IF;1379vm-test-run-amcheck-upgrade> server # [  137.893327] postgres[1639]:1380vm-test-run-amcheck-upgrade> server # [  137.897693] postgres[1639]: 	    END;1381vm-test-run-amcheck-upgrade> server # [  137.898379] postgres[1639]: 	$func$;1382vm-test-run-amcheck-upgrade> server # [  137.899232] postgres[1639]: ::1 2026-10-07 20:39:25.110 UTC [1639] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS issue_graphql_placeholder;1383vm-test-run-amcheck-upgrade> server # [  137.905864] postgres[1639]: ::1 2026-10-07 20:39:25.120 UTC [1639] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER issue_graphql_placeholder ON sql_drop WHEN TAG in ('DROP EXTENSION')1384vm-test-run-amcheck-upgrade> server # [  137.908533] postgres[1639]: 	EXECUTE PROCEDURE extensions.set_graphql_placeholder();1385vm-test-run-amcheck-upgrade> server # [  137.909087] postgres[1639]: ::1 2026-10-07 20:39:25.136 UTC [1639] supabase_admin@postgres LOG:  statement: COMMENT ON FUNCTION extensions.set_graphql_placeholder IS 'Reintroduces placeholder function for graphql_public.graphql';1386vm-test-run-amcheck-upgrade> server # [  137.927000] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql1387vm-test-run-amcheck-upgrade> server # [  138.164340] postgres[1650]: ::1 2026-10-07 20:39:25.520 UTC [1650] supabase_admin@postgres LOG:  statement: drop event trigger if exists api_restart;1388vm-test-run-amcheck-upgrade> server # [  138.166954] postgres[1650]: ::1 2026-10-07 20:39:25.525 UTC [1650] supabase_admin@postgres LOG:  statement: drop function if exists extensions.notify_api_restart();1389vm-test-run-amcheck-upgrade> server # [  138.171390] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1649]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:3: NOTICE:  event trigger "api_restart" does not exist, skipping1390vm-test-run-amcheck-upgrade> server # [  138.175157] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1649]: DROP EVENT TRIGGER1391vm-test-run-amcheck-upgrade> server # [  138.176868] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1649]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220321174452_fix-postgrest-alter-type-event-trigger.sql:4: NOTICE:  function extensions.notify_api_restart() does not exist, skipping1392vm-test-run-amcheck-upgrade> server # [  138.184592] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1649]: DROP FUNCTION1393vm-test-run-amcheck-upgrade> server # [  138.189687] postgres[1650]: ::1 2026-10-07 20:39:25.551 UTC [1650] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_ddl_watch() RETURNS event_trigger AS $$1394vm-test-run-amcheck-upgrade> server # [  138.191217] postgres[1650]: 	DECLARE1395vm-test-run-amcheck-upgrade> server # [  138.192049] postgres[1650]: 	  cmd record;1396vm-test-run-amcheck-upgrade> server # [  138.203196] postgres[1650]: 	BEGIN1397vm-test-run-amcheck-upgrade> server # [  138.212802] postgres[1650]: 	  FOR cmd IN SELECT * FROM pg_event_trigger_ddl_commands()1398vm-test-run-amcheck-upgrade> server # [  138.213400] postgres[1650]: 	  LOOP1399vm-test-run-amcheck-upgrade> server # [  138.213650] postgres[1650]: 	    IF cmd.command_tag IN (1400vm-test-run-amcheck-upgrade> server # [  138.213877] postgres[1650]: 	      'CREATE SCHEMA', 'ALTER SCHEMA'1401vm-test-run-amcheck-upgrade> server # [  138.217428] postgres[1650]: 	    , 'CREATE TABLE', 'CREATE TABLE AS', 'SELECT INTO', 'ALTER TABLE'1402vm-test-run-amcheck-upgrade> server # [  138.218060] postgres[1650]: 	    , 'CREATE FOREIGN TABLE', 'ALTER FOREIGN TABLE'1403vm-test-run-amcheck-upgrade> server # [  138.219055] postgres[1650]: 	    , 'CREATE VIEW', 'ALTER VIEW'1404vm-test-run-amcheck-upgrade> server # [  138.219401] postgres[1650]: 	    , 'CREATE MATERIALIZED VIEW', 'ALTER MATERIALIZED VIEW'1405vm-test-run-amcheck-upgrade> server # [  138.233447] postgres[1650]: 	    , 'CREATE FUNCTION', 'ALTER FUNCTION'1406vm-test-run-amcheck-upgrade> server # [  138.236031] postgres[1650]: 	    , 'CREATE TRIGGER'1407vm-test-run-amcheck-upgrade> server # [  138.236661] postgres[1650]: 	    , 'CREATE TYPE', 'ALTER TYPE'1408vm-test-run-amcheck-upgrade> server # [  138.245890] postgres[1650]: 	    , 'CREATE RULE'1409vm-test-run-amcheck-upgrade> server # [  138.246756] postgres[1650]: 	    , 'COMMENT'1410vm-test-run-amcheck-upgrade> server # [  138.247905] postgres[1650]: 	    )1411vm-test-run-amcheck-upgrade> server # [  138.257122] postgres[1650]: 	    -- don't notify in case of CREATE TEMP table or other objects created on pg_temp1412vm-test-run-amcheck-upgrade> server # [  138.258009] postgres[1650]: 	    AND cmd.schema_name is distinct from 'pg_temp'1413vm-test-run-amcheck-upgrade> server # [  138.258413] postgres[1650]: 	    THEN1414vm-test-run-amcheck-upgrade> server # [  138.258689] postgres[1650]: 	      NOTIFY pgrst, 'reload schema';1415vm-test-run-amcheck-upgrade> server # [  138.258964] postgres[1650]: 	    END IF;1416vm-test-run-amcheck-upgrade> server # [  138.259191] postgres[1650]: 	  END LOOP;1417vm-test-run-amcheck-upgrade> server # [  138.259408] postgres[1650]: 	END; $$ LANGUAGE plpgsql;1418vm-test-run-amcheck-upgrade> server # [  138.294141] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1649]: CREATE FUNCTION1419vm-test-run-amcheck-upgrade> server # [  138.305074] postgres[1650]: ::1 2026-10-07 20:39:25.663 UTC [1650] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.pgrst_drop_watch() RETURNS event_trigger AS $$1420vm-test-run-amcheck-upgrade> server # [  138.305915] postgres[1650]: 	DECLARE1421vm-test-run-amcheck-upgrade> server # [  138.306203] postgres[1650]: 	  obj record;1422vm-test-run-amcheck-upgrade> server # [  138.306437] postgres[1650]: 	BEGIN1423vm-test-run-amcheck-upgrade> server # [  138.306665] postgres[1650]: 	  FOR obj IN SELECT * FROM pg_event_trigger_dropped_objects()1424vm-test-run-amcheck-upgrade> server # [  138.306935] postgres[1650]: 	  LOOP1425vm-test-run-amcheck-upgrade> server # [  138.309479] postgres[1650]: 	    IF obj.object_type IN (1426vm-test-run-amcheck-upgrade> server # [  138.310531] postgres[1650]: 	      'schema'1427vm-test-run-amcheck-upgrade> server # [  138.311239] postgres[1650]: 	    , 'table'1428vm-test-run-amcheck-upgrade> server # [  138.312078] postgres[1650]: 	    , 'foreign table'1429vm-test-run-amcheck-upgrade> server # [  138.318783] postgres[1650]: 	    , 'view'1430vm-test-run-amcheck-upgrade> server # [  138.321325] postgres[1650]: 	    , 'materialized view'1431vm-test-run-amcheck-upgrade> server # [  138.322171] postgres[1650]: 	    , 'function'1432vm-test-run-amcheck-upgrade> server # [  138.323300] postgres[1650]: 	    , 'trigger'1433vm-test-run-amcheck-upgrade> server # [  138.323797] postgres[1650]: 	    , 'type'1434vm-test-run-amcheck-upgrade> server # [  138.324143] postgres[1650]: 	    , 'rule'1435vm-test-run-amcheck-upgrade> server # [  138.324723] postgres[1650]: 	    )1436vm-test-run-amcheck-upgrade> server # [  138.325905] postgres[1650]: 	    AND obj.is_temporary IS false -- no pg_temp objects1437vm-test-run-amcheck-upgrade> server # [  138.326754] postgres[1650]: 	    THEN1438vm-test-run-amcheck-upgrade> server # [  138.327073] postgres[1650]: 	      NOTIFY pgrst, 'reload schema';1439vm-test-run-amcheck-upgrade> server # [  138.328949] postgres[1650]: 	    END IF;1440vm-test-run-amcheck-upgrade> server # [  138.329394] postgres[1650]: 	  END LOOP;1441vm-test-run-amcheck-upgrade> server # [  138.329678] postgres[1650]: 	END; $$ LANGUAGE plpgsql;1442vm-test-run-amcheck-upgrade> server # [  138.345038] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1649]: CREATE FUNCTION1443vm-test-run-amcheck-upgrade> server # [  138.345949] postgres[1650]: ::1 2026-10-07 20:39:25.707 UTC [1650] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_ddl_watch;1444vm-test-run-amcheck-upgrade> server # [  138.353407] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1649]: DROP EVENT TRIGGER1445vm-test-run-amcheck-upgrade> server # [  138.356741] postgres[1650]: ::1 2026-10-07 20:39:25.719 UTC [1650] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_ddl_watch1446vm-test-run-amcheck-upgrade> server # [  138.357639] postgres[1650]: 	  ON ddl_command_end1447vm-test-run-amcheck-upgrade> server # [  138.358664] postgres[1650]: 	  EXECUTE PROCEDURE extensions.pgrst_ddl_watch();1448vm-test-run-amcheck-upgrade> server # [  138.364288] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1649]: CREATE EVENT TRIGGER1449vm-test-run-amcheck-upgrade> server # [  138.366829] postgres[1650]: ::1 2026-10-07 20:39:25.730 UTC [1650] supabase_admin@postgres LOG:  statement: DROP EVENT TRIGGER IF EXISTS pgrst_drop_watch;1450vm-test-run-amcheck-upgrade> server # [  138.378368] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1649]: DROP EVENT TRIGGER1451vm-test-run-amcheck-upgrade> server # [  138.381343] postgres[1650]: ::1 2026-10-07 20:39:25.741 UTC [1650] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER pgrst_drop_watch1452vm-test-run-amcheck-upgrade> server # [  138.382039] postgres[1650]: 	  ON sql_drop1453vm-test-run-amcheck-upgrade> server # [  138.383228] postgres[1650]: 	  EXECUTE PROCEDURE extensions.pgrst_drop_watch();1454vm-test-run-amcheck-upgrade> server # [  138.391152] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1649]: CREATE EVENT TRIGGER1455vm-test-run-amcheck-upgrade> server # [  138.445921] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220322085208_gotrue-session-limit.sql1456vm-test-run-amcheck-upgrade> server # [  138.831878] postgres[1655]: ::1 2026-10-07 20:39:26.173 UTC [1655] supabase_admin@postgres LOG:  statement: ALTER ROLE supabase_auth_admin SET idle_in_transaction_session_timeout TO 60000;1457vm-test-run-amcheck-upgrade> server # [  138.851163] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1651]: ALTER ROLE1458vm-test-run-amcheck-upgrade> server # [  138.869111] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql1459vm-test-run-amcheck-upgrade> server # [  139.240375] postgres[1658]: ::1 2026-10-07 20:39:26.596 UTC [1658] supabase_admin@postgres LOG:  statement: create or replace function extensions.grant_pg_graphql_access()1460vm-test-run-amcheck-upgrade> server # [  139.242610] postgres[1658]: 	    returns event_trigger1461vm-test-run-amcheck-upgrade> server # [  139.244007] postgres[1658]: 	    language plpgsql1462vm-test-run-amcheck-upgrade> server # [  139.246904] postgres[1658]: 	AS $func$1463vm-test-run-amcheck-upgrade> server # [  139.247583] postgres[1658]: 	DECLARE1464vm-test-run-amcheck-upgrade> server # [  139.249311] postgres[1658]: 	    func_is_graphql_resolve bool;1465vm-test-run-amcheck-upgrade> server # [  139.249834] postgres[1658]: 	BEGIN1466vm-test-run-amcheck-upgrade> server # [  139.250105] postgres[1658]: 	    func_is_graphql_resolve = (1467vm-test-run-amcheck-upgrade> server # [  139.250728] postgres[1658]: 	        SELECT n.proname = 'resolve'1468vm-test-run-amcheck-upgrade> server # [  139.252249] postgres[1658]: 	        FROM pg_event_trigger_ddl_commands() AS ev1469vm-test-run-amcheck-upgrade> server # [  139.252584] postgres[1658]: 	        LEFT JOIN pg_catalog.pg_proc AS n1470vm-test-run-amcheck-upgrade> server # [  139.254171] postgres[1658]: 	        ON ev.objid = n.oid1471vm-test-run-amcheck-upgrade> server # [  139.255445] postgres[1658]: 	    );1472vm-test-run-amcheck-upgrade> server # [  139.255888] postgres[1658]:1473vm-test-run-amcheck-upgrade> server # [  139.256122] postgres[1658]: 	    IF func_is_graphql_resolve1474vm-test-run-amcheck-upgrade> server # [  139.257861] postgres[1658]: 	    THEN1475vm-test-run-amcheck-upgrade> server # [  139.258191] postgres[1658]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;1476vm-test-run-amcheck-upgrade> server # [  139.258759] postgres[1658]: 	        grant all on function graphql.resolve to postgres, anon, authenticated, service_role;1477vm-test-run-amcheck-upgrade> server # [  139.259466] postgres[1658]:1478vm-test-run-amcheck-upgrade> server # [  139.260653] postgres[1658]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1479vm-test-run-amcheck-upgrade> server # [  139.262041] postgres[1658]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1480vm-test-run-amcheck-upgrade> server # [  139.262954] postgres[1658]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1481vm-test-run-amcheck-upgrade> server # [  139.268064] postgres[1658]:1482vm-test-run-amcheck-upgrade> server # [  139.268820] postgres[1658]: 	        -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1483vm-test-run-amcheck-upgrade> server # [  139.269669] postgres[1658]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;1484vm-test-run-amcheck-upgrade> server # [  139.271346] postgres[1658]: 	        create or replace function graphql_public.graphql(1485vm-test-run-amcheck-upgrade> server # [  139.273891] postgres[1658]: 	            "operationName" text default null,1486vm-test-run-amcheck-upgrade> server # [  139.274612] postgres[1658]: 	            query text default null,1487vm-test-run-amcheck-upgrade> server # [  139.274963] postgres[1658]: 	            variables jsonb default null,1488vm-test-run-amcheck-upgrade> server # [  139.276081] postgres[1658]: 	            extensions jsonb default null1489vm-test-run-amcheck-upgrade> server # [  139.278360] postgres[1658]: 	        )1490vm-test-run-amcheck-upgrade> server # [  139.278644] postgres[1658]: 	            returns jsonb1491vm-test-run-amcheck-upgrade> server # [  139.279381] postgres[1658]: 	            language sql1492vm-test-run-amcheck-upgrade> server # [  139.280918] postgres[1658]: 	        as $$1493vm-test-run-amcheck-upgrade> server # [  139.281228] postgres[1658]: 	            -- This changed1494vm-test-run-amcheck-upgrade> server # [  139.281729] postgres[1658]: 	            select graphql.resolve(1495vm-test-run-amcheck-upgrade> server # [  139.282052] postgres[1658]: 	                query := query,1496vm-test-run-amcheck-upgrade> server # [  139.282938] postgres[1658]: 	                variables := coalesce(variables, '{}'),1497vm-test-run-amcheck-upgrade> server # [  139.283815] postgres[1658]: 	                "operationName" := "operationName",1498vm-test-run-amcheck-upgrade> server # [  139.284732] postgres[1658]: 	                extensions := extensions1499vm-test-run-amcheck-upgrade> server # [  139.286614] postgres[1658]: 	            );1500vm-test-run-amcheck-upgrade> server # [  139.287882] postgres[1658]: 	        $$;1501vm-test-run-amcheck-upgrade> server # [  139.289265] postgres[1658]:1502vm-test-run-amcheck-upgrade> server # [  139.289588] postgres[1658]: 	        grant execute on function graphql.resolve to postgres, anon, authenticated, service_role;1503vm-test-run-amcheck-upgrade> server # [  139.290012] postgres[1658]: 	    END IF;1504vm-test-run-amcheck-upgrade> server # [  139.290254] postgres[1658]:1505vm-test-run-amcheck-upgrade> server # [  139.290693] postgres[1658]: 	END;1506vm-test-run-amcheck-upgrade> server # [  139.290983] postgres[1658]: 	$func$;1507vm-test-run-amcheck-upgrade> server # [  139.350296] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1657]: CREATE FUNCTION1508vm-test-run-amcheck-upgrade> server # [  139.356787] postgres[1658]: ::1 2026-10-07 20:39:26.713 UTC [1658] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.set_graphql_placeholder()1509vm-test-run-amcheck-upgrade> server # [  139.360048] postgres[1658]: 	RETURNS event_trigger1510vm-test-run-amcheck-upgrade> server # [  139.367213] postgres[1658]: 	LANGUAGE plpgsql1511vm-test-run-amcheck-upgrade> server # [  139.377657] postgres[1658]: 	AS $func$1512vm-test-run-amcheck-upgrade> server # [  139.378478] postgres[1658]: 	    DECLARE1513vm-test-run-amcheck-upgrade> server # [  139.378799] postgres[1658]: 	    graphql_is_dropped bool;1514vm-test-run-amcheck-upgrade> server # [  139.379042] postgres[1658]: 	    BEGIN1515vm-test-run-amcheck-upgrade> server # [  139.380117] postgres[1658]: 	    graphql_is_dropped = (1516vm-test-run-amcheck-upgrade> server # [  139.380422] postgres[1658]: 	        SELECT ev.schema_name = 'graphql_public'1517vm-test-run-amcheck-upgrade> server # [  139.380713] postgres[1658]: 	        FROM pg_event_trigger_dropped_objects() AS ev1518vm-test-run-amcheck-upgrade> server # [  139.393880] postgres[1658]: 	        WHERE ev.schema_name = 'graphql_public'1519vm-test-run-amcheck-upgrade> server # [  139.394457] postgres[1658]: 	    );1520vm-test-run-amcheck-upgrade> server # [  139.395148] postgres[1658]:1521vm-test-run-amcheck-upgrade> server # [  139.395423] postgres[1658]: 	    IF graphql_is_dropped1522vm-test-run-amcheck-upgrade> server # [  139.396259] postgres[1658]: 	    THEN1523vm-test-run-amcheck-upgrade> server # [  139.401899] postgres[1658]: 	        create or replace function graphql_public.graphql(1524vm-test-run-amcheck-upgrade> server # [  139.402802] postgres[1658]: 	            "operationName" text default null,1525vm-test-run-amcheck-upgrade> server # [  139.403569] postgres[1658]: 	            query text default null,1526vm-test-run-amcheck-upgrade> server # [  139.413729] postgres[1658]: 	            variables jsonb default null,1527vm-test-run-amcheck-upgrade> server # [  139.421947] postgres[1658]: 	            extensions jsonb default null1528vm-test-run-amcheck-upgrade> server # [  139.423130] postgres[1658]: 	        )1529vm-test-run-amcheck-upgrade> server # [  139.423468] postgres[1658]: 	            returns jsonb1530vm-test-run-amcheck-upgrade> server # [  139.426171] postgres[1658]: 	            language plpgsql1531vm-test-run-amcheck-upgrade> server # [  139.426791] postgres[1658]: 	        as $$1532vm-test-run-amcheck-upgrade> server # [  139.427845] postgres[1658]: 	            DECLARE1533vm-test-run-amcheck-upgrade> server # [  139.428215] postgres[1658]: 	                server_version float;1534vm-test-run-amcheck-upgrade> server # [  139.429455] postgres[1658]: 	            BEGIN1535vm-test-run-amcheck-upgrade> server # [  139.431586] postgres[1658]: 	                server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1536vm-test-run-amcheck-upgrade> server # [  139.437028] postgres[1658]:1537vm-test-run-amcheck-upgrade> server # [  139.437584] postgres[1658]: 	                IF server_version >= 14 THEN1538vm-test-run-amcheck-upgrade> server # [  139.437922] postgres[1658]: 	                    RETURN jsonb_build_object(1539vm-test-run-amcheck-upgrade> server # [  139.438491] postgres[1658]: 	                        'errors', jsonb_build_array(1540vm-test-run-amcheck-upgrade> server # [  139.439135] postgres[1658]: 	                            jsonb_build_object(1541vm-test-run-amcheck-upgrade> server # [  139.439605] postgres[1658]: 	                                'message', 'pg_graphql extension is not enabled.'1542vm-test-run-amcheck-upgrade> server # [  139.440303] postgres[1658]: 	                            )1543vm-test-run-amcheck-upgrade> server # [  139.441761] postgres[1658]: 	                        )1544vm-test-run-amcheck-upgrade> server # [  139.442830] postgres[1658]: 	                    );1545vm-test-run-amcheck-upgrade> server # [  139.443129] postgres[1658]: 	                ELSE1546vm-test-run-amcheck-upgrade> server # [  139.443358] postgres[1658]: 	                    RETURN jsonb_build_object(1547vm-test-run-amcheck-upgrade> server # [  139.443610] postgres[1658]: 	                        'errors', jsonb_build_array(1548vm-test-run-amcheck-upgrade> server # [  139.444005] postgres[1658]: 	                            jsonb_build_object(1549vm-test-run-amcheck-upgrade> server # [  139.445454] postgres[1658]: 	                                'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1550vm-test-run-amcheck-upgrade> server # [  139.446531] postgres[1658]: 	                            )1551vm-test-run-amcheck-upgrade> server # [  139.447334] postgres[1658]: 	                        )1552vm-test-run-amcheck-upgrade> server # [  139.448143] postgres[1658]: 	                    );1553vm-test-run-amcheck-upgrade> server # [  139.449203] postgres[1658]: 	                END IF;1554vm-test-run-amcheck-upgrade> server # [  139.449658] postgres[1658]: 	            END;1555vm-test-run-amcheck-upgrade> server # [  139.449900] postgres[1658]: 	        $$;1556vm-test-run-amcheck-upgrade> server # [  139.450121] postgres[1658]: 	    END IF;1557vm-test-run-amcheck-upgrade> server # [  139.450345] postgres[1658]:1558vm-test-run-amcheck-upgrade> server # [  139.450620] postgres[1658]: 	    END;1559vm-test-run-amcheck-upgrade> server # [  139.450828] postgres[1658]: 	$func$;1560vm-test-run-amcheck-upgrade> server # [  139.451179] postgres[1658]: ::1 2026-10-07 20:39:26.773 UTC [1658] supabase_admin@postgres LOG:  statement: create or replace function graphql_public.graphql(1561vm-test-run-amcheck-upgrade> server # [  139.453920] postgres[1658]: 	    "operationName" text default null,1562vm-test-run-amcheck-upgrade> server # [  139.455846] postgres[1658]: 	    query text default null,1563vm-test-run-amcheck-upgrade> server # [  139.456491] postgres[1658]: 	    variables jsonb default null,1564vm-test-run-amcheck-upgrade> server # [  139.457269] postgres[1658]: 	    extensions jsonb default null1565vm-test-run-amcheck-upgrade> server # [  139.458072] postgres[1658]: 	)1566vm-test-run-amcheck-upgrade> server # [  139.458985] postgres[1658]: 	    returns jsonb1567vm-test-run-amcheck-upgrade> server # [  139.460221] postgres[1658]: 	    language plpgsql1568vm-test-run-amcheck-upgrade> server # [  139.461150] postgres[1658]: 	as $$1569vm-test-run-amcheck-upgrade> server # [  139.465902] postgres[1658]: 	    DECLARE1570vm-test-run-amcheck-upgrade> server # [  139.466718] postgres[1658]: 	        server_version float;1571vm-test-run-amcheck-upgrade> server # [  139.467024] postgres[1658]: 	    BEGIN1572vm-test-run-amcheck-upgrade> server # [  139.469671] postgres[1658]: 	        server_version = (SELECT (SPLIT_PART((select version()), ' ', 2))::float);1573vm-test-run-amcheck-upgrade> server # [  139.470725] postgres[1658]:1574vm-test-run-amcheck-upgrade> server # [  139.471204] postgres[1658]: 	        IF server_version >= 14 THEN1575vm-test-run-amcheck-upgrade> server # [  139.471480] postgres[1658]: 	            RETURN jsonb_build_object(1576vm-test-run-amcheck-upgrade> server # [  139.471995] postgres[1658]: 	                'errors', jsonb_build_array(1577vm-test-run-amcheck-upgrade> server # [  139.475113] postgres[1658]: 	                    jsonb_build_object(1578vm-test-run-amcheck-upgrade> server # [  139.478187] postgres[1658]: 	                        'message', 'pg_graphql extension is not enabled.'1579vm-test-run-amcheck-upgrade> server # [  139.478779] postgres[1658]: 	                    )1580vm-test-run-amcheck-upgrade> server # [  139.479290] postgres[1658]: 	                )1581vm-test-run-amcheck-upgrade> server # [  139.479569] postgres[1658]: 	            );1582vm-test-run-amcheck-upgrade> server # [  139.479864] postgres[1658]: 	        ELSE1583vm-test-run-amcheck-upgrade> server # [  139.480111] postgres[1658]: 	            RETURN jsonb_build_object(1584vm-test-run-amcheck-upgrade> server # [  139.480359] postgres[1658]: 	                'errors', jsonb_build_array(1585vm-test-run-amcheck-upgrade> server # [  139.480600] postgres[1658]: 	                    jsonb_build_object(1586vm-test-run-amcheck-upgrade> server # [  139.487399] postgres[1658]: 	                        'message', 'pg_graphql is only available on projects running Postgres 14 onwards.'1587vm-test-run-amcheck-upgrade> server # [  139.488055] postgres[1658]: 	                    )1588vm-test-run-amcheck-upgrade> server # [  139.488911] postgres[1658]: 	                )1589vm-test-run-amcheck-upgrade> server # [  139.491577] postgres[1658]: 	            );1590vm-test-run-amcheck-upgrade> server # [  139.492051] postgres[1658]: 	        END IF;1591vm-test-run-amcheck-upgrade> server # [  139.492304] postgres[1658]: 	    END;1592vm-test-run-amcheck-upgrade> server # [  139.492530] postgres[1658]: 	$$;1593vm-test-run-amcheck-upgrade> server # [  139.495057] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1657]: CREATE FUNCTION1594vm-test-run-amcheck-upgrade> server # [  139.496407] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1657]: CREATE FUNCTION1595vm-test-run-amcheck-upgrade> server # [  139.497658] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1657]: psql:/nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220404205710_pg_graphql-on-by-default.sql:142: NOTICE:  extension "pg_graphql" does not exist, skipping1596vm-test-run-amcheck-upgrade> server # [  139.499548] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1657]: DROP EXTENSION1597vm-test-run-amcheck-upgrade> server # [  139.502094] postgres[1658]: ::1 2026-10-07 20:39:26.829 UTC [1658] supabase_admin@postgres LOG:  statement: drop extension if exists pg_graphql;1598vm-test-run-amcheck-upgrade> server # [  141.595919] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1657]: DO1599vm-test-run-amcheck-upgrade> server # [  141.631351] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220609081115_grant-supabase-auth-admin-and-supabase-storage-admin-to-postgres.sql1600vm-test-run-amcheck-upgrade> server # [  141.914185] postgres[1684]: ::1 2026-10-07 20:39:29.271 UTC [1684] supabase_admin@postgres LOG:  statement: grant supabase_auth_admin, supabase_storage_admin to postgres;1601vm-test-run-amcheck-upgrade> server # [  141.934266] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1683]: GRANT ROLE1602vm-test-run-amcheck-upgrade> server # [  141.968064] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220613123923_pg_graphql-pg-dump-perms.sql1603vm-test-run-amcheck-upgrade> server # [  142.220572] postgres[1686]: ::1 2026-10-07 20:39:29.583 UTC [1686] supabase_admin@postgres LOG:  statement: create or replace function extensions.grant_pg_graphql_access()1604vm-test-run-amcheck-upgrade> server # [  142.225479] postgres[1686]: 	    returns event_trigger1605vm-test-run-amcheck-upgrade> server # [  142.226037] postgres[1686]: 	    language plpgsql1606vm-test-run-amcheck-upgrade> server # [  142.226662] postgres[1686]: 	AS $func$1607vm-test-run-amcheck-upgrade> server # [  142.227224] postgres[1686]: 	DECLARE1608vm-test-run-amcheck-upgrade> server # [  142.227903] postgres[1686]: 	    func_is_graphql_resolve bool;1609vm-test-run-amcheck-upgrade> server # [  142.228795] postgres[1686]: 	BEGIN1610vm-test-run-amcheck-upgrade> server # [  142.229315] postgres[1686]: 	    func_is_graphql_resolve = (1611vm-test-run-amcheck-upgrade> server # [  142.229601] postgres[1686]: 	        SELECT n.proname = 'resolve'1612vm-test-run-amcheck-upgrade> server # [  142.234175] postgres[1686]: 	        FROM pg_event_trigger_ddl_commands() AS ev1613vm-test-run-amcheck-upgrade> server # [  142.234564] postgres[1686]: 	        LEFT JOIN pg_catalog.pg_proc AS n1614vm-test-run-amcheck-upgrade> server # [  142.234950] postgres[1686]: 	        ON ev.objid = n.oid1615vm-test-run-amcheck-upgrade> server # [  142.235978] postgres[1686]: 	    );1616vm-test-run-amcheck-upgrade> server # [  142.237277] postgres[1686]:1617vm-test-run-amcheck-upgrade> server # [  142.237939] postgres[1686]: 	    IF func_is_graphql_resolve1618vm-test-run-amcheck-upgrade> server # [  142.238464] postgres[1686]: 	    THEN1619vm-test-run-amcheck-upgrade> server # [  142.238918] postgres[1686]: 	        -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1620vm-test-run-amcheck-upgrade> server # [  142.240004] postgres[1686]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;1621vm-test-run-amcheck-upgrade> server # [  142.242269] postgres[1686]: 	        create or replace function graphql_public.graphql(1622vm-test-run-amcheck-upgrade> server # [  142.242792] postgres[1686]: 	            "operationName" text default null,1623vm-test-run-amcheck-upgrade> server # [  142.243108] postgres[1686]: 	            query text default null,1624vm-test-run-amcheck-upgrade> server # [  142.243384] postgres[1686]: 	            variables jsonb default null,1625vm-test-run-amcheck-upgrade> server # [  142.245204] postgres[1686]: 	            extensions jsonb default null1626vm-test-run-amcheck-upgrade> server # [  142.245732] postgres[1686]: 	        )1627vm-test-run-amcheck-upgrade> server # [  142.246831] postgres[1686]: 	            returns jsonb1628vm-test-run-amcheck-upgrade> server # [  142.248086] postgres[1686]: 	            language sql1629vm-test-run-amcheck-upgrade> server # [  142.249666] postgres[1686]: 	        as $$1630vm-test-run-amcheck-upgrade> server # [  142.249995] postgres[1686]: 	            select graphql.resolve(1631vm-test-run-amcheck-upgrade> server # [  142.250422] postgres[1686]: 	                query := query,1632vm-test-run-amcheck-upgrade> server # [  142.250694] postgres[1686]: 	                variables := coalesce(variables, '{}'),1633vm-test-run-amcheck-upgrade> server # [  142.251163] postgres[1686]: 	                "operationName" := "operationName",1634vm-test-run-amcheck-upgrade> server # [  142.251992] postgres[1686]: 	                extensions := extensions1635vm-test-run-amcheck-upgrade> server # [  142.255346] postgres[1686]: 	            );1636vm-test-run-amcheck-upgrade> server # [  142.255955] postgres[1686]: 	        $$;1637vm-test-run-amcheck-upgrade> server # [  142.257138] postgres[1686]:1638vm-test-run-amcheck-upgrade> server # [  142.257726] postgres[1686]: 	        -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1639vm-test-run-amcheck-upgrade> server # [  142.258616] postgres[1686]: 	        -- function in the extension so we need to grant permissions on existing entities AND1640vm-test-run-amcheck-upgrade> server # [  142.259147] postgres[1686]: 	        -- update default permissions to any others that are created after `graphql.resolve`1641vm-test-run-amcheck-upgrade> server # [  142.259806] postgres[1686]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;1642vm-test-run-amcheck-upgrade> server # [  142.262021] postgres[1686]: 	        grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1643vm-test-run-amcheck-upgrade> server # [  142.263563] postgres[1686]: 	        grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1644vm-test-run-amcheck-upgrade> server # [  142.265588] postgres[1686]: 	        grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1645vm-test-run-amcheck-upgrade> server # [  142.266355] postgres[1686]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1646vm-test-run-amcheck-upgrade> server # [  142.267766] postgres[1686]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1647vm-test-run-amcheck-upgrade> server # [  142.268712] postgres[1686]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1648vm-test-run-amcheck-upgrade> server # [  142.271256] postgres[1686]: 	    END IF;1649vm-test-run-amcheck-upgrade> server # [  142.272147] postgres[1686]:1650vm-test-run-amcheck-upgrade> server # [  142.273942] postgres[1686]: 	END;1651vm-test-run-amcheck-upgrade> server # [  142.274817] postgres[1686]: 	$func$;1652vm-test-run-amcheck-upgrade> server # [  142.322648] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1685]: CREATE FUNCTION1653vm-test-run-amcheck-upgrade> server # [  142.323493] postgres[1686]: ::1 2026-10-07 20:39:29.680 UTC [1686] supabase_admin@postgres LOG:  statement: drop extension if exists pg_graphql;1654vm-test-run-amcheck-upgrade> server # [  142.365604] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1685]: DROP EXTENSION1655vm-test-run-amcheck-upgrade> server # [  144.487976] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1685]: DO1656vm-test-run-amcheck-upgrade> server # [  144.557217] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20220713082019_pg_cron-pg_net-temp-perms-fix.sql1657vm-test-run-amcheck-upgrade> server # [  145.723387] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1711]: DO1658vm-test-run-amcheck-upgrade> server # [  146.440516] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1711]: DO1659vm-test-run-amcheck-upgrade> server # [  146.533374] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221028101028_set_authenticator_timeout.sql1660vm-test-run-amcheck-upgrade> server # [  147.087932] postgres[1730]: ::1 2026-10-07 20:39:34.429 UTC [1730] supabase_admin@postgres LOG:  statement: alter role authenticator set statement_timeout = '8s';1661vm-test-run-amcheck-upgrade> server # [  147.158435] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1726]: ALTER ROLE1662vm-test-run-amcheck-upgrade> server # [  147.190045] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221103090837_revoke_admin.sql1663vm-test-run-amcheck-upgrade> server # [  147.652274] postgres[1739]: ::1 2026-10-07 20:39:35.003 UTC [1739] supabase_admin@postgres LOG:  statement: revoke supabase_admin from authenticator;1664vm-test-run-amcheck-upgrade> server # [  147.691311] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1735]: REVOKE ROLE1665vm-test-run-amcheck-upgrade> server # [  147.768273] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20221207154255_create_pgsodium_and_vault.sql1666vm-test-run-amcheck-upgrade> server # [  150.191818] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1742]: DO1667vm-test-run-amcheck-upgrade> server # [  150.242172] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230201083204_grant_auth_roles_to_postgres.sql1668vm-test-run-amcheck-upgrade> server # [  150.778809] postgres[1771]: ::1 2026-10-07 20:39:38.124 UTC [1771] supabase_admin@postgres LOG:  statement: grant anon, authenticated, service_role to postgres;1669vm-test-run-amcheck-upgrade> server # [  150.811871] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1761]: GRANT ROLE1670vm-test-run-amcheck-upgrade> server # [  150.863979] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230224042246_grant_extensions_perms_for_postgres.sql1671vm-test-run-amcheck-upgrade> server # [  151.283752] postgres[1778]: ::1 2026-10-07 20:39:38.644 UTC [1778] supabase_admin@postgres LOG:  statement: grant all privileges on all tables in schema extensions to postgres with grant option;1672vm-test-run-amcheck-upgrade> server # [  151.365844] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1777]: GRANT1673vm-test-run-amcheck-upgrade> server # [  151.367007] postgres[1778]: ::1 2026-10-07 20:39:38.723 UTC [1778] supabase_admin@postgres LOG:  statement: grant all privileges on all routines in schema extensions to postgres with grant option;1674vm-test-run-amcheck-upgrade> server # [  151.437172] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1777]: GRANT1675vm-test-run-amcheck-upgrade> server # [  151.438674] postgres[1778]: ::1 2026-10-07 20:39:38.802 UTC [1778] supabase_admin@postgres LOG:  statement: grant all privileges on all sequences in schema extensions to postgres with grant option;1676vm-test-run-amcheck-upgrade> server # [  151.445147] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1777]: GRANT1677vm-test-run-amcheck-upgrade> server # [  151.449694] postgres[1778]: ::1 2026-10-07 20:39:38.812 UTC [1778] supabase_admin@postgres LOG:  statement: alter default privileges in schema extensions grant all on tables to postgres with grant option;1678vm-test-run-amcheck-upgrade> server # [  151.466785] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1777]: ALTER DEFAULT PRIVILEGES1679vm-test-run-amcheck-upgrade> server # [  151.467960] postgres[1778]: ::1 2026-10-07 20:39:38.832 UTC [1778] supabase_admin@postgres LOG:  statement: alter default privileges in schema extensions grant all on routines to postgres with grant option;1680vm-test-run-amcheck-upgrade> server # [  151.479541] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1777]: ALTER DEFAULT PRIVILEGES1681vm-test-run-amcheck-upgrade> server # [  151.482746] postgres[1778]: ::1 2026-10-07 20:39:38.846 UTC [1778] supabase_admin@postgres LOG:  statement: alter default privileges in schema extensions grant all on sequences to postgres with grant option;1682vm-test-run-amcheck-upgrade> server # [  151.513097] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1777]: ALTER DEFAULT PRIVILEGES1683vm-test-run-amcheck-upgrade> server # [  151.559396] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230306081037_grant_pg_monitor_to_postgres.sql1684vm-test-run-amcheck-upgrade> server # [  151.855301] postgres[1780]: ::1 2026-10-07 20:39:39.216 UTC [1780] supabase_admin@postgres LOG:  statement: grant pg_monitor to postgres;1685vm-test-run-amcheck-upgrade> server # [  151.878416] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1779]: GRANT ROLE1686vm-test-run-amcheck-upgrade> server # [  151.915583] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230327032006_grant_auth_roles_to_supabase_storage_admin.sql1687vm-test-run-amcheck-upgrade> server # [  152.195579] postgres[1782]: ::1 2026-10-07 20:39:39.555 UTC [1782] supabase_admin@postgres LOG:  statement: grant anon, authenticated, service_role to supabase_storage_admin;1688vm-test-run-amcheck-upgrade> server # [  152.223827] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1781]: GRANT ROLE1689vm-test-run-amcheck-upgrade> server # [  152.249721] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20230529180330_alter_api_roles_for_inherit.sql1690vm-test-run-amcheck-upgrade> server # [  152.579127] postgres[1784]: ::1 2026-10-07 20:39:39.939 UTC [1784] supabase_admin@postgres LOG:  statement: ALTER ROLE authenticated inherit;1691vm-test-run-amcheck-upgrade> server # [  152.655368] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1783]: ALTER ROLE1692vm-test-run-amcheck-upgrade> server # [  152.665445] postgres[1784]: ::1 2026-10-07 20:39:39.994 UTC [1784] supabase_admin@postgres LOG:  statement: ALTER ROLE anon inherit;1693vm-test-run-amcheck-upgrade> server # [  152.671357] postgres[1784]: ::1 2026-10-07 20:39:40.020 UTC [1784] supabase_admin@postgres LOG:  statement: ALTER ROLE service_role inherit;1694vm-test-run-amcheck-upgrade> server # [  152.681853] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1783]: ALTER ROLE1695vm-test-run-amcheck-upgrade> server # [  152.682898] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1783]: ALTER ROLE1696vm-test-run-amcheck-upgrade> server # [  152.721194] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1783]: DO1697vm-test-run-amcheck-upgrade> server # [  152.811524] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231013070755_grant_authenticator_to_supabase_storage_admin.sql1698vm-test-run-amcheck-upgrade> server # [  153.531907] postgres[1799]: ::1 2026-10-07 20:39:40.877 UTC [1799] supabase_admin@postgres LOG:  statement: grant authenticator to supabase_storage_admin;1699vm-test-run-amcheck-upgrade> server # [  153.570721] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1792]: GRANT ROLE1700vm-test-run-amcheck-upgrade> server # [  153.575956] postgres[1799]: ::1 2026-10-07 20:39:40.914 UTC [1799] supabase_admin@postgres LOG:  statement: revoke anon, authenticated, service_role from supabase_storage_admin;1701vm-test-run-amcheck-upgrade> server # [  153.581763] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1792]: REVOKE ROLE1702vm-test-run-amcheck-upgrade> server # [  153.646088] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231017062225_grant_pg_graphql_permissions_for_custom_roles.sql1703vm-test-run-amcheck-upgrade> server # [  154.238449] postgres[1810]: ::1 2026-10-07 20:39:41.556 UTC [1810] supabase_admin@postgres LOG:  statement: create or replace function extensions.grant_pg_graphql_access()1704vm-test-run-amcheck-upgrade> server # [  154.266846] postgres[1810]: 	    returns event_trigger1705vm-test-run-amcheck-upgrade> server # [  154.274552] postgres[1810]: 	    language plpgsql1706vm-test-run-amcheck-upgrade> server # [  154.275446] postgres[1810]: 	AS $func$1707vm-test-run-amcheck-upgrade> server # [  154.281929] postgres[1810]: 	DECLARE1708vm-test-run-amcheck-upgrade> server # [  154.284113] postgres[1810]: 	    func_is_graphql_resolve bool;1709vm-test-run-amcheck-upgrade> server # [  154.289374] postgres[1810]: 	BEGIN1710vm-test-run-amcheck-upgrade> server # [  154.289952] postgres[1810]: 	    func_is_graphql_resolve = (1711vm-test-run-amcheck-upgrade> server # [  154.290337] postgres[1810]: 	        SELECT n.proname = 'resolve'1712vm-test-run-amcheck-upgrade> server # [  154.291626] postgres[1810]: 	        FROM pg_event_trigger_ddl_commands() AS ev1713vm-test-run-amcheck-upgrade> server # [  154.294420] postgres[1810]: 	        LEFT JOIN pg_catalog.pg_proc AS n1714vm-test-run-amcheck-upgrade> server # [  154.304192] postgres[1810]: 	        ON ev.objid = n.oid1715vm-test-run-amcheck-upgrade> server # [  154.304827] postgres[1810]: 	    );1716vm-test-run-amcheck-upgrade> server # [  154.311585] postgres[1810]:1717vm-test-run-amcheck-upgrade> server # [  154.313711] postgres[1810]: 	    IF func_is_graphql_resolve1718vm-test-run-amcheck-upgrade> server # [  154.314150] postgres[1810]: 	    THEN1719vm-test-run-amcheck-upgrade> server # [  154.315353] postgres[1810]: 	        -- Update public wrapper to pass all arguments through to the pg_graphql resolve func1720vm-test-run-amcheck-upgrade> server # [  154.321945] postgres[1810]: 	        DROP FUNCTION IF EXISTS graphql_public.graphql;1721vm-test-run-amcheck-upgrade> server # [  154.322818] postgres[1810]: 	        create or replace function graphql_public.graphql(1722vm-test-run-amcheck-upgrade> server # [  154.324122] postgres[1810]: 	            "operationName" text default null,1723vm-test-run-amcheck-upgrade> server # [  154.328234] postgres[1810]: 	            query text default null,1724vm-test-run-amcheck-upgrade> server # [  154.331268] postgres[1810]: 	            variables jsonb default null,1725vm-test-run-amcheck-upgrade> server # [  154.333937] postgres[1810]: 	            extensions jsonb default null1726vm-test-run-amcheck-upgrade> server # [  154.340005] postgres[1810]: 	        )1727vm-test-run-amcheck-upgrade> server # [  154.341712] postgres[1810]: 	            returns jsonb1728vm-test-run-amcheck-upgrade> server # [  154.342264] postgres[1810]: 	            language sql1729vm-test-run-amcheck-upgrade> server # [  154.342584] postgres[1810]: 	        as $$1730vm-test-run-amcheck-upgrade> server # [  154.342818] postgres[1810]: 	            select graphql.resolve(1731vm-test-run-amcheck-upgrade> server # [  154.343129] postgres[1810]: 	                query := query,1732vm-test-run-amcheck-upgrade> server # [  154.343535] postgres[1810]: 	                variables := coalesce(variables, '{}'),1733vm-test-run-amcheck-upgrade> server # [  154.347217] postgres[1810]: 	                "operationName" := "operationName",1734vm-test-run-amcheck-upgrade> server # [  154.352374] postgres[1810]: 	                extensions := extensions1735vm-test-run-amcheck-upgrade> server # [  154.353209] postgres[1810]: 	            );1736vm-test-run-amcheck-upgrade> server # [  154.354225] postgres[1810]: 	        $$;1737vm-test-run-amcheck-upgrade> server # [  154.355298] postgres[1810]:1738vm-test-run-amcheck-upgrade> server # [  154.355618] postgres[1810]: 	        -- This hook executes when `graphql.resolve` is created. That is not necessarily the last1739vm-test-run-amcheck-upgrade> server # [  154.359752] postgres[1810]: 	        -- function in the extension so we need to grant permissions on existing entities AND1740vm-test-run-amcheck-upgrade> server # [  154.369692] postgres[1810]: 	        -- update default permissions to any others that are created after `graphql.resolve`1741vm-test-run-amcheck-upgrade> server # [  154.370940] postgres[1810]: 	        grant usage on schema graphql to postgres, anon, authenticated, service_role;1742vm-test-run-amcheck-upgrade> server # [  154.371809] postgres[1810]: 	        grant select on all tables in schema graphql to postgres, anon, authenticated, service_role;1743vm-test-run-amcheck-upgrade> server # [  154.373735] postgres[1810]: 	        grant execute on all functions in schema graphql to postgres, anon, authenticated, service_role;1744vm-test-run-amcheck-upgrade> server # [  154.375543] postgres[1810]: 	        grant all on all sequences in schema graphql to postgres, anon, authenticated, service_role;1745vm-test-run-amcheck-upgrade> server # [  154.385366] postgres[1810]: 	        alter default privileges in schema graphql grant all on tables to postgres, anon, authenticated, service_role;1746vm-test-run-amcheck-upgrade> server # [  154.386254] postgres[1810]: 	        alter default privileges in schema graphql grant all on functions to postgres, anon, authenticated, service_role;1747vm-test-run-amcheck-upgrade> server # [  154.386649] postgres[1810]: 	        alter default privileges in schema graphql grant all on sequences to postgres, anon, authenticated, service_role;1748vm-test-run-amcheck-upgrade> server # [  154.386960] postgres[1810]:1749vm-test-run-amcheck-upgrade> server # [  154.387351] postgres[1810]: 	        -- Allow postgres role to allow granting usage on graphql and graphql_public schemas to custom roles1750vm-test-run-amcheck-upgrade> server # [  154.388700] postgres[1810]: 	        grant usage on schema graphql_public to postgres with grant option;1751vm-test-run-amcheck-upgrade> server # [  154.391097] postgres[1810]: 	        grant usage on schema graphql to postgres with grant option;1752vm-test-run-amcheck-upgrade> server # [  154.392155] postgres[1810]: 	    END IF;1753vm-test-run-amcheck-upgrade> server # [  154.393471] postgres[1810]:1754vm-test-run-amcheck-upgrade> server # [  154.394291] postgres[1810]: 	END;1755vm-test-run-amcheck-upgrade> server # [  154.394856] postgres[1810]: 	$func$;1756vm-test-run-amcheck-upgrade> server # [  154.395258] postgres[1810]: ::1 2026-10-07 20:39:41.713 UTC [1810] supabase_admin@postgres LOG:  statement: drop extension if exists pg_graphql;1757vm-test-run-amcheck-upgrade> server # [  154.399113] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1805]: CREATE FUNCTION1758vm-test-run-amcheck-upgrade> server # [  154.409684] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1805]: DROP EXTENSION1759vm-test-run-amcheck-upgrade> server # [  156.477206] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1805]: DO1760vm-test-run-amcheck-upgrade> server # [  156.546541] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231020085357_revoke_writes_on_cron_job_from_postgres.sql1761vm-test-run-amcheck-upgrade> server # [  157.052908] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1830]: DO1762vm-test-run-amcheck-upgrade> server # [  157.085222] postgres[1836]: ::1 2026-10-07 20:39:44.406 UTC [1836] supabase_admin@postgres LOG:  statement: CREATE OR REPLACE FUNCTION extensions.grant_pg_cron_access() RETURNS event_trigger1763vm-test-run-amcheck-upgrade> server # [  157.098224] postgres[1836]: 	    LANGUAGE plpgsql1764vm-test-run-amcheck-upgrade> server # [  157.106342] postgres[1836]: 	    AS $$1765vm-test-run-amcheck-upgrade> server # [  157.110464] postgres[1836]: 	BEGIN1766vm-test-run-amcheck-upgrade> server # [  157.111060] postgres[1836]: 	  IF EXISTS (1767vm-test-run-amcheck-upgrade> server # [  157.111955] postgres[1836]: 	    SELECT1768vm-test-run-amcheck-upgrade> server # [  157.121140] postgres[1836]: 	    FROM pg_event_trigger_ddl_commands() AS ev1769vm-test-run-amcheck-upgrade> server # [  157.124142] postgres[1836]: 	    JOIN pg_extension AS ext1770vm-test-run-amcheck-upgrade> server # [  157.138104] postgres[1836]: 	    ON ev.objid = ext.oid1771vm-test-run-amcheck-upgrade> server # [  157.139853] postgres[1836]: 	    WHERE ext.extname = 'pg_cron'1772vm-test-run-amcheck-upgrade> server # [  157.147276] postgres[1836]: 	  )1773vm-test-run-amcheck-upgrade> server # [  157.152970] postgres[1836]: 	  THEN1774vm-test-run-amcheck-upgrade> server # [  157.153999] postgres[1836]: 	    grant usage on schema cron to postgres with grant option;1775vm-test-run-amcheck-upgrade> server # [  157.154387] postgres[1836]:1776vm-test-run-amcheck-upgrade> server # [  157.155019] postgres[1836]: 	    alter default privileges in schema cron grant all on tables to postgres with grant option;1777vm-test-run-amcheck-upgrade> server # [  157.156129] postgres[1836]: 	    alter default privileges in schema cron grant all on functions to postgres with grant option;1778vm-test-run-amcheck-upgrade> server # [  157.156469] postgres[1836]: 	    alter default privileges in schema cron grant all on sequences to postgres with grant option;1779vm-test-run-amcheck-upgrade> server # [  157.166130] postgres[1836]:1780vm-test-run-amcheck-upgrade> server # [  157.166530] postgres[1836]: 	    alter default privileges for user supabase_admin in schema cron grant all1781vm-test-run-amcheck-upgrade> server # [  157.167099] postgres[1836]: 	        on sequences to postgres with grant option;1782vm-test-run-amcheck-upgrade> server # [  157.167881] postgres[1836]: 	    alter default privileges for user supabase_admin in schema cron grant all1783vm-test-run-amcheck-upgrade> server # [  157.178254] postgres[1836]: 	        on tables to postgres with grant option;1784vm-test-run-amcheck-upgrade> server # [  157.179044] postgres[1836]: 	    alter default privileges for user supabase_admin in schema cron grant all1785vm-test-run-amcheck-upgrade> server # [  157.180171] postgres[1836]: 	        on functions to postgres with grant option;1786vm-test-run-amcheck-upgrade> server # [  157.180480] postgres[1836]:1787vm-test-run-amcheck-upgrade> server # [  157.180716] postgres[1836]: 	    grant all privileges on all tables in schema cron to postgres with grant option;1788vm-test-run-amcheck-upgrade> server # [  157.192500] postgres[1836]: 	    revoke all on table cron.job from postgres;1789vm-test-run-amcheck-upgrade> server # [  157.194506] postgres[1836]: 	    grant select on table cron.job to postgres with grant option;1790vm-test-run-amcheck-upgrade> server # [  157.196213] postgres[1836]: 	  END IF;1791vm-test-run-amcheck-upgrade> server # [  157.196573] postgres[1836]: 	END;1792vm-test-run-amcheck-upgrade> server # [  157.196817] postgres[1836]: 	$$;1793vm-test-run-amcheck-upgrade> server # [  157.209375] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1830]: CREATE FUNCTION1794vm-test-run-amcheck-upgrade> server # [  157.214681] postgres[1836]: ::1 2026-10-07 20:39:44.576 UTC [1836] supabase_admin@postgres LOG:  statement: drop event trigger if exists issue_pg_cron_access;1795vm-test-run-amcheck-upgrade> server # [  157.227491] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1830]: DROP EVENT TRIGGER1796vm-test-run-amcheck-upgrade> server # [  157.234434] postgres[1836]: ::1 2026-10-07 20:39:44.596 UTC [1836] supabase_admin@postgres LOG:  statement: alter function extensions.grant_pg_cron_access owner to supabase_admin;1797vm-test-run-amcheck-upgrade> server # [  157.254444] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1830]: ALTER FUNCTION1798vm-test-run-amcheck-upgrade> server # [  157.262947] postgres[1836]: ::1 2026-10-07 20:39:44.623 UTC [1836] supabase_admin@postgres LOG:  statement: CREATE EVENT TRIGGER issue_pg_cron_access ON ddl_command_end1799vm-test-run-amcheck-upgrade> server # [  157.269905] postgres[1836]: 	         WHEN TAG IN ('CREATE EXTENSION')1800vm-test-run-amcheck-upgrade> server # [  157.281756] postgres[1836]: 	   EXECUTE FUNCTION extensions.grant_pg_cron_access();1801vm-test-run-amcheck-upgrade> server # [  157.320820] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1830]: CREATE EVENT TRIGGER1802vm-test-run-amcheck-upgrade> server # [  157.333833] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20231130133139_set_lock_timeout_to_authenticator_role.sql1803vm-test-run-amcheck-upgrade> server # [  157.689577] postgres[1844]: ::1 2026-10-07 20:39:45.035 UTC [1844] supabase_admin@postgres LOG:  statement: ALTER ROLE authenticator set lock_timeout to '8s';1804vm-test-run-amcheck-upgrade> server # [  157.722448] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1842]: ALTER ROLE1805vm-test-run-amcheck-upgrade> server # [  157.767368] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240124080435_alter_lo_export_lo_import_owner.sql1806vm-test-run-amcheck-upgrade> server # [  158.147959] postgres[1846]: ::1 2026-10-07 20:39:45.502 UTC [1846] supabase_admin@postgres LOG:  statement: alter function pg_catalog.lo_export owner to supabase_admin;1807vm-test-run-amcheck-upgrade> server # [  158.175591] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1845]: ALTER FUNCTION1808vm-test-run-amcheck-upgrade> server # [  158.179966] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1845]: ALTER FUNCTION1809vm-test-run-amcheck-upgrade> server # [  158.183749] postgres[1846]: ::1 2026-10-07 20:39:45.532 UTC [1846] supabase_admin@postgres LOG:  statement: alter function pg_catalog.lo_import(text) owner to supabase_admin;1810vm-test-run-amcheck-upgrade> server # [  158.186449] postgres[1846]: ::1 2026-10-07 20:39:45.546 UTC [1846] supabase_admin@postgres LOG:  statement: alter function pg_catalog.lo_import(text, oid) owner to supabase_admin;1811vm-test-run-amcheck-upgrade> server # [  158.193901] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1845]: ALTER FUNCTION1812vm-test-run-amcheck-upgrade> server # [  158.233035] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20240606060239_grant_predefined_roles_to_postgres.sql1813vm-test-run-amcheck-upgrade> server # [  158.511002] postgres[1848]: ::1 2026-10-07 20:39:45.862 UTC [1848] supabase_admin@postgres LOG:  statement: grant pg_read_all_data, pg_signal_backend to postgres;1814vm-test-run-amcheck-upgrade> server # [  158.542229] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1847]: GRANT ROLE1815vm-test-run-amcheck-upgrade> server # [  158.557342] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241031003909_create_orioledb.sql1816vm-test-run-amcheck-upgrade> server # [  159.754739] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1849]: DO1817vm-test-run-amcheck-upgrade> server # [  159.829783] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20241215003910_backfill_pgmq_metadata.sql1818vm-test-run-amcheck-upgrade> server # [  160.527385] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1862]: DO1819vm-test-run-amcheck-upgrade> server # [  160.546837] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1862]: DO1820vm-test-run-amcheck-upgrade> server # [  160.598337] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205060043_disable_log_statement_on_internal_roles.sql1821vm-test-run-amcheck-upgrade> server # [  161.012708] postgres[1878]: ::1 2026-10-07 20:39:48.368 UTC [1878] supabase_admin@postgres LOG:  statement: alter role supabase_admin set log_statement = none;1822vm-test-run-amcheck-upgrade> server # [  161.030403] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1875]: ALTER ROLE1823vm-test-run-amcheck-upgrade> server # [  161.037699] postgres[1878]: ::1 2026-10-07 20:39:48.391 UTC [1878] supabase_admin@postgres LOG:  statement: alter role supabase_auth_admin set log_statement = none;1824vm-test-run-amcheck-upgrade> server # [  161.040331] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1875]: ALTER ROLE1825vm-test-run-amcheck-upgrade> server # [  161.046839] postgres[1878]: ::1 2026-10-07 20:39:48.406 UTC [1878] supabase_admin@postgres LOG:  statement: alter role supabase_storage_admin set log_statement = none;1826vm-test-run-amcheck-upgrade> server # [  161.050991] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1875]: ALTER ROLE1827vm-test-run-amcheck-upgrade> server # [  161.131411] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250205144616_move_orioledb_to_extensions_schema.sql1828vm-test-run-amcheck-upgrade> server # [  161.619937] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1881]: DO1829vm-test-run-amcheck-upgrade> server # [  161.651853] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250218031949_pgsodium_mask_role.sql1830vm-test-run-amcheck-upgrade> server # [  162.031410] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1885]: DO1831vm-test-run-amcheck-upgrade> server # [  162.073587] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250220051611_pg_net_perms_fix.sql1832vm-test-run-amcheck-upgrade> server # [  162.406574] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1887]: CREATE FUNCTION1833vm-test-run-amcheck-upgrade> server # [  162.421338] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1887]: DO1834vm-test-run-amcheck-upgrade> server # [  162.475289] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250312095419_pgbouncer_ownership.sql1835vm-test-run-amcheck-upgrade> server # [  162.847346] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1889]: ALTER FUNCTION1836vm-test-run-amcheck-upgrade> server # [  162.851601] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1889]: GRANT1837vm-test-run-amcheck-upgrade> server # [  162.897755] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402065937_alter_internal_event_triggers_owner_to_supabase_admin.sql1838vm-test-run-amcheck-upgrade> server # [  163.580151] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1897]: DROP EVENT TRIGGER1839vm-test-run-amcheck-upgrade> server # [  163.649594] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1897]: ALTER FUNCTION1840vm-test-run-amcheck-upgrade> server # [  163.684928] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1897]: CREATE EVENT TRIGGER1841vm-test-run-amcheck-upgrade> server # [  163.765850] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250402093753_grant_subscription_to_postgres_16_and_above.sql1842vm-test-run-amcheck-upgrade> server # [  164.235943] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1911]: DO1843vm-test-run-amcheck-upgrade> server # [  164.286903] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250417190610_update_pgbouncer_get_auth.sql1844vm-test-run-amcheck-upgrade> server # [  164.708713] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1919]: CREATE FUNCTION1845vm-test-run-amcheck-upgrade> server # [  164.727093] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1919]: GRANT1846vm-test-run-amcheck-upgrade> server # [  164.781817] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250421084701_revoke_admin_roles_from_postgres.sql1847vm-test-run-amcheck-upgrade> server # [  165.066263] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1921]: REVOKE ROLE1848vm-test-run-amcheck-upgrade> server # [  165.095941] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1921]: DO1849vm-test-run-amcheck-upgrade> server # [  165.110675] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1921]: DO1850vm-test-run-amcheck-upgrade> server # [  165.115235] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1921]: REVOKE ROLE1851vm-test-run-amcheck-upgrade> server # [  165.136933] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1921]: REVOKE1852vm-test-run-amcheck-upgrade> server # [  165.188049] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1921]: DO1853vm-test-run-amcheck-upgrade> server # [  165.246405] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250605172253_grant_with_admin_to_postgres_16_and_above.sql1854vm-test-run-amcheck-upgrade> server # [  165.663676] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1926]: DO1855vm-test-run-amcheck-upgrade> server # [  165.709526] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250623125453_tmp_grant_storage_tables_to_postgres_with_grant_option.sql1856vm-test-run-amcheck-upgrade> server # [  166.247029] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1929]: DO1857vm-test-run-amcheck-upgrade> server # [  166.307094] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250709135250_grant_storage_schema_to_postgres_with_grant_option.sql1858vm-test-run-amcheck-upgrade> server # [  166.836139] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1937]: DO1859vm-test-run-amcheck-upgrade> server # [  166.897020] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20250710151649_supabase_read_only_user_default_transaction_read_only.sql1860vm-test-run-amcheck-upgrade> server # [  167.492173] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1948]: ALTER ROLE1861vm-test-run-amcheck-upgrade> server # [  167.559601] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251001204436_predefined_role_grants.sql1862vm-test-run-amcheck-upgrade> server # [  167.920991] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1959]: GRANT ROLE1863vm-test-run-amcheck-upgrade> server # [  167.935319] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1959]: DO1864vm-test-run-amcheck-upgrade> server # [  167.979885] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251105172723_grant_pg_reload_conf_to_postgres.sql1865vm-test-run-amcheck-upgrade> server # [  168.302711] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1961]: GRANT1866vm-test-run-amcheck-upgrade> server # [  168.332458] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20251121132723_correct_search_path_pgbouncer.sql1867vm-test-run-amcheck-upgrade> server # [  168.654505] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1963]: CREATE FUNCTION1868vm-test-run-amcheck-upgrade> server # [  168.666674] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1963]: REVOKE1869vm-test-run-amcheck-upgrade> server # [  168.678433] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1963]: REVOKE1870vm-test-run-amcheck-upgrade> server # [  168.687176] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1963]: GRANT1871vm-test-run-amcheck-upgrade> server # [  168.748417] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260211120934_supabase_privileged_role.sql1872vm-test-run-amcheck-upgrade> server # [  169.101056] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1965]: DO1873vm-test-run-amcheck-upgrade> server # [  169.109156] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260413000000_fix-authenticator-session-preload-libraries.sql1874vm-test-run-amcheck-upgrade> server # [  169.627917] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1968]: ALTER ROLE1875vm-test-run-amcheck-upgrade> server # [  169.697381] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000000_pg_graphql-off-by-default.sql1876vm-test-run-amcheck-upgrade> server # [  170.467556] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1979]: DROP EXTENSION1877vm-test-run-amcheck-upgrade> server # [  170.504790] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260421000001_rescope_pg_graphql_access_trigger.sql1878vm-test-run-amcheck-upgrade> server # [  170.935857] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1993]: CREATE FUNCTION1879vm-test-run-amcheck-upgrade> server # [  170.946740] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1993]: DROP EVENT TRIGGER1880vm-test-run-amcheck-upgrade> server # [  170.959734] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1993]: CREATE EVENT TRIGGER1881vm-test-run-amcheck-upgrade> server # [  171.002430] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260730000000_revoke_trigger_on_cron_tables_from_postgres.sql1882vm-test-run-amcheck-upgrade> server # [  171.359458] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1997]: DO1883vm-test-run-amcheck-upgrade> server # [  171.404585] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1997]: CREATE FUNCTION1884vm-test-run-amcheck-upgrade> server # [  171.461655] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running migration: /nix/store/nw0bs8nddlaf6wh127acj2xwsdq5p7qz-migrations-db/migrations/20260923021047_update_pgrst_watch_triggers.sql1885vm-test-run-amcheck-upgrade> server # [  171.904131] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2002]: CREATE FUNCTION1886vm-test-run-amcheck-upgrade> server # [  171.923133] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2002]: CREATE FUNCTION1887vm-test-run-amcheck-upgrade> server # [  171.992010] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Running postgresql schema...1888vm-test-run-amcheck-upgrade> server # [  172.343545] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER DATABASE1889vm-test-run-amcheck-upgrade> server # [  172.350169] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER DATABASE1890vm-test-run-amcheck-upgrade> server # [  172.429145] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER ROLE1891vm-test-run-amcheck-upgrade> server # [  172.553580] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER ROLE1892vm-test-run-amcheck-upgrade> server # [  172.675920] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER ROLE1893vm-test-run-amcheck-upgrade> server # [  172.801612] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER ROLE1894vm-test-run-amcheck-upgrade> server # [  172.930368] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER ROLE1895vm-test-run-amcheck-upgrade> server # [  173.061870] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER ROLE1896vm-test-run-amcheck-upgrade> server # [  173.181344] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER ROLE1897vm-test-run-amcheck-upgrade> server # [  173.289746] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER ROLE1898vm-test-run-amcheck-upgrade> server # [  173.439985] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER ROLE1899vm-test-run-amcheck-upgrade> server # [  173.455041] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[2005]: ALTER ROLE1900vm-test-run-amcheck-upgrade> server # [  173.515301] z8w0zyjml4ky3aw4mdlmwdwjsyk9dyr0-supabase-db-init[1445]: Database initialization complete1901vm-test-run-amcheck-upgrade> server # [  173.587143] systemd[1]: Finished Supabase Database Initialization.1902vm-test-run-amcheck-upgrade> server # [  173.610892] systemd[1]: Reached target Multi-User System.1903vm-test-run-amcheck-upgrade> server # [  173.638004] systemd[1]: Startup finished in 18.201s (kernel) + 2min 35.372s (userspace) = 2min 53.573s.1904vm-test-run-amcheck-upgrade> server: (finished: waiting for unit supabase-db-init.service, in 175.33 seconds)1905vm-test-run-amcheck-upgrade> subtest: Preconditions1906vm-test-run-amcheck-upgrade> server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select rolsuper from pg_roles where rolname = 'postgres'"1907vm-test-run-amcheck-upgrade> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select rolsuper from pg_roles where rolname = 'postgres'", in 0.56 seconds)1908vm-test-run-amcheck-upgrade> server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select current_user"1909vm-test-run-amcheck-upgrade> server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select current_user", in 0.63 seconds)1910vm-test-run-amcheck-upgrade> (finished: subtest: Preconditions, in 1.19 seconds)1911vm-test-run-amcheck-upgrade> subtest: A non-superuser installs amcheck on PG 15, pinned to pg_catalog1912vm-test-run-amcheck-upgrade> server: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension amcheck"1913vm-test-run-amcheck-upgrade> server: (finished: must succeed: PGOPTIONS="-c role=postgres" psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "create extension amcheck", in 2.00 seconds)1914vm-test-run-amcheck-upgrade> server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'"1915vm-test-run-amcheck-upgrade> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select extversion, extnamespace::regnamespace from pg_extension where extname = 'amcheck'", in 0.55 seconds)1916vm-test-run-amcheck-upgrade> PG 15 amcheck: 1.3,pg_catalog1917vm-test-run-amcheck-upgrade> (finished: subtest: A non-superuser installs amcheck on PG 15, pinned to pg_catalog, in 2.55 seconds)1918vm-test-run-amcheck-upgrade> subtest: PG 15 grants reach postgres only1919vm-test-run-amcheck-upgrade> server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname"1920vm-test-run-amcheck-upgrade> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "select r.rolname, bool_and(has_function_privilege(r.rolname, p.oid, 'execute')), bool_or(has_function_privilege(r.rolname, p.oid, 'execute')) from pg_proc p join pg_depend d on d.objid = p.oid and d.deptype = 'e' join pg_extension e on e.oid = d.refobjid and e.extname = 'amcheck' cross join (values ('postgres'), ('anon'), ('authenticated'), ('service_role')) as r(rolname) group by r.rolname order by r.rolname", in 0.75 seconds)1921vm-test-run-amcheck-upgrade> (finished: subtest: PG 15 grants reach postgres only, in 0.75 seconds)1922vm-test-run-amcheck-upgrade> subtest: amcheck dropped before upgrade, mirroring EXTENSIONS_TO_DISABLE1923vm-test-run-amcheck-upgrade> server: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "drop extension if exists amcheck cascade"1924vm-test-run-amcheck-upgrade> server: (finished: must succeed: psql -U supabase_admin -d postgres -t -A -F, -v ON_ERROR_STOP=1 -c "drop extension if exists amcheck cascade", in 0.91 seconds)1925vm-test-run-amcheck-upgrade> (finished: subtest: amcheck dropped before upgrade, mirroring EXTENSIONS_TO_DISABLE, in 0.91 seconds)1926vm-test-run-amcheck-upgrade> subtest: switch to postgresql 171927vm-test-run-amcheck-upgrade> server # Checking switch inhibitors... done1928vm-test-run-amcheck-upgrade> server # stopping the following units: postgresql.service, supabase-db-init.service1929vm-test-run-amcheck-upgrade> server # [  189.088232] nixos[2101]: switching to system configuration /nix/store/p6hpg7fs71y8djdag53jwb1wiq2rsacw-nixos-system-server-test1930vm-test-run-amcheck-upgrade> server # [  189.119433] systemd[1]: Stopped target Local File Systems.1931vm-test-run-amcheck-upgrade> server # [  189.143914] systemd[1]: Stopped target Remote File Systems.1932vm-test-run-amcheck-upgrade> server # [  189.179282] systemd[1]: supabase-db-init.service: Deactivated successfully.1933vm-test-run-amcheck-upgrade> server # [  189.186525] systemd[1]: Stopped Supabase Database Initialization.1934vm-test-run-amcheck-upgrade> server # [  189.188148] systemd[1]: supabase-db-init.service: Consumed 8.690s CPU time, 3.5M memory peak, 89.3K incoming IP traffic, 120.7K outgoing IP traffic.1935vm-test-run-amcheck-upgrade> server # [  189.209892] systemd[1]: Stopping PostgreSQL Database Server...1936vm-test-run-amcheck-upgrade> server # [  189.232092] postgres[1380]:  2026-10-07 20:40:16.558 UTC [1380] LOG:  received fast shutdown request1937vm-test-run-amcheck-upgrade> server # [  189.242554] postgres[1380]:  2026-10-07 20:40:16.587 UTC [1380] LOG:  aborting any active transactions1938vm-test-run-amcheck-upgrade> server # [  189.262268] postgres[1441]:  2026-10-07 20:40:16.601 UTC [1441] LOG:  pg_cron scheduler shutting down1939vm-test-run-amcheck-upgrade> server # [  189.277890] postgres[1438]:  2026-10-07 20:40:16.611 UTC [1438] FATAL:  terminating background worker "TimescaleDB Background Worker Launcher" due to administrator command1940vm-test-run-amcheck-upgrade> server # [  189.389971] postgres[1380]:  2026-10-07 20:40:16.746 UTC [1380] LOG:  background worker "TimescaleDB Background Worker Launcher" (PID 1438) exited with exit code 11941vm-test-run-amcheck-upgrade> server # [  189.431289] postgres[1380]:  2026-10-07 20:40:16.796 UTC [1380] LOG:  background worker "logical replication launcher" (PID 1443) exited with exit code 11942vm-test-run-amcheck-upgrade> server # [  189.445418] postgres[1380]:  2026-10-07 20:40:16.807 UTC [1380] LOG:  background worker "pg_cron launcher" (PID 1441) exited with exit code 11943vm-test-run-amcheck-upgrade> server # [  189.494064] postgres[1380]:  2026-10-07 20:40:16.859 UTC [1380] LOG:  background worker "pg_net 0.20.4 worker" (PID 1463) exited with exit code 11944vm-test-run-amcheck-upgrade> server # [  189.504155] postgres[1425]:  2026-10-07 20:40:16.863 UTC [1425] LOG:  shutting down1945vm-test-run-amcheck-upgrade> server # [  189.514620] postgres[1425]:  2026-10-07 20:40:16.879 UTC [1425] LOG:  checkpoint starting: shutdown immediate1946vm-test-run-amcheck-upgrade> server # [  189.930827] postgres[1425]:  2026-10-07 20:40:17.296 UTC [1425] LOG:  checkpoint complete: wrote 267 buffers (1.6%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.111 s, sync=0.239 s, total=0.430 s; sync files=136, longest=0.022 s, average=0.002 s; distance=1943 kB, estimate=1943 kB1947vm-test-run-amcheck-upgrade> server # [  190.089737] postgres[1380]:  2026-10-07 20:40:17.447 UTC [1380] LOG:  database system is shut down1948vm-test-run-amcheck-upgrade> server # [  190.195280] systemd[1]: postgresql.service: Deactivated successfully.1949vm-test-run-amcheck-upgrade> server # [  190.205153] systemd[1]: Stopped PostgreSQL Database Server.1950vm-test-run-amcheck-upgrade> server # [  190.217815] systemd[1]: postgresql.service: Consumed 41.416s CPU time, 124.9M memory peak, 54.5M written to disk, 124.9K incoming IP traffic, 93.5K outgoing IP traffic.1951vm-test-run-amcheck-upgrade> server # activating the configuration...1952vm-test-run-amcheck-upgrade> server # setting up /etc...1953vm-test-run-amcheck-upgrade> server # [  198.545452] systemd[1]: Reload requested from client PID 2101 ('.switch-to-conf') (unit backdoor.service)...1954vm-test-run-amcheck-upgrade> server # [  198.548832] systemd[1]: Reloading...1955vm-test-run-amcheck-upgrade> server # [  204.834858] systemd[1]: Reloading finished in 6271 ms.