Machine state will be reset. To keep it, pass --keep-machine-state
start all VLans
(finished: start all VLans, in 0.01 seconds)
Test will time out and terminate in 3600 seconds
run the VM test script
additionally exposed symbols:
    server,
    vlan1,
    start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh
server: waiting for unit mobilizon.service
server: waiting for the VM to finish booting
server: starting vm
server: QEMU running (pid 12)
server # Disk image does not exist, creating the virtualisation disk image...
server # Formatting '/build/vm-state-server/tmp.H1GFDyepdU', fmt=raw size=1073741824
server # mke2fs 1.47.3 (8-Jul-2025)
server # Discarding device blocks:      0/262144             done
server # Creating filesystem with 262144 4k blocks and 65536 inodes
server # Filesystem UUID: cab1f084-f1d7-4dba-aad5-7b7d667a9901
server # Superblock backups stored on blocks:
server # 	32768, 98304, 163840, 229376
server # 
server # Allocating group tables: 0/8   done
server # Writing inode tables: 0/8   done
server # Creating journal (8192 blocks): done
server # Writing superblocks and filesystem accounting information: 0/8   done
server # 
server # Virtualisation disk image created.
server # qemu-system-aarch64: Could not access KVM kernel module: No such file or directory
server # qemu-system-aarch64: failed to initialize kvm: No such file or directory
server # qemu-system-aarch64: falling back to tcg
server # [    0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]
server # [    0.000000] Linux version 6.18.35 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP Tue Jun  9 10:28:53 UTC 2026
server # [    0.000000] KASLR enabled
server # [    0.000000] random: crng init done
server # [    0.000000] Machine model: linux,dummy-virt
server # [    0.000000] efi: UEFI not found.
server # [    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
server # [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000] NODE_DATA(0) allocated [mem 0x7fc06740-0x7fc09ebf]
server # [    0.000000] Zone ranges:
server # [    0.000000]   DMA      [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000]   DMA32    empty
server # [    0.000000]   Normal   empty
server # [    0.000000]   Device   empty
server # [    0.000000] Movable zone start for each node
server # [    0.000000] Early memory node ranges
server # [    0.000000]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]
server # [    0.000000] cma: Reserved 32 MiB at 0x000000007ca00000
server # [    0.000000] psci: probing for conduit method from DT.
server # [    0.000000] psci: PSCIv1.1 detected in firmware.
server # [    0.000000] psci: Using standard PSCI v0.2 function IDs
server # [    0.000000] psci: Trusted OS migration not required
server # [    0.000000] psci: SMC Calling Convention v1.0
server # [    0.000000] percpu: Embedded 76 pages/cpu s185688 r8192 d117416 u311296
server # [    0.000000] Detected PIPT I-cache on CPU0
server # [    0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)
server # [    0.000000] CPU features: detected: GICv3 CPU interface
server # [    0.000000] CPU features: detected: HCRX_EL2 register
server # [    0.000000] CPU features: detected: Stage-1 Permission Indirection Extension (S1PIE)
server # [    0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2)
server # [    0.000000] CPU features: detected: Spectre-v4
server # [    0.000000] alternatives: applying boot alternatives
server # [    0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/rzapljrzcw7dmdpsihfwgckkgfpsxyl6-nixos-system-server-test/init regInfo=/nix/store/dzv5r5x7r2aakvb7rx13jrjyb727xjy5-closure-info/registration console=ttyAMA0,115200n8 console=tty0
server # [    0.000000] Unknown kernel command line parameters "regInfo=/nix/store/dzv5r5x7r2aakvb7rx13jrjyb727xjy5-closure-info/registration", will be passed to user space.
server # [    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
server # [    0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
server # [    0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
server # [    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB
server # [    0.000000] software IO TLB: area num 1.
server # [    0.000000] software IO TLB: mapped [mem 0x000000007c732000-0x000000007c832000] (1MB)
server # [    0.000000] Fallback order for Node 0: 0
server # [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 262144
server # [    0.000000] Policy zone: DMA
server # [    0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
server # [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
server # [    0.000000] allocated 2097152 bytes of page_ext
server # [    0.000000] ftrace: allocating 74729 entries in 292 pages
server # [    0.000000] ftrace: allocated 292 pages with 3 groups
server # [    0.000000] rcu: Hierarchical RCU implementation.
server # [    0.000000] rcu: 	RCU event tracing is enabled.
server # [    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
server # [    0.000000] 	Rude variant of Tasks RCU enabled.
server # [    0.000000] 	Tracing variant of Tasks RCU enabled.
server # [    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
server # [    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
server # [    0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
server # [    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
server # [    0.000000] GICv3: 256 SPIs implemented
server # [    0.000000] GICv3: 0 Extended SPIs implemented
server # [    0.000000] Root IRQ handler: gic_handle_irq
server # [    0.000000] GICv3: GICv3 features: 16 PPIs
server # [    0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0
server # [    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
server # [    0.000000] ITS [mem 0x08080000-0x0809ffff]
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)
server # [    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)
server # [    0.000000] GICv3: using LPI property table @0x0000000044d00000
server # [    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000
server # [    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
server # [    0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).
server # [    0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
server # [    0.000091] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns
server # [    0.006638] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
server # [    0.035522] Console: colour dummy device 80x25
server # [    0.039298] printk: legacy console [tty0] enabled
server # [    0.052824] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)
server # [    0.053848] pid_max: default: 32768 minimum: 301
server # [    0.061719] LSM: initializing lsm=capability,landlock,yama,bpf,ima
server # [    0.064787] landlock: Up and running.
server # [    0.064925] Yama: becoming mindful.
server # [    0.067289] LSM support for eBPF active
server # [    0.073826] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
server # [    0.074083] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
server # [    0.149652] cacheinfo: Unable to detect cache hierarchy for CPU 0
server # [    0.181931] rcu: Hierarchical SRCU implementation.
server # [    0.182205] rcu: 	Max phase no-delay instances is 1000.
server # [    0.201128] fsl-mc MSI: its@8080000 domain created
server # [    0.205524] EFI services will not be available.
server # [    0.208624] smp: Bringing up secondary CPUs ...
server # [    0.210159] smp: Brought up 1 node, 1 CPU
server # [    0.210277] SMP: Total of 1 processors activated.
server # [    0.210372] CPU: All CPU(s) started at EL1
server # [    0.212040] CPU features: detected: Branch Target Identification
server # [    0.212254] CPU features: detected: 32-bit EL0 Support
server # [    0.212343] CPU features: detected: 32-bit EL1 Support
server # [    0.212406] CPU features: detected: ARMv8.4 Translation Table Level
server # [    0.212484] CPU features: detected: Instruction cache invalidation not required for I/D coherence
server # [    0.212577] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
server # [    0.212736] CPU features: detected: Common not Private translations
server # [    0.212804] CPU features: detected: CRC32 instructions
server # [    0.212860] CPU features: detected: Data cache clean to Point of Deep Persistence
server # [    0.212929] CPU features: detected: Data cache clean to Point of Persistence
server # [    0.212992] CPU features: detected: Data independent timing control (DIT)
server # [    0.213053] CPU features: detected: E0PD
server # [    0.213103] CPU features: detected: Enhanced Counter Virtualization
server # [    0.213189] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)
server # [    0.213258] CPU features: detected: Enhanced Privileged Access Never
server # [    0.213318] CPU features: detected: Enhanced Virtualization Traps
server # [    0.213390] CPU features: detected: Fine Grained Traps
server # [    0.213481] CPU features: detected: Guarded Control Stack (GCS)
server # [    0.213634] CPU features: detected: Generic authentication (IMP DEF algorithm)
server # [    0.213838] CPU features: detected: RCpc load-acquire (LDAPR)
server # [    0.213972] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)
server # [    0.214040] CPU features: detected: LSE atomic instructions
server # [    0.214097] CPU features: detected: Memory Copy and Memory Set instructions
server # [    0.214205] CPU features: detected: Privileged Access Never
server # [    0.214341] CPU features: detected: PMUv3
server # [    0.214402] CPU features: detected: SCTLR2
server # [    0.214453] CPU features: detected: RAS Extension Support
server # [    0.214556] CPU features: detected: RASv1p1 Extension Support
server # [    0.214615] CPU features: detected: Random Number Generator
server # [    0.214672] CPU features: detected: Speculation barrier (SB)
server # [    0.214729] CPU features: detected: Stage-2 Force Write-Back
server # [    0.214787] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality
server # [    0.214856] CPU features: detected: TLB range maintenance instructions
server # [    0.214917] CPU features: detected: WFx with timeout
server # [    0.215139] CPU features: detected: Scalable Matrix Extension
server # [    0.215423] CPU features: detected: FA64
server # [    0.215506] CPU features: detected: SME2
server # [    0.215568] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
server # [    0.215665] CPU features: detected: Scalable Vector Extension
server # [    0.241694] alternatives: applying system-wide alternatives
server # [    0.269364] CPU features: detected: Hardware dirty bit management on CPU0
server # [    0.270973] SVE: maximum available vector length 256 bytes per vector
server # [    0.271192] SVE: default vector length 64 bytes per vector
server # [    0.273832] SME: minimum available vector length 16 bytes per vector
server # [    0.273976] SME: maximum available vector length 256 bytes per vector
server # [    0.274062] SME: default vector length 32 bytes per vector
server # [    0.309620] Memory: 891048K/1048576K available (24576K kernel code, 7086K rwdata, 26312K rodata, 4864K init, 1102K bss, 116268K reserved, 32768K cma-reserved)
server # [    0.356301] devtmpfs: initialized
server # [    0.418687] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
server # [    0.420440] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    0.421043] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
server # [    0.428312] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
server # [    0.428482] 0 pages in range for non-PLT usage
server # [    0.428584] 508240 pages in range for PLT usage
server # [    0.435437] pinctrl core: initialized pinctrl subsystem
server # [    0.463311] DMI not present or invalid.
server # [    0.498883] NET: Registered PF_NETLINK/PF_ROUTE protocol family
server # [    0.525322] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
server # [    0.528810] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
server # [    0.532585] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
server # [    0.533433] audit: initializing netlink subsys (disabled)
server # [    0.538123] audit: type=2000 audit(0.452:1): state=initialized audit_enabled=0 res=1
server # [    0.554245] thermal_sys: Registered thermal governor 'fair_share'
server # [    0.554375] thermal_sys: Registered thermal governor 'bang_bang'
server # [    0.554496] thermal_sys: Registered thermal governor 'step_wise'
server # [    0.554564] thermal_sys: Registered thermal governor 'user_space'
server # [    0.554626] thermal_sys: Registered thermal governor 'power_allocator'
server # [    0.555774] cpuidle: using governor ladder
server # [    0.556189] cpuidle: using governor menu
server # [    0.560971] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
server # [    0.561896] ASID allocator initialised with 65536 entries
server # [    0.583056] Serial: AMBA PL011 UART driver
server # [    0.724716] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
server # [    0.730425] printk: console [ttyAMA0] enabled
server # [    0.892419] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
server # [    0.892745] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
server # [    0.892869] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
server # [    0.892963] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
server # [    0.893053] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
server # [    0.893141] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
server # [    0.893253] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
server # [    0.893337] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
server # [    0.948560] fbcon: Taking over console
server # [    0.953640] ACPI: Interpreter disabled.
server # [    0.995695] iommu: Default domain type: Translated
server # [    0.995978] iommu: DMA domain TLB invalidation policy: strict mode
server # [    1.003336] SCSI subsystem initialized
server # [    1.021592] usbcore: registered new interface driver usbfs
server # [    1.022970] usbcore: registered new interface driver hub
server # [    1.024263] usbcore: registered new device driver usb
server # [    1.035653] pps_core: LinuxPPS API ver. 1 registered
server # [    1.035962] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
server # [    1.044091] PTP clock support registered
server # [    1.045219] EDAC MC: Ver: 3.0.0
server # [    1.050174] scmi_core: SCMI protocol bus registered
server # [    1.069399] FPGA manager framework
server # [    1.116215] vgaarb: loaded
server # [    1.132197] clocksource: Switched to clocksource arch_sys_counter
server # [    1.160815] VFS: Disk quotas dquot_6.6.0
server # [    1.162022] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
server # [    1.167600] netfs: FS-Cache loaded
server # [    1.176429] pnp: PnP ACPI: disabled
server # [    1.319489] NET: Registered PF_INET protocol family
server # [    1.326562] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
server # [    1.611818] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
server # [    1.612542] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
server # [    1.614015] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
server # [    1.615683] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
server # [    1.616402] TCP: Hash tables configured (established 8192 bind 8192)
server # [    1.620842] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
server # [    1.622559] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)
server # [    1.624078] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)
server # [    1.628380] NET: Registered PF_UNIX/PF_LOCAL protocol family
server # [    1.630040] NET: Registered PF_XDP protocol family
server # [    1.631208] PCI: CLS 0 bytes, default 64
server # [    1.641627] Trying to unpack rootfs image as initramfs...
server # [    1.651484] kvm [1]: HYP mode not available
server # [    2.319364] Initialise system trusted keyrings
server # [    2.329366] workingset: timestamp_bits=42 max_order=18 bucket_order=0
server # [    2.354637] squashfs: version 4.0 (2009/01/31) Phillip Lougher
server # [    2.361748] 9p: Installing v9fs 9p2000 file system support
server # [    2.632785] Key type asymmetric registered
server # [    2.636747] Asymmetric key parser 'x509' registered
server # [    2.637807] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)
server # [    2.641083] io scheduler mq-deadline registered
server # [    2.641427] io scheduler kyber registered
server # [    2.816119] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
server # [    2.842723] ledtrig-cpu: registered to indicate activity on CPUs
server # [    2.861541] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
server # [    2.866090] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
server # [    2.874391] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
server # [    2.875929] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
server # [    2.878170] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
server # [    2.885336] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
server # [    2.890338] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
server # [    2.894849] pci_bus 0000:00: root bus resource [bus 00-ff]
server # [    2.896024] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
server # [    2.896887] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
server # [    2.897697] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
server # [    2.908539] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
server # [    2.931410] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    2.932500] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
server # [    2.932766] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    2.932965] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    2.933396] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    2.938304] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    2.938641] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
server # [    2.938767] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    2.938881] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    2.946243] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    2.946596] pci 0000:00:03.0: BAR 0 [io  0x0000-0x003f]
server # [    2.946720] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    2.946832] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    2.950516] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    2.950859] pci 0000:00:04.0: BAR 0 [io  0x0000-0x001f]
server # [    2.950981] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    2.951092] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    2.957256] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
server # [    2.957631] pci 0000:00:05.0: BAR 0 [io  0x0000-0x001f]
server # [    2.957755] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    2.957862] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    2.961393] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
server # [    2.961734] pci 0000:00:06.0: BAR 0 [io  0x0000-0x007f]
server # [    2.961856] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    2.961967] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    2.969512] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
server # [    2.969886] pci 0000:00:07.0: BAR 0 [io  0x0000-0x001f]
server # [    2.970013] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    2.970122] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    2.970250] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]
server # [    2.977664] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
server # [    2.978077] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    2.978359] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    2.981983] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
server # [    2.982362] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    2.982503] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    2.990077] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint
server # [    2.990600] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]
server # [    2.994108] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
server # [    2.994660] pci 0000:00:0b.0: BAR 0 [io  0x0000-0x003f]
server # [    2.994819] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    2.994932] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    3.001481] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
server # [    3.001856] pci 0000:00:0c.0: BAR 0 [io  0x0000-0x001f]
server # [    3.001979] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]
server # [    3.002092] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
server # [    3.018317] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
server # [    3.018898] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned
server # [    3.019243] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
server # [    3.019712] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
server # [    3.019976] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
server # [    3.020527] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned
server # [    3.020728] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
server # [    3.020882] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
server # [    3.021026] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned
server # [    3.021213] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned
server # [    3.021380] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned
server # [    3.021530] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned
server # [    3.021764] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned
server # [    3.021984] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned
server # [    3.022162] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned
server # [    3.022306] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned
server # [    3.022429] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned
server # [    3.022547] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned
server # [    3.022661] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned
server # [    3.022777] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned
server # [    3.022892] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned
server # [    3.023007] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned
server # [    3.023122] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned
server # [    3.023260] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned
server # [    3.023381] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned
server # [    3.023521] pci 0000:00:06.0: BAR 0 [io  0x1000-0x107f]: assigned
server # [    3.023786] pci 0000:00:03.0: BAR 0 [io  0x1080-0x10bf]: assigned
server # [    3.024200] pci 0000:00:0b.0: BAR 0 [io  0x10c0-0x10ff]: assigned
server # [    3.024345] pci 0000:00:01.0: BAR 0 [io  0x1100-0x111f]: assigned
server # [    3.024468] pci 0000:00:02.0: BAR 0 [io  0x1120-0x113f]: assigned
server # [    3.024587] pci 0000:00:04.0: BAR 0 [io  0x1140-0x115f]: assigned
server # [    3.024698] pci 0000:00:05.0: BAR 0 [io  0x1160-0x117f]: assigned
server # [    3.024809] pci 0000:00:07.0: BAR 0 [io  0x1180-0x119f]: assigned
server # [    3.025019] pci 0000:00:0c.0: BAR 0 [io  0x11a0-0x11bf]: assigned
server # [    3.025802] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
server # [    3.025978] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
server # [    3.026088] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
server # [    3.063658] pci 0000:00:0a.0: enabling device (0000 -> 0002)
server # [    3.461502] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
server # [    3.479360] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
server # [    3.488236] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
server # [    3.495168] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
server # [    3.503231] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)
server # [    3.518369] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)
server # [    3.522920] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)
server # [    3.536256] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)
server # [    3.541441] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)
server # [    3.551520] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)
server # [    3.558505] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)
server # [    3.669563] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
server # [    3.728113] msm_serial: driver initialized
server # [    3.731394] SuperH (H)SCI(F) driver initialized
server # [    3.738851] STM32 USART driver initialized
server # [    3.992364] loop: module loaded
server # [    3.994137] virtio_blk virtio5: 1/0/0 default/read/poll queues
server # [    4.014232] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
server # [    4.082492] megasas: 07.734.00.00-rc1
server # [    4.114485] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
server # [    4.124955] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    4.128911] Intel/Sharp Extended Query Table at 0x0031
server # [    4.134821] Using buffer write method
server # [    4.141050] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
server # [    4.147019] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
server # [    4.154690] Intel/Sharp Extended Query Table at 0x0031
server # [    4.158621] Using buffer write method
server # [    4.164550] Concatenating MTD devices:
server # [    4.164775] (0): "0.flash"
server # [    4.164890] (1): "0.flash"
server # [    4.164986] into device "0.flash"
server # [    5.460310] Freeing initrd memory: 25352K
server # [    5.713400] tun: Universal TUN/TAP device driver, 1.6
server # [    5.746416] thunder_xcv, ver 1.0
server # [    5.747663] thunder_bgx, ver 1.0
server # [    5.748860] nicpf, ver 1.0
server # [    5.758712] e1000: Intel(R) PRO/1000 Network Driver
server # [    5.758997] e1000: Copyright (c) 1999-2006 Intel Corporation.
server # [    5.760876] e1000e: Intel(R) PRO/1000 Network Driver
server # [    5.761116] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
server # [    5.762533] igb: Intel(R) Gigabit Ethernet Network Driver
server # [    5.762732] igb: Copyright (c) 2007-2014 Intel Corporation.
server # [    5.764399] igbvf: Intel(R) Gigabit Virtual Function Network Driver
server # [    5.764608] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
server # [    5.767698] sky2: driver version 1.30
server # [    5.795168] ehci-pci 0000:00:0a.0: EHCI Host Controller
server # [    5.800948] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1
server # [    5.807280] usbcore: registered new interface driver usb-storage
server # [    5.811723] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000
server # [    5.814720] usbcore: registered new interface driver usbserial_generic
server # [    5.816777] usbserial: USB Serial support registered for generic
server # [    5.828227] hv_vmbus: registering driver hyperv_keyboard
server # [    5.829308] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00
server # [    5.866312] hub 1-0:1.0: USB hub found
server # [    5.873997] rtc-pl031 9010000.pl031: registered as rtc0
server # [    5.876081] rtc-pl031 9010000.pl031: setting system clock to 2026-08-30T21:52:29 UTC (1788126749)
server # [    5.885772] hub 1-0:1.0: 6 ports detected
server # [    5.892111] i2c_dev: i2c /dev entries driver
server # [    5.943335] sdhci: Secure Digital Host Controller Interface driver
server # [    5.943724] sdhci: Copyright(c) Pierre Ossman
server # [    5.949754] Synopsys Designware Multimedia Card Interface Driver
server # [    5.956812] sdhci-pltfm: SDHCI platform and OF driver helper
server # [    5.980768] hid: raw HID events driver (C) Jiri Kosina
server # [    5.986687] usbcore: registered new interface driver usbhid
server # [    5.986940] usbhid: USB HID core driver
server # [    6.009377] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available
server # [    6.038764] drop_monitor: Initializing network drop monitor service
server # [    6.043216] NET: Registered PF_INET6 protocol family
server # [    6.062224] Segment Routing with IPv6
server # [    6.063368] In-situ OAM (IOAM) with IPv6
server # [    6.065363] NET: Registered PF_PACKET protocol family
server # [    6.068182] 9pnet: Installing 9P2000 support
server # [    6.079430] Key type dns_resolver registered
server # [    6.156874] usb 1-1: new high-speed USB device number 2 using ehci-pci
server # [    6.197829] registered taskstats version 1
server # [    6.204231] Loading compiled-in X.509 certificates
server # [    6.381983] 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/input0
server # [    6.401549] Demotion targets for Node 0: null
server # [    6.404910] Key type .fscrypt registered
server # [    6.405610] Key type fscrypt-provisioning registered
server # [    6.412942] ima: No TPM chip found, activating TPM-bypass!
server # [    6.413865] ima: Allocated hash algorithm: sha1
server # [    6.419268] ima: No architecture policies found
server # [    6.437510] input: gpio-keys as /devices/platform/gpio-keys/input/input1
server # [    6.461340] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0
server # [    6.576419] clk: Disabling unused clocks
server # [    6.577506] PM: genpd: Disabling unused power domains
server # [    6.600195] usb 1-2: new high-speed USB device number 3 using ehci-pci
server # [    7.211079] Freeing unused kernel memory: 4864K
server # [    7.216578] Run /init as init process
server # [    7.345040] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2
server # [    7.349279] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0
server # [    7.552179] systemd[1]: Successfully made /usr/ read-only.
server # [    7.928531] systemd[1]: systemd 260.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
server # [    7.931567] systemd[1]: Detected virtualization qemu.
server # [    7.933573] systemd[1]: Detected architecture arm64.
server # [    7.934810] systemd[1]: Running in initrd.
server # [    7.953841] systemd[1]: Initializing machine ID from random generator.
server # [    7.962913] systemd[1]: Hostname set to <server>.
server # [   10.072355] systemd[1]: Queued start job for default target Initrd Default Target.
server # [   11.767455] systemd[1]: Created slice Slice /system/modprobe.
server # [   11.781547] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [   11.785785] systemd[1]: Expecting device /dev/disk/by-label/nixos...
server # [   11.789395] systemd[1]: Reached target Path Units.
server # [   11.791351] systemd[1]: Reached target Slice Units.
server # [   11.793603] systemd[1]: Reached target Swaps.
server # [   11.795289] systemd[1]: Reached target Timer Units.
server # [   11.805717] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [   11.813637] systemd[1]: Listening on Journal Socket (/dev/log).
server # [   11.819550] systemd[1]: Listening on Journal Sockets.
server # [   11.825638] systemd[1]: Listening on udev Control Socket.
server # [   11.830014] systemd[1]: Listening on udev Kernel Socket.
server # [   11.832291] systemd[1]: Reached target Socket Units.
server # [   11.923461] systemd[1]: Starting Create List of Static Device Nodes...
server # [   12.045418] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [   12.054504] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [   12.246187] systemd[1]: Mounting Kernel Configuration File System...
server # [   12.681920] systemd[1]: Starting Journal Service...
server # [   12.838005] systemd[1]: Starting Load Kernel Modules...
server # [   12.845521] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
server # [   12.985644] systemd[1]: Starting Coldplug All udev Devices...
server # [   13.522563] systemd[1]: Finished Create List of Static Device Nodes.
server # [   13.681031] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [   13.815089] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [   14.093379] systemd[1]: Mounted Kernel Configuration File System.
server # [   14.257321] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
server # [   14.274105] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
server # [   14.353789] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [   14.564994] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0
server # [   14.567325] [drm] features: -virgl +edid -resource_blob -host_visible
server # [   14.567556] [drm] features: -context_init
server # [   14.593409] [drm] number of scanouts: 1
server # [   14.596459] [drm] number of cap sets: 0
server # [   14.656999] systemd-journald[131]: Collecting audit messages is disabled.
server # [   14.688266] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic
server # [   14.688620] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0
server # [   15.052761] Console: switching to colour frame buffer device 160x50
server # [   15.129243] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device
server # [   15.329431] systemd[1]: Finished Load Kernel Modules.
server # [   15.474824] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [   15.673908] systemd[1]: Starting Apply Kernel Variables...
server # [   15.953916] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [   16.830246] systemd[1]: Finished Apply Kernel Variables.
server # [   17.013232] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [   17.043132] systemd[1]: Reached target Preparation for Local File Systems.
server # [   17.050900] systemd[1]: Reached target Local File Systems.
server # [   17.242098] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [   19.678503] systemd[1]: Started Journal Service.
server # [   19.575274] systemd-modules-load[133]: Inserted module 'dm_mod'
server # [   19.665714] systemd-modules-load[133]: Module 'virtio_balloon' is built in
server # [   19.687255] systemd-modules-load[133]: Module 'virtio_console' is built in
server # [   19.714328] systemd-modules-load[133]: Inserted module 'virtio_gpu'
server # [   19.740958] systemd-modules-load[133]: Module 'virtio_rng' is built in
server # [   19.793391] systemd-udevd[154]: Using default interface naming scheme 'v260'.
server # [   19.831176] systemd[1]: Starting Create System Files and Directories...
server # [   20.773223] systemd[1]: Finished Create System Files and Directories.
server # [   21.090022] systemd[1]: Started Rule-based Manager for Device Events and Files.
server # [   22.913789] systemd[1]: Starting Virtual Console Setup...
server # [   24.582963] systemd-vconsole-setup[179]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [   24.753331] systemd[1]: Finished Virtual Console Setup.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [   45.185942] systemd[1]: Finished Coldplug All udev Devices.
server # [   45.206038] systemd[1]: Reached target System Initialization.
server # [   45.217792] systemd[1]: Reached target Basic System.
server # [   55.385578] (udev-worker)[211]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [   55.407394] (udev-worker)[211]: Network interface NamePolicy= disabled on kernel command line.
server # [   55.455513] (udev-worker)[210]: Network interface NamePolicy= disabled on kernel command line.
server # [   57.567393] systemd[1]: Found device /dev/disk/by-label/nixos.
server # [   57.582672] systemd[1]: Reached target Initrd Root Device.
server # [   57.671121] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
server # [   58.613104] systemd-fsck[234]: nixos: clean, 12/65536 files, 13019/262144 blocks
server # [   58.803330] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
server # [   58.935021] systemd[1]: Mounting /sysroot...
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [   59.597583] EXT4-fs (vda): mounted filesystem cab1f084-f1d7-4dba-aad5-7b7d667a9901 r/w with ordered data mode. Quota mode: none.
server # [   59.609308] systemd[1]: Mounted /sysroot.
server # [   59.654669] systemd[1]: Reached target Initrd Root File System.
server # [   59.904770] systemd[1]: Mounting /sysroot/nix/.ro-store...
server # [   60.109216] systemd[1]: Mounting /sysroot/nix/.rw-store...
server # [   60.415022] systemd[1]: Mounting /sysroot/run...
server # [   60.715349] systemd[1]: Mounting /sysroot/tmp/shared...
server # [   60.954510] systemd[1]: Mounting /sysroot/tmp/xchg...
server # [   61.119244] systemd[1]: Starting Mountpoints Configured in the Real Root...
server # [   61.882937] systemd-sysroot-fstab-check[255]: /sysroot should be mounted in the initrd, will request daemon-reload.
server # [   61.899170] systemd[1]: Mounted /sysroot/nix/.ro-store.
server # [   61.913688] systemd[1]: Mounted /sysroot/nix/.rw-store.
server # [   61.921636] systemd[1]: Mounted /sysroot/run.
server # [   61.931671] systemd[1]: Mounted /sysroot/tmp/shared.
server # [   61.959669] systemd[1]: Mounted /sysroot/tmp/xchg.
server # [   62.091300] systemd[1]: Reload requested from client PID 255 ('systemd-sysroot') (unit initrd-parse-etc.service)...
server # [   62.101648] systemd[1]: Reloading...
server # [   68.649017] systemd[1]: Reloading finished in 6517 ms.
server # [   69.299594] systemd-sysroot-fstab-check[255]: Requesting initrd-fs.target/start/replace...
server # [   70.963708] systemd-sysroot-fstab-check[255]: Requesting swap.target/start/replace...
server # [   71.059276] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [   71.082077] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
server # [   71.155990] systemd[1]: Finished Mountpoints Configured in the Real Root.
server # [   71.163860] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
server # [   71.434574] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [   71.474748] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   71.624906] systemd[1]: Mounting /sysroot/nix/store...
server # [   72.459805] systemd[1]: Mounted /sysroot/nix/store.
server # [   72.485213] systemd[1]: Reached target Initrd File Systems.
server # [   72.611097] systemd[1]: Starting Find NixOS closure...
server # [   72.801399] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
server # [   73.723727] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
server # [   73.773445] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.
server # [   74.078978] systemd[1]: Finished Find NixOS closure.
server # [   74.113643] systemd[1]: Reached target Initrd Default Target.
server # [   74.189691] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
server # [   74.911328] systemd[1]: Stopped target Initrd Default Target.
server # [   74.925800] systemd[1]: Stopped target Basic System.
server # [   74.935071] systemd[1]: Stopped target Initrd Root Device.
server # [   74.945945] systemd[1]: Stopped target Path Units.
server # [   74.959888] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
server # [   74.995801] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
server # [   75.020921] systemd[1]: Stopped target Slice Units.
server # [   75.034925] systemd[1]: Stopped target Socket Units.
server # [   75.053980] systemd[1]: Stopped target System Initialization.
server # [   75.065664] systemd[1]: Stopped target Swaps.
server # [   75.085464] systemd[1]: Stopped target Timer Units.
server # [   75.098168] systemd[1]: dbus.socket: Deactivated successfully.
server # [   75.113165] systemd[1]: Closed D-Bus System Message Bus Socket.
server # [   75.253384] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
server # [   75.269909] systemd[1]: Stopped Find NixOS closure.
server # [   75.545654] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [   75.760959] systemd[1]: Starting rw-sysroot-nix-store.service...
server # [   75.771173] systemd[1]: systemd-sysctl.service: Deactivated successfully.
server # [   75.793130] systemd[1]: Stopped Apply Kernel Variables.
server # [   76.080038] systemd[1]: systemd-modules-load.service: Deactivated successfully.
server # [   76.102805] systemd[1]: Stopped Load Kernel Modules.
server # [   76.351923] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
server # [   76.370793] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
server # [   76.529376] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
server # [   76.545111] systemd[1]: Stopped Create System Files and Directories.
server # [   76.694397] systemd[1]: Stopped target Local File Systems.
server # [   76.706687] systemd[1]: Stopped target Preparation for Local File Systems.
server # [   76.718542] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
server # [   76.731778] systemd[1]: Stopped Coldplug All udev Devices.
server # [   76.751574] systemd[1]: systemd-udev-trigger.service: Consumed 16.581s CPU time over 1min 3.872s wall clock time, 9.2M memory peak.
server # [   76.873069] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
server # [   76.877753] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [   76.886745] systemd[1]: Stopped Virtual Console Setup.
server # [   77.087248] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [   77.118913] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [   77.214117] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
server # [   77.257773] systemd[1]: Finished rw-sysroot-nix-store.service.
server # [   77.437741] systemd[1]: initrd-cleanup.service: Deactivated successfully.
server # [   77.474010] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
server # [   78.386744] systemd[1]: systemd-udevd.service: Deactivated successfully.
server # [   78.425396] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
server # [   78.437644] systemd[1]: systemd-udevd.service: Consumed 20.575s CPU time over 1min 1.260s wall clock time, 19.5M memory peak.
server # [   78.507186] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
server # [   78.517288] systemd[1]: Closed udev Control Socket.
server # [   78.638060] systemd[1]: Starting Cleanup udev Database...
server # [   78.647044] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
server # [   78.654458] systemd[1]: Stopped Create Static Device Nodes in /dev.
server # [   78.770079] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
server # [   78.776825] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
server # [   78.913184] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
server # [   78.918359] systemd[1]: Stopped Create List of Static Device Nodes.
server # [   79.231421] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
server # [   79.275906] systemd[1]: Finished Cleanup udev Database.
server # [   79.349972] systemd[1]: Reached target Switch Root.
server # [   79.423280] systemd[1]: Starting NixOS Activation...
server # [   82.175105] initrd-nixos-activation-start[558]: booting system configuration /nix/store/rzapljrzcw7dmdpsihfwgckkgfpsxyl6-nixos-system-server-test
server # [   83.270969] initrd-nixos-activation-start[558]: running activation script...
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [   91.107584] initrd-nixos-activation-start[583]: setting up /etc...
server # [   95.427347] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
server # [   95.464029] systemd[1]: Finished NixOS Activation.
server # [   95.474436] systemd[1]: initrd-nixos-activation.service: Consumed 9.032s CPU time over 16.008s wall clock time, 22.5M memory peak.
server # [   95.597050] systemd[1]: Starting Switch Root...
server # [   95.876873] systemd[1]: Switching root.
server # [  100.411033] systemd-journald[131]: Received SIGTERM from PID 1 (systemd).
server # [  103.931420] systemd[1]: systemd 260.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
server # [  103.937952] systemd[1]: Detected virtualization qemu.
server # [  103.942219] systemd[1]: Detected architecture arm64.
server # [  103.947379] systemd[1]: Detected first boot.
server # [  104.008226] systemd[1]: Initializing machine ID from random generator.
server # [  107.590505] systemd[1]: bpf-restrict-fs: LSM BPF program attached
server # [  110.571053] systemd[1]: Applying preset policy.
server # [  118.501767] systemd[1]: Populated /etc with preset unit settings.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  126.868844] systemd[1]: initrd-switch-root.service: Deactivated successfully.
server # [  126.881420] systemd[1]: Stopped initrd-switch-root.service.
server # [  126.946506] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
server # [  126.985855] systemd[1]: Created slice Slice /system/getty.
server # [  127.015329] systemd[1]: Created slice User and Session Slice.
server # [  127.029056] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
server # [  127.039007] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
server # [  127.048503] systemd[1]: Expecting device /dev/hvc0...
server # [  127.055592] systemd[1]: Expecting device /dev/ttyAMA0...
server # [  127.067593] systemd[1]: Reached target Local Encrypted Volumes.
server # [  127.076596] systemd[1]: Stopped target initrd-fs.target.
server # [  127.084610] systemd[1]: Stopped target initrd-root-fs.target.
server # [  127.092445] systemd[1]: Stopped target initrd-switch-root.target.
server # [  127.100446] systemd[1]: Reached target Virtual Machines and Containers.
server # [  127.108875] systemd[1]: Reached target Path Units.
server # [  127.116808] systemd[1]: Reached target Remote File Systems.
server # [  127.127118] systemd[1]: Reached target Slice Units.
server # [  127.135143] systemd[1]: Reached target Swaps.
server # [  127.197615] systemd[1]: Listening on Process Core Dump Socket.
server # [  127.248935] systemd[1]: Listening on Credential Encryption/Decryption.
server # [  127.333438] systemd[1]: Starting Journal Log Access Socket...
server # [  127.390005] systemd[1]: Listening on Journal Audit Socket.
server # [  127.413288] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
server # [  127.423025] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
server # [  127.435081] systemd[1]: Listening on udev Control Socket.
server # [  127.511472] systemd[1]: Mounting Huge Pages File System...
server # [  127.632791] systemd[1]: Mounting POSIX Message Queue File System...
server # [  127.806866] systemd[1]: Mounting Kernel Debug File System...
server # [  128.030748] systemd[1]: Mounting Kernel Trace File System...
server # [  128.318591] systemd[1]: Starting Create List of Static Device Nodes...
server # [  128.673950] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
server # [  128.724638] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server # [  129.060030] systemd[1]: Mounting Kernel Configuration File System...
server # [  129.110944] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
server # [  129.209294] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
server # [  130.025111] systemd[1]: Starting Load Kernel Module fuse...
server # [  130.165818] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
server # [  130.580683] systemd[1]: Starting Journal Service...
server # [  130.973903] systemd[1]: Starting Load Kernel Modules...
server # [  131.725071] fuse: init (API version 7.45)
server # [  131.735655] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
server # [  132.010451] systemd[1]: Starting Remount Root and Kernel File Systems...
server # [  132.066852] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
server # [  132.572853] systemd[1]: Starting Coldplug All udev Devices...
server # [  133.442311] systemd-journald[792]: Collecting audit messages is enabled.
server # [  133.593811] systemd[1]: Listening on Journal Log Access Socket.
server # [  133.691306] systemd[1]: Mounted Huge Pages File System.
server # [  133.771423] systemd[1]: Mounted POSIX Message Queue File System.
server # [  133.834697] systemd[1]: Mounted Kernel Debug File System.
server # [  133.906162] systemd[1]: Mounted Kernel Trace File System.
server # [  134.003289] systemd[1]: Finished Create List of Static Device Nodes.
server # [  134.090754] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
server # [  134.185419] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
server # [  134.263311] systemd[1]: Mounted Kernel Configuration File System.
server # [  134.366746] systemd[1]: modprobe@fuse.service: Deactivated successfully.
server # [  134.457629] systemd[1]: Finished Load Kernel Module fuse.
server # [  134.339051] systemd[1]: Queued start job for default target Multi-User System.
server # [  134.541476] EXT4-fs (vda): re-mounted cab1f084-f1d7-4dba-aad5-7b7d667a9901.
server # [  134.549907] systemd[1]: Started Journal Service.
server # [  134.458257] systemd[1]: systemd-journald.service: Deactivated successfully.
server # [  134.570698] systemd[1]: systemd-journald.service: Consumed 2.572s CPU time over 1min 54.032s wall clock time, 3.9M memory peak.
server # [  134.658720] systemd-modules-load[793]: Module 'atkbd' is built in
server # [  134.690130] systemd-modules-load[793]: Module 'loop' is built in
server # [  134.730379] systemd-modules-load[793]: Inserted module 'tls'
server # [  134.793210] systemd[1]: Finished Load Kernel Modules.
server # [  134.884039] systemd[1]: Finished Remount Root and Kernel File Systems.
server # [  135.691539] systemd[1]: Mounting FUSE Control File System...
server # [  135.967159] systemd[1]: Starting Firewall...
server # [  136.341354] systemd[1]: Starting Flush Journal to Persistent Storage...
server # [  136.367060] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
server # [  136.947805] systemd[1]: Starting Load/Save OS Random Seed...
server # [  137.042141] systemd-oomd[794]: No swap; memory pressure usage will be degraded
server # [  137.524973] systemd[1]: Starting Apply Kernel Variables...
server # [  138.370592] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
server # [  138.430959] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
server # [  139.078321] systemd-journald[792]: Received client request to flush runtime journal.
server # [  141.577760] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
server # [  141.667457] systemd[1]: Mounted FUSE Control File System.
server # [  141.743718] systemd[1]: Finished Load/Save OS Random Seed.
server # [  141.837887] systemd[1]: Reached target First Boot Complete.
server # [  141.883728] systemd[1]: Finished Flush Journal to Persistent Storage.
server # [  142.561704] systemd[1]: Finished Apply Kernel Variables.
server # [  143.698770] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
server # [  143.926003] systemd[1]: Starting Create Static Device Nodes in /dev...
server # [  146.258057] systemd[1]: Finished Create Static Device Nodes in /dev.
server # [  146.349166] systemd[1]: Reached target Preparation for Local File Systems.
server # [  146.489468] systemd[1]: Mounting /run/wrappers...
server # [  146.793914] systemd[1]: Starting Rule-based Manager for Device Events and Files...
server # [  148.419152] systemd[1]: Mounted /run/wrappers.
server # [  148.467224] systemd[1]: Reached target Local File Systems.
server # [  148.630127] systemd[1]: Listening on Boot Loader Control Service Socket.
server # [  148.837804] systemd[1]: Starting register-nix-paths.service...
server # [  149.176999] systemd[1]: Starting Create SUID/SGID Wrappers...
server # [  149.233118] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  149.955038] systemd[1]: Starting Save Transient machine-id to Disk...
server # [  150.609214] systemd[1]: Starting Create System Files and Directories...
server # [  154.001653] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
server # [  154.085435] systemd[1]: Finished Save Transient machine-id to Disk.
server # [  159.455537] systemd[1]: Finished Create System Files and Directories.
server # [  160.093311] systemd[1]: Starting Rebuild Journal Catalog...
server # [  160.765968] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
server # [  164.575447] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
server # [  168.463532] systemd[1]: Finished Rebuild Journal Catalog.
server # [  168.848892] systemd[1]: Starting Update is Completed...
server # [  171.319500] systemd[1]: Finished Update is Completed.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  179.381496] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
server # [  179.437980] systemd[1]: Finished Create SUID/SGID Wrappers.
server # [  179.465366] systemd[1]: suid-sgid-wrappers.service: Consumed 3.776s CPU time over 30.196s wall clock time, 5.2M memory peak.
server # [  183.435207] systemd[1]: Finished Firewall.
server # [  186.935890] systemd-udevd[849]: Using default interface naming scheme 'v260'.
server # [  188.365171] systemd[1]: Finished register-nix-paths.service.
server # [  190.137865] systemd[1]: Started Rule-based Manager for Device Events and Files.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  209.899104] systemd[1]: Finished Coldplug All udev Devices.
server # [  209.921792] systemd[1]: Reached target System Initialization.
server # [  209.953041] systemd[1]: Started Discard unused filesystem blocks once a week.
server # [  209.964683] systemd[1]: Started Daily Cleanup of Temporary Directories.
server # [  209.987076] systemd[1]: Reached target Timer Units.
server # [  209.994710] systemd[1]: Listening on D-Bus System Message Bus Socket.
server # [  210.013844] systemd[1]: Listening on Nix Daemon Socket.
server # [  210.026675] systemd[1]: Listening on Hostname Service Socket.
server # [  210.038422] systemd[1]: Reached target Socket Units.
server # [  210.047169] systemd[1]: Reached target Basic System.
server # [  210.125805] systemd[1]: Starting Import lastlog data into lastlog2 database...
server # [  210.325104] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [  210.569168] systemd[1]: Starting Post-Boot Actions...
server # [  211.001373] systemd[1]: Started Reset console on configuration changes.
server # [  211.637087] systemd[1]: Starting resolvconf update...
server # [  213.591986] systemd[1]: Starting D-Bus System Message Bus...
server # [  213.683486] nsncd[1037]: Aug 30 21:55:57.315 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [  213.711578] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [  213.946367] systemd[1]: Finished Post-Boot Actions.
server # [  214.694510] systemd[1]: Finished Import lastlog data into lastlog2 database.
server # [  214.715858] systemd[1]: Reached target Host and Network Name Lookups.
server # [  214.738909] systemd[1]: Reached target User and Group Name Lookups.
server # [  215.256988] systemd[1]: Starting User Login Management...
server # [  218.022009] dbus-broker-launch[1045]: Looking up NSS user entry for 'systemd-timesync'...
server # [  218.519355] dbus-broker-launch[1045]: NSS returned no entry for 'systemd-timesync'
server # [  218.543202] dbus-broker-launch[1045]: Invalid user-name in /nix/store/58p5ppvra2m02zkqr4jllpvcas9cspab-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
server # [  219.297920] systemd[1]: Started D-Bus System Message Bus.
server # [  220.781467] systemd-logind[1059]: New seat seat0.
server # [  220.913317] dbus-broker-launch[1045]: Ready
server # [  221.039186] systemd[1]: Started User Login Management.
server # [  221.379871] systemd[1]: Stopped target Host and Network Name Lookups.
server # [  221.399595] systemd[1]: Stopping Host and Network Name Lookups...
server # [  221.418499] systemd[1]: Stopped target User and Group Name Lookups.
server # [  221.430604] systemd[1]: Stopping User and Group Name Lookups...
server # [  221.558445] systemd[1]: Starting linger-users.service...
server # [  221.658729] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
server # [  221.869264] systemd[1]: nscd.service: Deactivated successfully.
server # [  221.954763] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
server # [  222.827499] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
server # [  223.621181] systemd[1]: linger-users.service: Deactivated successfully.
server # [  223.686084] systemd[1]: Finished linger-users.service.
server # [  224.073876] systemd[1]: Finished resolvconf update.
server # [  224.117763] systemd[1]: Reached target Preparation for Network.
server # [  224.412772] systemd[1]: Starting DHCP Client...
server # [  224.634501] nsncd[1110]: Aug 30 21:56:08.358 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
server # [  224.677109] systemd[1]: Starting Extra networking commands....
server # [  224.783179] systemd[1]: Started Name Service Cache Daemon (nsncd).
server # [  224.877246] systemd[1]: Reached target Host and Network Name Lookups.
server # [  224.912663] systemd[1]: Reached target User and Group Name Lookups.
server # [  229.747419] systemd-logind[1059]: Watching system buttons on /dev/input/event1 (gpio-keys)
server # [  230.477785] systemd[1]: Finished Extra networking commands..
server # [  230.530254] systemd[1]: Reached target Network.
server # [  230.814805] systemd[1]: Starting Nginx Web Server...
server # [  230.906302] dhcpcd[1138]: dhcpcd-10.3.2 starting
server # [  231.199242] dhcpcd[1186]: dev: loaded udev
server # [  231.357297] dhcpcd[1186]: no valid interfaces found
server # [  231.369348] systemd[1]: Starting PostgreSQL Server...
server # [  231.377473] dhcpcd[1186]: no valid interfaces found
server # [  231.549992] systemd[1]: Starting Permit User Sessions...
server # [  233.323724] systemd[1]: Finished Permit User Sessions.
server # [  233.649945] systemd[1]: Started Getty on tty1.
server # [  233.775884] systemd[1]: Reached target Login Prompts.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  240.659507] nginx-pre-start[1197]: nginx: the configuration file /nix/store/z7891f9bxfhn8yrz9yaks370dkhgxbyb-nginx.conf syntax is ok
server # [  240.819628] nginx-pre-start[1197]: nginx: configuration file /nix/store/z7891f9bxfhn8yrz9yaks370dkhgxbyb-nginx.conf test is successful
server # [  241.395736] systemd[1]: Started Nginx Web Server.
server # [  241.513645] postgresql-pre-start[1199]: The files belonging to this database system will be owned by user "postgres".
server # [  241.531321] postgresql-pre-start[1199]: This user must also own the server process.
server # [  241.739712] postgresql-pre-start[1199]: The database cluster will be initialized with locale "en_US.UTF-8".
server # [  241.769163] postgresql-pre-start[1199]: The default database encoding has accordingly been set to "UTF8".
server # [  241.785307] postgresql-pre-start[1199]: The default text search configuration will be set to "english".
server # [  241.797576] postgresql-pre-start[1199]: Data page checksums are disabled.
server # [  241.814375] postgresql-pre-start[1199]: fixing permissions on existing directory /var/lib/postgresql/17 ... ok
server # [  241.940851] postgresql-pre-start[1199]: creating subdirectories ... ok
server # [  241.981573] postgresql-pre-start[1199]: selecting dynamic shared memory implementation ... posix
server # [  245.287716] postgresql-pre-start[1199]: selecting default "max_connections" ... 100
server # [  247.518849] postgresql-pre-start[1199]: selecting default "shared_buffers" ... 128MB
server # [  261.447393] dhcpcd[1186]: timed out
server # [  261.493736] dhcpcd[1186]: timed out
server # [  261.595430] systemd[1]: Started DHCP Client.
server # [  265.527156] mousedev: PS/2 mouse device common for all mice
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  276.623350] systemd-logind[1059]: Watching system buttons on /dev/input/event0 (QEMU QEMU USB Keyboard)
server # [  290.783987] postgresql-pre-start[1199]: selecting default time zone ... UTC
server # [  290.882922] postgresql-pre-start[1199]: creating configuration files ... ok
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  304.890736] postgresql-pre-start[1199]: running bootstrap script ... ok
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  342.662525] postgresql-pre-start[1199]: performing post-bootstrap initialization ... ok
server # [  348.611219] postgresql-pre-start[1199]: syncing data to disk ... ok
server # [  348.633706] postgresql-pre-start[1199]: initdb: warning: enabling "trust" authentication for local connections
server # [  348.647986] postgresql-pre-start[1199]: initdb: hint: You can change this by editing pg_hba.conf or using the option -A, or --auth-local and --auth-host, the next time you run initdb.
server # [  348.662262] postgresql-pre-start[1199]: Success. You can now start the database server using:
server # [  348.681429] postgresql-pre-start[1199]:     pg_ctl -D /var/lib/postgresql/17 -l logfile start
server # [  352.530938] postgres[1359]: [1359] LOG:  starting PostgreSQL 17.10 on aarch64-unknown-linux-gnu, compiled by clang version 21.1.8, 64-bit
server # [  352.753184] postgres[1359]: [1359] LOG:  listening on IPv6 address "::1", port 5432
server # [  352.769410] postgres[1359]: [1359] LOG:  listening on IPv4 address "127.0.0.1", port 5432
server # [  352.799421] postgres[1359]: [1359] LOG:  listening on Unix socket "/run/postgresql/.s.PGSQL.5432"
server # [  353.106289] postgres[1375]: [1375] LOG:  database system was shut down at 2026-08-30 21:58:06 GMT
server # [  353.392909] postgres[1359]: [1359] LOG:  database system is ready to accept connections
server # [  353.565028] systemd[1]: Started PostgreSQL Server.
server # [  353.701431] systemd[1]: Starting PostgreSQL Setup Scripts...
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  361.427161] postgresql-setup-start[1386]: CREATE DATABASE
server # [  363.120533] postgresql-setup-start[1401]: CREATE ROLE
server # [  363.315127] systemd[1]: Finished PostgreSQL Setup Scripts.
server # [  363.351177] systemd[1]: Reached target PostgreSQL.
server # [  363.463898] systemd[1]: Starting Mobilizon PostgreSQL setup...
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  399.142643] mobilizon-postgresql-start[1405]: CREATE EXTENSION
server # [  399.178049] mobilizon-postgresql-start[1405]: CREATE EXTENSION
server # [  399.201352] mobilizon-postgresql-start[1405]: CREATE EXTENSION
server # [  400.031042] mobilizon-postgresql-start[1467]: ALTER DATABASE
server # [  400.150365] systemd[1]: mobilizon-postgresql.service: Deactivated successfully.
server # [  400.159226] systemd[1]: Finished Mobilizon PostgreSQL setup.
server # [  400.266835] systemd[1]: Starting Mobilizon setup secrets...
server # [  401.331496] mobilizon-setup-secrets-start[1470]: + '[' '!' -f /var/lib/mobilizon/secret-env.sh ']'
server # [  401.351438] mobilizon-setup-secrets-start[1470]: + install -m 600 /dev/null /var/lib/mobilizon/secret-env.sh
server # [  401.484669] mobilizon-setup-secrets-start[1470]: + cat
server # [  401.582865] mobilizon-setup-secrets-start[1474]: ++ /nix/store/l8rv77qmqmcq0yzw5qw2w5n0y099x0ih-elixir-1.18.4/bin/elixir --eval 'IO.puts(:crypto.strong_rand_bytes(64)|> Base.encode64()|> binary_part(0, 64))'
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  426.961552] systemd[1]: dev-hvc0.device: Job dev-hvc0.device/start timed out.
server # [  426.975182] systemd[1]: Timed out waiting for device /dev/hvc0.
server # [  426.998960] systemd[1]: Dependency failed for backdoor.service.
server # [  427.014797] systemd[1]: backdoor.service: Job backdoor.service/start failed with result 'dependency'.
server # [  427.031009] systemd[1]: dev-hvc0.device: Job dev-hvc0.device/start failed with result 'timeout'.
server # [  427.050698] systemd[1]: Unnecessary job was removed for /dev/ttyAMA0.
server # [  439.815779] mobilizon-setup-secrets-start[1571]: ++ /nix/store/l8rv77qmqmcq0yzw5qw2w5n0y099x0ih-elixir-1.18.4/bin/elixir --eval 'IO.puts(:crypto.strong_rand_bytes(64)|> Base.encode64()|> binary_part(0, 64))'
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  475.377826] mobilizon-setup-secrets-start[1657]: ++ /nix/store/l8rv77qmqmcq0yzw5qw2w5n0y099x0ih-elixir-1.18.4/bin/elixir --eval 'IO.puts(Base.encode32(:crypto.strong_rand_bytes(32)))'
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  510.431157] systemd[1]: mobilizon-setup-secrets.service: Deactivated successfully.
server # [  510.450170] systemd[1]: Finished Mobilizon setup secrets.
server # [  510.466548] systemd[1]: mobilizon-setup-secrets.service: Consumed 42.252s CPU time over 1min 50.153s wall clock time, 63.4M memory peak, 4K written to disk.
server # [  510.609409] systemd[1]: Starting Mobilizon federated organization and mobilization platform...
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  569.543743] mobilizon_ctl[1749]: Loading app..
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  569.839825] mobilizon_ctl[1749]: Starting dependencies..
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  653.179205] postgres[1373]: [1373] LOG:  checkpoint starting: time
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  748.793307] mobilizon_ctl[1749]:     #########################################################
server # [  748.838695] mobilizon_ctl[1749]:     # If the CREATE EXTENSION or DROP EXTENSION calls fail, #
server # [  748.854558] mobilizon_ctl[1749]:     # please manually execute them with an authorized       #
server # [  748.869959] mobilizon_ctl[1749]:     # PostgreSQL user with SUPER USER role.                 #
server # [  748.884718] mobilizon_ctl[1749]:     #########################################################
server # [  748.897106] mobilizon_ctl[1749]:
server # [  748.906745] mobilizon_ctl[1749]:
server # [  748.918320] mobilizon_ctl[1749]: 22:04:52.294 [info] == Running 20180109150000 Mobilizon.Repo.Migrations.Prerequites.up/0 forward
server # [  748.970163] mobilizon_ctl[1749]: 22:04:52.684 [info] execute "CREATE TYPE datetimetz AS (\n    dt timestamptz,\n    tz varchar\n);\n"
server # [  749.051190] mobilizon_ctl[1749]: 22:04:52.774 [info] execute "CREATE EXTENSION IF NOT EXISTS postgis"
server # [  749.091610] mobilizon_ctl[1749]: 22:04:52.819 [info] extension "postgis" already exists, skipping
server # [  749.129268] mobilizon_ctl[1749]: 22:04:52.820 [info] execute "CREATE EXTENSION IF NOT EXISTS pg_trgm"
server # [  749.147866] mobilizon_ctl[1749]: 22:04:52.851 [info] extension "pg_trgm" already exists, skipping
server # [  749.162708] mobilizon_ctl[1749]: 22:04:52.851 [info] execute "CREATE EXTENSION IF NOT EXISTS unaccent"
server # [  749.179180] mobilizon_ctl[1749]: 22:04:52.911 [info] extension "unaccent" already exists, skipping
server # [  749.298616] mobilizon_ctl[1749]: 22:04:53.016 [info] == Migrated 20180109150000 in 0.4s
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  751.323461] mobilizon_ctl[1749]: 22:04:55.024 [info] == Running 20180109165738 Mobilizon.Repo.Migrations.CreateAccounts.change/0 forward
server # [  751.358452] mobilizon_ctl[1749]: 22:04:55.082 [info] create table accounts
server # [  751.601881] mobilizon_ctl[1749]: 22:04:55.323 [info] create index accounts_username_domain_index
server # [  751.676903] mobilizon_ctl[1749]: 22:04:55.402 [info] == Migrated 20180109165738 in 0.3s
server # [  751.772931] mobilizon_ctl[1749]: 22:04:55.508 [info] == Running 20180109170315 Mobilizon.Repo.Migrations.CreateUsers.change/0 forward
server # [  751.809043] mobilizon_ctl[1749]: 22:04:55.535 [info] create table users
server # [  752.094538] mobilizon_ctl[1749]: 22:04:55.827 [info] create index users_email_index
server # [  752.161123] mobilizon_ctl[1749]: 22:04:55.886 [info] == Migrated 20180109170315 in 0.3s
server # [  752.260924] mobilizon_ctl[1749]: 22:04:55.996 [info] == Running 20180110091747 Mobilizon.Repo.Migrations.CreateCategories.change/0 forward
server # [  752.291562] mobilizon_ctl[1749]: 22:04:56.020 [info] create table categories
server # [  752.489401] mobilizon_ctl[1749]: 22:04:56.171 [info] create index categories_title_index
server # [  752.533133] mobilizon_ctl[1749]: 22:04:56.247 [info] == Migrated 20180110091747 in 0.2s
server # [  752.621900] mobilizon_ctl[1749]: 22:04:56.360 [info] == Running 20180110092400 Mobilizon.Repo.Migrations.CreateAddresses.change/0 forward
server # [  752.657595] mobilizon_ctl[1749]: 22:04:56.389 [info] create table addresses
server # [  752.818972] mobilizon_ctl[1749]: 22:04:56.538 [info] == Migrated 20180110092400 in 0.1s
server # [  752.925207] mobilizon_ctl[1749]: 22:04:56.648 [info] == Running 20180110092500 Mobilizon.Repo.Migrations.CreateGroups.change/0 forward
server # [  752.970021] mobilizon_ctl[1749]: 22:04:56.687 [info] create table groups
server # [  753.213055] mobilizon_ctl[1749]: 22:04:56.938 [info] create index groups_slug_index
server # [  753.275721] mobilizon_ctl[1749]: 22:04:57.003 [info] == Migrated 20180110092500 in 0.3s
server # [  753.414772] mobilizon_ctl[1749]: 22:04:57.142 [info] == Running 20180110092600 Mobilizon.Repo.Migrations.CreateEvents.change/0 forward
server # [  753.544038] mobilizon_ctl[1749]: 22:04:57.217 [info] create table events
server # [  753.935360] mobilizon_ctl[1749]: 22:04:57.648 [info] create index events_organizer_account_id_index
server # [  754.013041] mobilizon_ctl[1749]: 22:04:57.735 [info] create index events_organizer_group_id_index
server # [  754.087809] mobilizon_ctl[1749]: 22:04:57.808 [info] create index events_slug_index
server # [  754.157935] mobilizon_ctl[1749]: 22:04:57.881 [info] == Migrated 20180110092600 in 0.7s
server # [  754.273443] mobilizon_ctl[1749]: 22:04:57.999 [info] == Running 20180110093905 Mobilizon.Repo.Migrations.CreateTags.change/0 forward
server # [  754.320006] mobilizon_ctl[1749]: 22:04:58.040 [info] create table tags
server # [  754.553489] mobilizon_ctl[1749]: 22:04:58.230 [info] create index tags_slug_index
server # [  754.589995] mobilizon_ctl[1749]: 22:04:58.303 [info] == Migrated 20180110093905 in 0.3s
server # [  754.708921] mobilizon_ctl[1749]: 22:04:58.442 [info] == Running 20180110093906 Mobilizon.Repo.Migrations.CreateEventsTags.change/0 forward
server # [  754.722143] mobilizon_ctl[1749]: 22:04:58.459 [info] create table events_tags
server # [  754.833405] mobilizon_ctl[1749]: 22:04:58.559 [info] == Migrated 20180110093906 in 0.1s
server # [  754.952687] mobilizon_ctl[1749]: 22:04:58.682 [info] == Running 20180110094301 Mobilizon.Repo.Migrations.CreateParticipants.change/0 forward
server # [  754.986490] mobilizon_ctl[1749]: 22:04:58.713 [info] create table participants
server # [  755.150862] mobilizon_ctl[1749]: 22:04:58.870 [info] create index participants_event_id_index
server # [  755.193619] mobilizon_ctl[1749]: 22:04:58.927 [info] create index participants_account_id_index
server # [  755.289888] mobilizon_ctl[1749]: 22:04:58.995 [info] == Migrated 20180110094301 in 0.3s
server # [  755.397093] mobilizon_ctl[1749]: 22:04:59.127 [info] == Running 20180110094502 Mobilizon.Repo.Migrations.CreateEventRequests.change/0 forward
server # [  755.437962] mobilizon_ctl[1749]: 22:04:59.156 [info] create table event_requests
server # [  755.617910] mobilizon_ctl[1749]: 22:04:59.305 [info] create index event_requests_event_id_index
server # [  755.656882] mobilizon_ctl[1749]: 22:04:59.362 [info] create index event_requests_account_id_index
server # [  755.688837] mobilizon_ctl[1749]: 22:04:59.420 [info] == Migrated 20180110094502 in 0.2s
server # [  755.780911] mobilizon_ctl[1749]: 22:04:59.514 [info] == Running 20180110095317 Mobilizon.Repo.Migrations.CreateMembers.change/0 forward
server # [  755.804793] mobilizon_ctl[1749]: 22:04:59.532 [info] create table members
server # [  755.934674] mobilizon_ctl[1749]: 22:04:59.663 [info] create index members_group_id_index
server # [  755.998516] mobilizon_ctl[1749]: 22:04:59.720 [info] create index members_account_id_index
server # [  756.045544] mobilizon_ctl[1749]: 22:04:59.770 [info] == Migrated 20180110095317 in 0.2s
server # [  756.128853] mobilizon_ctl[1749]: 22:04:59.864 [info] == Running 20180110095515 Mobilizon.Repo.Migrations.CreateGroupRequests.change/0 forward
server # [  756.149485] mobilizon_ctl[1749]: 22:04:59.887 [info] create table group_requests
server # [  756.335196] mobilizon_ctl[1749]: 22:05:00.056 [info] create index group_requests_group_id_index
server # [  756.396933] mobilizon_ctl[1749]: 22:05:00.118 [info] create index group_requests_account_id_index
server # [  756.450881] mobilizon_ctl[1749]: 22:05:00.174 [info] == Migrated 20180110095515 in 0.3s
server # [  756.568858] mobilizon_ctl[1749]: 22:05:00.299 [info] == Running 20180110165029 Mobilizon.Repo.Migrations.Guardian.DB.change/0 forward
server # [  756.639297] mobilizon_ctl[1749]: 22:05:00.326 [info] create table guardian_tokens
server # [  756.790775] mobilizon_ctl[1749]: 22:05:00.519 [info] == Migrated 20180110165029 in 0.2s
server # [  756.953105] mobilizon_ctl[1749]: 22:05:00.682 [info] == Running 20180112100000 Mobilizon.Repo.Migrations.CreateTracks.change/0 forward
server # [  756.983575] mobilizon_ctl[1749]: 22:05:00.719 [info] create table tracks
server # [  757.229825] mobilizon_ctl[1749]: 22:05:00.939 [info] == Migrated 20180112100000 in 0.2s
server # [  757.329710] mobilizon_ctl[1749]: 22:05:01.074 [info] == Running 20180112105354 Mobilizon.Repo.Migrations.CreateSessions.change/0 forward
server # [  757.373787] mobilizon_ctl[1749]: 22:05:01.100 [info] create table sessions
server # [  757.770268] mobilizon_ctl[1749]: 22:05:01.432 [info] == Migrated 20180112105354 in 0.3s
server # [  757.845161] mobilizon_ctl[1749]: 22:05:01.576 [info] == Running 20180430071244 Mobilizon.Repo.Migrations.RemoveUri.up/0 forward
server # [  757.902410] mobilizon_ctl[1749]: 22:05:01.613 [info] alter table accounts
server # [  757.998209] mobilizon_ctl[1749]: 22:05:01.712 [info] alter table groups
server # [  758.036022] mobilizon_ctl[1749]: 22:05:01.755 [info] == Migrated 20180430071244 in 0.1s
server # [  758.177046] mobilizon_ctl[1749]: 22:05:01.907 [info] == Running 20180515091106 Mobilizon.Repo.Migrations.AddUrlFieldToEvents.up/0 forward
server # [  758.206498] mobilizon_ctl[1749]: 22:05:01.920 [info] alter table events
server # [  758.294196] mobilizon_ctl[1749]: 22:05:02.000 [info] == Migrated 20180515091106 in 0.0s
server # [  758.423351] mobilizon_ctl[1749]: 22:05:02.151 [info] == Running 20180515100237 Mobilizon.Repo.Migrations.CreateComments.change/0 forward
server # [  758.486874] mobilizon_ctl[1749]: 22:05:02.191 [info] create table comments
server # [  758.915805] mobilizon_ctl[1749]: 22:05:02.591 [info] == Migrated 20180515100237 in 0.4s
server # [  758.971725] mobilizon_ctl[1749]: 22:05:02.715 [info] == Running 20180515142835 Mobilizon.Repo.Migrations.AlterEventTimestampsToDateTimeWithTimeZone.up/0 forward
server # [  759.010961] mobilizon_ctl[1749]: 22:05:02.727 [info] alter table events
server # [  759.078584] mobilizon_ctl[1749]: 22:05:02.799 [info] == Migrated 20180515142835 in 0.0s
server # [  759.173908] mobilizon_ctl[1749]: 22:05:02.908 [info] == Running 20180515145438 Mobilizon.Repo.Migrations.AddLocalAttributeToEventsAndComments.up/0 forward
server # [  759.213059] mobilizon_ctl[1749]: 22:05:02.933 [info] alter table events
server # [  759.269986] mobilizon_ctl[1749]: 22:05:02.996 [info] alter table comments
server # [  759.316615] mobilizon_ctl[1749]: 22:05:03.040 [info] == Migrated 20180515145438 in 0.1s
server # [  759.408950] mobilizon_ctl[1749]: 22:05:03.147 [info] == Running 20180517100700 Mobilizon.Repo.Migrations.MoveFromAccountToActor.up/0 forward
server # [  759.571430] mobilizon_ctl[1749]: 22:05:03.291 [info] drop table event_requests
server # [  759.719255] mobilizon_ctl[1749]: 22:05:03.458 [info] drop table group_requests
server # [  759.853665] mobilizon_ctl[1749]: 22:05:03.563 [info] alter table events
server # [  759.963922] mobilizon_ctl[1749]: 22:05:03.639 [info] rename column account_id to actor_id on table members
server # [  759.989168] mobilizon_ctl[1749]: 22:05:03.663 [info] alter table members
server # [  760.126615] mobilizon_ctl[1749]: 22:05:03.855 [info] drop table groups
server # [  760.237358] mobilizon_ctl[1749]: 22:05:03.966 [info] rename table accounts to actors
server # [  760.293956] mobilizon_ctl[1749]: 22:05:04.000 [info] execute "CREATE TYPE public.actor_type AS ENUM ('Person', 'Application', 'Group', 'Organization', 'Service')"
server # [  760.394047] mobilizon_ctl[1749]: 22:05:04.110 [info] rename column username to name on table actors
server # [  760.421807] mobilizon_ctl[1749]: 22:05:04.127 [info] rename column description to summary on table actors
server # [  760.463670] mobilizon_ctl[1749]: 22:05:04.151 [info] rename column display_name to preferred_username on table actors
server # [  760.478397] mobilizon_ctl[1749]: 22:05:04.182 [info] alter table actors
server # [  760.662751] mobilizon_ctl[1749]: 22:05:04.390 [info] create index actors_preferred_username_domain_index
server # [  760.734975] mobilizon_ctl[1749]: 22:05:04.468 [info] rename column organizer_account_id to organizer_actor_id on table events
server # [  760.789099] mobilizon_ctl[1749]: 22:05:04.499 [info] rename column account_id to actor_id on table participants
server # [  760.806753] mobilizon_ctl[1749]: 22:05:04.522 [info] create table followers
server # [  760.999447] mobilizon_ctl[1749]: 22:05:04.687 [info] rename column account_id to actor_id on table comments
server # [  761.027348] mobilizon_ctl[1749]: 22:05:04.719 [info] rename column account_id to actor_id on table users
server # [  761.053426] mobilizon_ctl[1749]: 22:05:04.764 [info] == Migrated 20180517100700 in 1.6s
server # [  761.253693] mobilizon_ctl[1749]: 22:05:04.986 [info] == Running 20180522133844 Mobilizon.Repo.Migrations.AddBotsTable.up/0 forward
server # [  761.278860] mobilizon_ctl[1749]: 22:05:05.011 [info] create table bots
server # [  761.541242] mobilizon_ctl[1749]: 22:05:05.261 [info] == Migrated 20180522133844 in 0.2s
server # [  761.643317] mobilizon_ctl[1749]: 22:05:05.377 [info] == Running 20180530125159 Mobilizon.Repo.Migrations.AddAvatarAndBannerToActor.up/0 forward
server # [  761.669960] mobilizon_ctl[1749]: 22:05:05.386 [info] alter table actors
server # [  761.734584] mobilizon_ctl[1749]: 22:05:05.446 [info] == Migrated 20180530125159 in 0.0s
server # [  761.845771] mobilizon_ctl[1749]: 22:05:05.576 [info] == Running 20180530152323 Mobilizon.Repo.Migrations.MakeActorPublicKeyNullable.up/0 forward
server # [  761.876388] mobilizon_ctl[1749]: 22:05:05.591 [info] alter table actors
server # [  761.925275] mobilizon_ctl[1749]: 22:05:05.647 [info] == Migrated 20180530152323 in 0.0s
server # [  762.086900] mobilizon_ctl[1749]: 22:05:05.777 [info] == Running 20180530170808 Mobilizon.Repo.Migrations.AddUUIDIdToEvents.up/0 forward
server # [  762.115247] mobilizon_ctl[1749]: 22:05:05.783 [info] alter table events
server # [  762.137040] mobilizon_ctl[1749]: 22:05:05.854 [info] == Migrated 20180530170808 in 0.0s
server # [  762.246063] mobilizon_ctl[1749]: 22:05:05.979 [info] == Running 20180531162301 Mobilizon.Repo.Migrations.AddApprovedStatusToMember.up/0 forward
server # [  762.272937] mobilizon_ctl[1749]: 22:05:05.987 [info] alter table members
server # [  762.330537] mobilizon_ctl[1749]: 22:05:06.050 [info] == Migrated 20180531162301 in 0.0s
server # [  762.425616] mobilizon_ctl[1749]: 22:05:06.156 [info] == Running 20180607095732 Mobilizon.Repo.Migrations.AddUUIDToComments.up/0 forward
server # [  762.453486] mobilizon_ctl[1749]: 22:05:06.175 [info] alter table comments
server # [  762.498850] mobilizon_ctl[1749]: 22:05:06.216 [info] == Migrated 20180607095732 in 0.0s
server # [  762.601677] mobilizon_ctl[1749]: 22:05:06.344 [info] == Running 20180614094653 Mobilizon.Repo.Migrations.MakeSharedInboxUrlNullable.up/0 forward
server # [  762.642268] mobilizon_ctl[1749]: 22:05:06.366 [info] alter table actors
server # [  762.737248] mobilizon_ctl[1749]: 22:05:06.455 [info] == Migrated 20180614094653 in 0.1s
server # [  762.841383] mobilizon_ctl[1749]: 22:05:06.579 [info] == Running 20180614104618 Mobilizon.Repo.Migrations.FusionPublicPrivateKeyIntoKeysColumn.up/0 forward
server # [  762.878088] mobilizon_ctl[1749]: 22:05:06.588 [info] rename column private_key to keys on table actors
server # [  762.922954] mobilizon_ctl[1749]: 22:05:06.643 [info] alter table actors
server # [  762.973825] mobilizon_ctl[1749]: 22:05:06.684 [info] == Migrated 20180614104618 in 0.1s
server # [  763.143247] mobilizon_ctl[1749]: 22:05:06.817 [info] == Running 20180614131328 Mobilizon.Repo.Migrations.AddAttributedToFieldToEventsAndComments.up/0 forward
server # [  763.159664] mobilizon_ctl[1749]: 22:05:06.839 [info] alter table events
server # [  763.291790] mobilizon_ctl[1749]: 22:05:07.019 [info] alter table comments
server # [  763.413790] mobilizon_ctl[1749]: 22:05:07.121 [info] == Migrated 20180614131328 in 0.2s
server # [  763.516968] mobilizon_ctl[1749]: 22:05:07.254 [info] == Running 20180628091920 :"Elixir.Mobilizon.Repo.Migrations.Add-user-confirm-email-fields".up/0 forward
server # [  763.544981] mobilizon_ctl[1749]: 22:05:07.268 [info] alter table users
server # [  763.604979] mobilizon_ctl[1749]: 22:05:07.328 [info] create index index_unique_users_confirmation_token
server # [  763.659911] mobilizon_ctl[1749]: 22:05:07.382 [info] == Migrated 20180628091920 in 0.1s
server # [  763.776976] mobilizon_ctl[1749]: 22:05:07.516 [info] == Running 20180628130746 :"Elixir.Mobilizon.Repo.Migrations.Add-user-password-reset-fields".up/0 forward
server # [  763.842528] mobilizon_ctl[1749]: 22:05:07.548 [info] alter table users
server # [  763.877181] mobilizon_ctl[1749]: 22:05:07.603 [info] create index index_unique_users_reset_password_token
server # [  763.959021] mobilizon_ctl[1749]: 22:05:07.675 [info] == Migrated 20180628130746 in 0.1s
server # [  764.142942] mobilizon_ctl[1749]: 22:05:07.811 [info] == Running 20180628142835 Mobilizon.Repo.Migrations.RevertAlterEventTimestampsToDateTimeWithTimeZone.up/0 forward
server # [  764.175424] mobilizon_ctl[1749]: 22:05:07.820 [info] alter table events
server # [  764.192760] mobilizon_ctl[1749]: 22:05:07.902 [info] == Migrated 20180628142835 in 0.0s
server # [  764.329546] mobilizon_ctl[1749]: 22:05:08.063 [info] == Running 20180702150922 Mobilizon.Repo.Migrations.AddAddressType.up/0 forward
server # [  764.367735] mobilizon_ctl[1749]: 22:05:08.091 [info] alter table events
server # [  764.421089] mobilizon_ctl[1749]: 22:05:08.139 [info] drop constraint events_address_id_fkey from table events
server # [  764.473011] mobilizon_ctl[1749]: 22:05:08.190 [info] rename column address_id to physical_address_id on table events
server # [  764.485170] mobilizon_ctl[1749]: 22:05:08.210 [info] alter table events
server # [  764.561233] mobilizon_ctl[1749]: 22:05:08.288 [info] == Migrated 20180702150922 in 0.2s
server # [  764.673979] mobilizon_ctl[1749]: 22:05:08.407 [info] == Running 20180702154630 Mobilizon.Repo.Migrations.RemoveSlugForEvent.up/0 forward
server # [  764.685801] mobilizon_ctl[1749]: 22:05:08.416 [info] alter table events
server # [  764.736756] mobilizon_ctl[1749]: 22:05:08.467 [info] == Migrated 20180702154630 in 0.0s
server # [  764.823497] mobilizon_ctl[1749]: 22:05:08.554 [info] == Running 20180706082208 Mobilizon.Repo.Migrations.AlterEventsSetDescriptionAsText.up/0 forward
server # [  764.843863] mobilizon_ctl[1749]: 22:05:08.566 [info] alter table events
server # [  764.893013] mobilizon_ctl[1749]: 22:05:08.605 [info] == Migrated 20180706082208 in 0.0s
server # [  764.982804] mobilizon_ctl[1749]: 22:05:08.720 [info] == Running 20180709154152 Mobilizon.Repo.Migrations.AllowMultipleAccountsForUser.up/0 forward
server # [  765.018449] mobilizon_ctl[1749]: 22:05:08.740 [info] alter table actors
server # [  765.139777] mobilizon_ctl[1749]: 22:05:08.844 [info] alter table users
server # [  765.179045] mobilizon_ctl[1749]: 22:05:08.908 [info] == Migrated 20180709154152 in 0.1s
server # [  765.263480] mobilizon_ctl[1749]: 22:05:08.999 [info] == Running 20180802133951 Mobilizon.Repo.Migrations.MakeFollowerTableUnique.up/0 forward
server # [  765.288618] mobilizon_ctl[1749]: 22:05:09.010 [info] create index followers_actor_target_actor_unique_index
server # [  765.346499] mobilizon_ctl[1749]: 22:05:09.075 [info] == Migrated 20180802133951 in 0.0s
server # [  765.450207] mobilizon_ctl[1749]: 22:05:09.183 [info] == Running 20180816093446 Mobilizon.Repo.Migrations.AddPrimaryKeyToMember.up/0 forward
server # [  765.503243] mobilizon_ctl[1749]: 22:05:09.208 [info] execute "ALTER TABLE members DROP CONSTRAINT IF EXISTS members_pkey"
server # [  765.545553] mobilizon_ctl[1749]: 22:05:09.235 [info] constraint "members_pkey" of relation "members" does not exist, skipping
server # [  765.570196] mobilizon_ctl[1749]: 22:05:09.236 [info] drop index if exists members_members_account_id_index_index
server # [  765.577806] mobilizon_ctl[1749]: 22:05:09.281 [info] index "members_members_account_id_index_index" does not exist, skipping
server # [  765.598728] mobilizon_ctl[1749]: 22:05:09.286 [info] create index members_actor_parent_unique_index
server # [  765.649093] mobilizon_ctl[1749]: 22:05:09.370 [info] alter table members
server # [  765.901804] mobilizon_ctl[1749]: 22:05:09.623 [info] == Migrated 20180816093446 in 0.4s
server # [  766.031869] mobilizon_ctl[1749]: 22:05:09.762 [info] == Running 20181021161324 Mobilizon.Repo.Migrations.AddDefaultActorUserField.up/0 forward
server # [  766.061703] mobilizon_ctl[1749]: 22:05:09.774 [info] alter table users
server # [  766.095067] mobilizon_ctl[1749]: 22:05:09.819 [info] == Migrated 20181021161324 in 0.0s
server # [  766.215861] mobilizon_ctl[1749]: 22:05:09.930 [info] == Running 20181108165151 Mobilizon.Repo.Migrations.FixCommentsReferences.up/0 forward
server # [  766.242921] mobilizon_ctl[1749]: 22:05:09.948 [info] drop constraint comments_in_reply_to_comment_id_fkey from table comments
server # [  766.293742] mobilizon_ctl[1749]: 22:05:10.022 [info] drop constraint comments_origin_comment_id_fkey from table comments
server # [  766.365686] mobilizon_ctl[1749]: 22:05:10.083 [info] alter table comments
server # [  766.513731] mobilizon_ctl[1749]: 22:05:10.229 [info] == Migrated 20181108165151 in 0.2s
server # [  766.609254] mobilizon_ctl[1749]: 22:05:10.344 [info] == Running 20181203092128 Mobilizon.Repo.Migrations.ChangeActorsIndexes.up/0 forward
server # [  766.648873] mobilizon_ctl[1749]: 22:05:10.383 [info] drop index actors_preferred_username_domain_index
server # [  766.713073] mobilizon_ctl[1749]: 22:05:10.442 [info] drop index accounts_username_domain_index
server # [  766.749095] mobilizon_ctl[1749]: 22:05:10.471 [info] execute "ALTER INDEX accounts_pkey RENAME TO actors_pkey"
server # [  766.781876] mobilizon_ctl[1749]: 22:05:10.515 [info] create index actors_preferred_username_domain_type_index
server # [  766.901878] mobilizon_ctl[1749]: 22:05:10.623 [info] create index actors_url_index
server # [  766.970351] mobilizon_ctl[1749]: 22:05:10.698 [info] == Migrated 20181203092128 in 0.3s
server # [  767.125509] mobilizon_ctl[1749]: 22:05:10.855 [info] == Running 20190103150805 Mobilizon.Repo.Migrations.FixEventVisibility.up/0 forward
server # [  767.174973] mobilizon_ctl[1749]: 22:05:10.876 [info] execute "CREATE TYPE public.event_visibility AS ENUM ('public', 'unlisted', 'restricted', 'private')"
server # [  767.230688] mobilizon_ctl[1749]: 22:05:10.911 [info] execute "CREATE TYPE public.event_status AS ENUM ('tentative', 'confirmed', 'cancelled')"
server # [  767.255824] mobilizon_ctl[1749]: 22:05:10.946 [info] execute "CREATE TYPE public.comment_visibility AS ENUM ('public', 'unlisted', 'private', 'moderated', 'invite')"
server # [  767.277948] mobilizon_ctl[1749]: 22:05:10.978 [info] alter table events
server # [  767.347202] mobilizon_ctl[1749]: 22:05:11.067 [info] alter table comments
server # [  767.385750] mobilizon_ctl[1749]: 22:05:11.110 [info] == Migrated 20190103150805 in 0.2s
server # [  767.504860] mobilizon_ctl[1749]: 22:05:11.240 [info] == Running 20190114162055 Mobilizon.Repo.Migrations.RemoveAddressType.up/0 forward
server # [  767.521074] mobilizon_ctl[1749]: 22:05:11.255 [info] execute "ALTER TABLE \"events\" DROP COLUMN IF EXISTS address_type"
server # [  767.576610] mobilizon_ctl[1749]: 22:05:11.299 [info] column "address_type" of relation "events" does not exist, skipping
server # [  767.586716] mobilizon_ctl[1749]: 22:05:11.300 [info] execute "DROP TYPE IF EXISTS address_type"
server # [  767.613135] mobilizon_ctl[1749]: 22:05:11.336 [info] type "address_type" does not exist, skipping
server # [  767.629901] mobilizon_ctl[1749]: 22:05:11.345 [info] rename column phone to phone_address on table events
server # [  767.682180] mobilizon_ctl[1749]: 22:05:11.387 [info] == Migrated 20190114162055 in 0.1s
server # [  767.777942] mobilizon_ctl[1749]: 22:05:11.522 [info] == Running 20190125143718 Mobilizon.Repo.Migrations.GroupDeleteMembersCascade.change/0 forward
server # [  767.813729] mobilizon_ctl[1749]: 22:05:11.536 [info] drop constraint members_account_id_fkey from table members
server # [  767.881844] mobilizon_ctl[1749]: 22:05:11.603 [info] drop constraint members_parent_id_fkey from table members
server # [  767.934670] mobilizon_ctl[1749]: 22:05:11.667 [info] alter table members
server # [  768.135607] mobilizon_ctl[1749]: 22:05:11.859 [info] == Migrated 20190125143718 in 0.3s
server # [  768.273178] mobilizon_ctl[1749]: 22:05:11.955 [info] == Running 20190130151607 Mobilizon.Repo.Migrations.SplitEventVisibilityAndJoinOptions.up/0 forward
server # [  768.287932] mobilizon_ctl[1749]: 22:05:11.978 [info] execute "ALTER TABLE events ALTER COLUMN visibility TYPE VARCHAR USING visibility::text"
server # [  768.467722] mobilizon_ctl[1749]: 22:05:12.203 [info] execute "DROP TYPE public.event_visibility"
server # [  768.513671] mobilizon_ctl[1749]: 22:05:12.232 [info] execute "CREATE TYPE public.event_visibility AS ENUM ('public', 'unlisted', 'restricted', 'private')"
server # [  768.554899] mobilizon_ctl[1749]: 22:05:12.284 [info] execute "ALTER TABLE events ALTER COLUMN visibility TYPE event_visibility USING visibility::event_visibility"
server # [  768.724907] mobilizon_ctl[1749]: 22:05:12.455 [info] execute "CREATE TYPE public.join_options AS ENUM ('free', 'restricted', 'invite', 'external')"
server # [  768.758661] mobilizon_ctl[1749]: 22:05:12.486 [info] alter table events
server # [  768.799168] mobilizon_ctl[1749]: 22:05:12.536 [info] execute "UPDATE events SET visibility = 'public' WHERE visibility IS NULL"
server # [  768.855003] mobilizon_ctl[1749]: 22:05:12.590 [info] alter table events
server # [  768.907561] mobilizon_ctl[1749]: 22:05:12.632 [info] == Migrated 20190130151607 in 0.6s
server # [  769.054019] mobilizon_ctl[1749]: 22:05:12.788 [info] == Running 20190207134142 Mobilizon.Repo.Migrations.MoveParticipantRoleToEnum.up/0 forward
server # [  769.079994] mobilizon_ctl[1749]: 22:05:12.814 [info] execute "CREATE TYPE public.participant_role AS ENUM ('not_approved', 'not_confirmed', 'rejected', 'participant', 'moderator', 'administrator', 'creator')"
server # [  769.130293] mobilizon_ctl[1749]: 22:05:12.851 [info] alter table participants
server # [  769.190934] mobilizon_ctl[1749]: 22:05:12.916 [info] execute "UPDATE participants set role_tmp = 'not_approved' where role = 0"
server # [  769.290808] mobilizon_ctl[1749]: 22:05:12.970 [info] execute "UPDATE participants set role_tmp = 'participant' where role = 1"
server # [  769.311119] mobilizon_ctl[1749]: 22:05:12.986 [info] execute "UPDATE participants set role_tmp = 'moderator' where role = 2"
server # [  769.329735] mobilizon_ctl[1749]: 22:05:13.014 [info] execute "UPDATE participants set role_tmp = 'administrator' where role = 3"
server # [  769.353289] mobilizon_ctl[1749]: 22:05:13.039 [info] execute "UPDATE participants set role_tmp = 'creator' where role = 4"
server # [  769.385503] mobilizon_ctl[1749]: 22:05:13.079 [info] alter table participants
server # [  769.419023] mobilizon_ctl[1749]: 22:05:13.115 [info] rename column role_tmp to role on table participants
server # [  769.435716] mobilizon_ctl[1749]: 22:05:13.147 [info] == Migrated 20190207134142 in 0.3s
server # [  769.513149] mobilizon_ctl[1749]: 22:05:13.246 [info] == Running 20190208141700 Mobilizon.Repo.Migrations.TagsRelations.up/0 forward
server # [  769.543897] mobilizon_ctl[1749]: 22:05:13.270 [info] create table tag_relations
server # [  769.686026] mobilizon_ctl[1749]: 22:05:13.411 [info] create check constraint no_self_loops_check on table tag_relations
server # [  769.725814] mobilizon_ctl[1749]: 22:05:13.451 [info] create index index_tag_relations_tag_id
server # [  769.783493] mobilizon_ctl[1749]: 22:05:13.510 [info] create index index_tag_relations_link_id
server # [  769.837433] mobilizon_ctl[1749]: 22:05:13.566 [info] == Migrated 20190208141700 in 0.3s
server # [  769.932886] mobilizon_ctl[1749]: 22:05:13.663 [info] == Running 20190214100858 Mobilizon.Repo.Migrations.DropDatetimetz.up/0 forward
server # [  769.987717] mobilizon_ctl[1749]: 22:05:13.702 [info] alter table events
server # [  770.050002] mobilizon_ctl[1749]: 22:05:13.785 [info] alter table sessions
server # [  770.099164] mobilizon_ctl[1749]: 22:05:13.830 [info] execute "DROP TYPE datetimetz"
server # [  770.139818] mobilizon_ctl[1749]: 22:05:13.859 [info] == Migrated 20190214100858 in 0.1s
server # [  770.230267] mobilizon_ctl[1749]:     #########################################################
server # [  770.241614] mobilizon_ctl[1749]:     # If the CREATE EXTENSION or DROP EXTENSION calls fail, #
server # [  770.245659] mobilizon_ctl[1749]:     # please manually execute them with an authorized       #
server # [  770.301831] mobilizon_ctl[1749]:     # PostgreSQL user with SUPER USER role.                 #
server # [  770.311745] mobilizon_ctl[1749]:     #########################################################
server # [  770.321466] mobilizon_ctl[1749]:
server # [  770.333410] mobilizon_ctl[1749]:
server # [  770.342865] mobilizon_ctl[1749]: 22:05:13.971 [info] == Running 20190219164310 Mobilizon.Repo.Migrations.CreateSearchIndexes.change/0 forward
server # [  770.358302] mobilizon_ctl[1749]: 22:05:13.992 [info] execute "CREATE EXTENSION IF NOT EXISTS pg_trgm"
server # [  770.383191] mobilizon_ctl[1749]: 22:05:14.023 [info] extension "pg_trgm" already exists, skipping
server # [  770.403741] mobilizon_ctl[1749]: 22:05:14.024 [info] execute "CREATE EXTENSION IF NOT EXISTS unaccent"
server # [  770.410946] mobilizon_ctl[1749]: 22:05:14.068 [info] extension "unaccent" already exists, skipping
server # [  770.426626] mobilizon_ctl[1749]: 22:05:14.082 [info] execute "CREATE OR REPLACE FUNCTION public.f_unaccent(text)\n  RETURNS text AS\n$func$\nSELECT public.unaccent('public.unaccent', $1)\n$func$  LANGUAGE sql IMMUTABLE;"
server # [  770.439041] mobilizon_ctl[1749]: 22:05:14.154 [info] execute "CREATE INDEX \"event_title_trigram\" ON \"events\" USING GIN (f_unaccent(title) gin_trgm_ops)"
server # [  770.544835] mobilizon_ctl[1749]: 22:05:14.279 [info] execute "CREATE INDEX \"actor_preferred_username_trigram\" ON \"actors\"\n    USING GIN (f_unaccent(preferred_username) gin_trgm_ops)"
server # [  770.614834] mobilizon_ctl[1749]: 22:05:14.343 [info] execute "CREATE INDEX \"actor_name_trigram\" ON \"actors\"\n    USING GIN (f_unaccent(name) gin_trgm_ops)"
server # [  770.689142] mobilizon_ctl[1749]: 22:05:14.415 [info] == Migrated 20190219164310 in 0.4s
server # [  770.828898] mobilizon_ctl[1749]: 22:05:14.531 [info] == Running 20190222151449 Mobilizon.Repo.Migrations.DropCategories.up/0 forward
server # [  770.853007] mobilizon_ctl[1749]: 22:05:14.555 [info] alter table events
server # [  770.950550] mobilizon_ctl[1749]: 22:05:14.660 [info] drop table categories
server # [  771.073944] mobilizon_ctl[1749]: 22:05:14.785 [info] == Migrated 20190222151449 in 0.2s
server # [  771.226505] mobilizon_ctl[1749]: 22:05:14.951 [info] == Running 20190301141830 Mobilizon.Repo.Migrations.MoveMemberRoleToEnum.up/0 forward
server # [  771.323618] mobilizon_ctl[1749]: 22:05:14.983 [info] execute "CREATE TYPE public.member_role AS ENUM ('invited', 'not_approved', 'member', 'moderator', 'administrator', 'creator', 'rejected')"
server # [  771.346085] mobilizon_ctl[1749]: 22:05:15.041 [info] alter table members
server # [  771.381918] mobilizon_ctl[1749]: 22:05:15.088 [info] execute "UPDATE members set role_tmp = 'member' where role = 0"
server # [  771.465703] mobilizon_ctl[1749]: 22:05:15.170 [info] execute "UPDATE members set role_tmp = 'moderator' where role = 1"
server # [  771.522056] mobilizon_ctl[1749]: 22:05:15.195 [info] execute "UPDATE members set role_tmp = 'creator' where role = 2"
server # [  771.534883] mobilizon_ctl[1749]: 22:05:15.239 [info] execute "UPDATE members set role_tmp = 'not_approved' where approved is false"
server # [  771.578802] mobilizon_ctl[1749]: 22:05:15.292 [info] alter table members
server # [  771.649920] mobilizon_ctl[1749]: 22:05:15.361 [info] rename column role_tmp to role on table members
server # [  771.671473] mobilizon_ctl[1749]: 22:05:15.384 [info] == Migrated 20190301141830 in 0.4s
server # [  771.809704] mobilizon_ctl[1749]: 22:05:15.548 [info] == Running 20190301143831 Mobilizon.Repo.Migrations.ActorGroupOpenness.up/0 forward
server # [  771.973044] mobilizon_ctl[1749]: 22:05:15.686 [info] execute "CREATE TYPE public.actor_openness AS ENUM ('invite_only', 'moderated', 'open')"
server # [  772.004947] mobilizon_ctl[1749]: 22:05:15.723 [info] alter table actors
server # [  772.063226] mobilizon_ctl[1749]: 22:05:15.787 [info] == Migrated 20190301143831 in 0.2s
server # [  772.197233] mobilizon_ctl[1749]: 22:05:15.918 [info] == Running 20190307125009 Mobilizon.Repo.Migrations.MoveUserRoleToEnum.up/0 forward
server # [  772.228886] mobilizon_ctl[1749]: 22:05:15.948 [info] execute "CREATE TYPE public.user_role AS ENUM ('administrator', 'moderator', 'user', 'pending')"
server # [  772.329356] mobilizon_ctl[1749]: 22:05:15.986 [info] alter table users
server # [  772.358897] mobilizon_ctl[1749]: 22:05:16.058 [info] execute "UPDATE users set role_tmp = 'user' where role = 0"
server # [  772.409123] mobilizon_ctl[1749]: 22:05:16.127 [info] execute "UPDATE users set role_tmp = 'moderator' where role = 1"
server # [  772.445045] mobilizon_ctl[1749]: 22:05:16.166 [info] execute "UPDATE users set role_tmp = 'administrator' where role = 2"
server # [  772.480851] mobilizon_ctl[1749]: 22:05:16.196 [info] alter table users
server # [  772.515906] mobilizon_ctl[1749]: 22:05:16.251 [info] rename column role_tmp to role on table users
server # [  772.594027] mobilizon_ctl[1749]: 22:05:16.292 [info] == Migrated 20190307125009 in 0.3s
server # [  772.694867] mobilizon_ctl[1749]: 22:05:16.420 [info] == Running 20190307133518 Mobilizon.Repo.Migrations.FeedTokenTable.change/0 forward
server # [  773.003621] mobilizon_ctl[1749]: 22:05:16.717 [info] create table feed_tokens
server # [  773.145164] mobilizon_ctl[1749]: 22:05:16.867 [info] == Migrated 20190307133518 in 0.4s
server # [  773.346769] mobilizon_ctl[1749]: 22:05:17.012 [info] == Running 20190322143724 Mobilizon.Repo.Migrations.RenameAddressFields.change/0 forward
server # [  773.369761] mobilizon_ctl[1749]: 22:05:17.074 [info] rename column addressCountry to country on table addresses
server # [  773.397231] mobilizon_ctl[1749]: 22:05:17.110 [info] rename column addressLocality to locality on table addresses
server # [  773.427092] mobilizon_ctl[1749]: 22:05:17.154 [info] rename column addressRegion to region on table addresses
server # [  773.469279] mobilizon_ctl[1749]: 22:05:17.183 [info] rename column postalCode to postal_code on table addresses
server # [  773.487009] mobilizon_ctl[1749]: 22:05:17.213 [info] rename column streetAddress to street on table addresses
server # [  773.511340] mobilizon_ctl[1749]: 22:05:17.242 [info] == Migrated 20190322143724 in 0.2s
server # [  773.633898] mobilizon_ctl[1749]: 22:05:17.354 [info] == Running 20190411124138 Mobilizon.Repo.Migrations.EventAddDescriptionSlug.change/0 forward
server # [  773.668926] mobilizon_ctl[1749]: 22:05:17.383 [info] alter table events
server # [  773.721093] mobilizon_ctl[1749]: 22:05:17.436 [info] == Migrated 20190411124138 in 0.0s
server # [  773.859510] mobilizon_ctl[1749]: 22:05:17.575 [info] == Running 20190411161557 Mobilizon.Repo.Migrations.EventEventTagOnDelete.up/0 forward
server # [  773.876893] mobilizon_ctl[1749]: 22:05:17.600 [info] drop constraint events_tags_event_id_fkey from table events_tags
server # [  773.977146] mobilizon_ctl[1749]: 22:05:17.684 [info] drop constraint events_tags_tag_id_fkey from table events_tags
server # [  774.017929] mobilizon_ctl[1749]: 22:05:17.750 [info] alter table events_tags
server # [  774.290072] mobilizon_ctl[1749]: 22:05:17.995 [info] == Migrated 20190411161557 in 0.4s
server # [  774.486496] mobilizon_ctl[1749]: 22:05:18.140 [info] == Running 20190425075451 Mobilizon.Repo.Migrations.AddVisibilityToActor.up/0 forward
server # [  774.507263] mobilizon_ctl[1749]: 22:05:18.159 [info] execute "CREATE TYPE public.actor_visibility AS ENUM ('public', 'unlisted', 'restricted', 'private')"
server # [  774.522306] mobilizon_ctl[1749]: 22:05:18.207 [info] alter table actors
server # [  774.569533] mobilizon_ctl[1749]: 22:05:18.288 [info] == Migrated 20190425075451 in 0.1s
server # [  774.627293] postgres[2162]: [2162] LOG:  skipping analyze of "schema_migrations" --- lock not available
server # [  774.720942] mobilizon_ctl[1749]: 22:05:18.432 [info] == Running 20190426093202 Mobilizon.Repo.Migrations.CreatePictures.up/0 forward
server # [  774.758758] mobilizon_ctl[1749]: 22:05:18.472 [info] create table pictures
server # [  775.015625] mobilizon_ctl[1749]: 22:05:18.727 [info] alter table actors
server # [  775.124971] mobilizon_ctl[1749]: 22:05:18.837 [info] alter table events
server # [  775.329886] mobilizon_ctl[1749]: 22:05:19.034 [info] == Migrated 20190426093202 in 0.5s
server # [  775.526890] mobilizon_ctl[1749]: 22:05:19.197 [info] == Running 20190531131458 :"Elixir.Mobilizon.Repo.Migrations.Attach-pictures-to-actors".change/0 forward
server # [  775.542719] mobilizon_ctl[1749]: 22:05:19.223 [info] alter table pictures
server # [  775.723796] mobilizon_ctl[1749]: 22:05:19.439 [info] == Migrated 20190531131458 in 0.2s
server # [  775.879728] mobilizon_ctl[1749]: 22:05:19.602 [info] == Running 20190712125833 Mobilizon.Repo.Migrations.CreateReports.up/0 forward
server # [  776.143391] mobilizon_ctl[1749]: 22:05:19.871 [info] execute "CREATE TYPE public.report_status AS ENUM ('open', 'closed', 'resolved')"
server # [  776.236898] mobilizon_ctl[1749]: 22:05:19.927 [info] create table reports
server # [  776.861807] mobilizon_ctl[1749]: 22:05:20.508 [info] create table reports_comments
server # [  776.979624] mobilizon_ctl[1749]: 22:05:20.692 [info] == Migrated 20190712125833 in 1.0s
server # [  777.129453] mobilizon_ctl[1749]: 22:05:20.856 [info] == Running 20190712132438 Mobilizon.Repo.Migrations.CreateReportNotes.change/0 forward
server # [  777.192731] mobilizon_ctl[1749]: 22:05:20.895 [info] create table report_notes
server # [  777.528851] mobilizon_ctl[1749]: 22:05:21.251 [info] == Migrated 20190712132438 in 0.3s
server # [  777.653164] mobilizon_ctl[1749]: 22:05:21.376 [info] == Running 20190718122556 Mobilizon.Repo.Migrations.CreateAdminActionLogs.change/0 forward
server # [  777.714826] mobilizon_ctl[1749]: 22:05:21.434 [info] create table admin_action_logs
server # [  778.014170] mobilizon_ctl[1749]: 22:05:21.699 [info] == Migrated 20190718122556 in 0.3s
server # [  778.065931] mobilizon_ctl[1749]: 22:05:21.803 [info] == Running 20190729125532 :"Elixir.Mobilizon.Repo.Migrations.Add-url-to-addresses".change/0 forward
server # [  778.097108] mobilizon_ctl[1749]: 22:05:21.822 [info] alter table addresses
server # [  778.127161] mobilizon_ctl[1749]: 22:05:21.859 [info] == Migrated 20190729125532 in 0.0s
server # [  778.223898] mobilizon_ctl[1749]: 22:05:21.959 [info] == Running 20190806131306 Mobilizon.Repo.Migrations.AddUrlToFollowsAndMoveToUuid.up/0 forward
server # [  778.249897] mobilizon_ctl[1749]: 22:05:21.968 [info] alter table followers
server # [  778.353799] mobilizon_ctl[1749]: 22:05:22.082 [info] == Migrated 20190806131306 in 0.1s
server # [  778.456829] mobilizon_ctl[1749]: 22:05:22.187 [info] == Running 20190813160207 Mobilizon.Repo.Migrations.AddUrlAndUuidToParticipants.up/0 forward
server # [  778.495281] mobilizon_ctl[1749]: 22:05:22.223 [info] drop index participants_event_id_index
server # [  778.537503] mobilizon_ctl[1749]: 22:05:22.265 [info] drop index if exists participants_account_id_index
server # [  778.557708] mobilizon_ctl[1749]: 22:05:22.292 [info] drop index if exists participants_actor_id_index
server # [  778.579671] mobilizon_ctl[1749]: 22:05:22.318 [info] index "participants_actor_id_index" does not exist, skipping
server # [  778.605900] mobilizon_ctl[1749]: 22:05:22.319 [info] drop constraint participants_event_id_fkey from table participants
server # [  778.646837] mobilizon_ctl[1749]: 22:05:22.379 [info] drop constraint if exists participants_account_id_fkey from table participants
server # [  778.700428] mobilizon_ctl[1749]: 22:05:22.419 [info] drop constraint if exists participants_actor_id_fkey from table participants
server # [  778.719352] mobilizon_ctl[1749]: 22:05:22.439 [info] constraint "participants_actor_id_fkey" of relation "participants" does not exist, skipping
server # [  778.731020] mobilizon_ctl[1749]: 22:05:22.439 [info] drop constraint participants_pkey from table participants
server # [  778.761654] mobilizon_ctl[1749]: 22:05:22.486 [info] alter table participants
server # [  778.925832] mobilizon_ctl[1749]: 22:05:22.659 [info] create index participants_event_id_index
server # [  779.022818] mobilizon_ctl[1749]: 22:05:22.710 [info] create index participants_actor_id_index
server # [  779.048700] mobilizon_ctl[1749]: 22:05:22.771 [info] == Migrated 20190813160207 in 0.5s
server # [  779.141772] mobilizon_ctl[1749]: 22:05:22.878 [info] == Running 20190821161658 Mobilizon.Repo.Migrations.AddOriginIdToAddresses.change/0 forward
server # [  779.156738] mobilizon_ctl[1749]: 22:05:22.888 [info] alter table addresses
server # [  779.209021] mobilizon_ctl[1749]: 22:05:22.935 [info] create index addresses_origin_id_index
server # [  779.268845] mobilizon_ctl[1749]: 22:05:23.002 [info] == Migrated 20190821161658 in 0.1s
server # [  779.361725] mobilizon_ctl[1749]: 22:05:23.087 [info] == Running 20190823132816 Mobilizon.Repo.Migrations.RemoveEventsWhenDeletingOrganizer.up/0 forward
server # [  779.382680] mobilizon_ctl[1749]: 22:05:23.103 [info] drop constraint events_organizer_account_id_fkey from table events
server # [  779.433856] mobilizon_ctl[1749]: 22:05:23.156 [info] alter table events
server # [  779.539439] mobilizon_ctl[1749]: 22:05:23.269 [info] == Migrated 20190823132816 in 0.1s
server # [  779.644969] mobilizon_ctl[1749]: 22:05:23.371 [info] == Running 20190902082656 Mobilizon.Repo.Migrations.AddOptionsToEvent.change/0 forward
server # [  779.658188] mobilizon_ctl[1749]: 22:05:23.387 [info] alter table events
server # [  779.707148] mobilizon_ctl[1749]: 22:05:23.430 [info] == Migrated 20190902082656 in 0.0s
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  779.796805] mobilizon_ctl[1749]: 22:05:23.527 [info] == Running 20190929170817 Mobilizon.Storage.Repo.Migrations.RenamePostgresTypes.up/0 forward
server # [  780.078776] mobilizon_ctl[1749]: 22:05:23.759 [info] == Migrated 20190929170817 in 0.2s
server # [  780.134134] mobilizon_ctl[1749]: 22:05:23.869 [info] == Running 20190929175229 Mobilizon.Storage.Repo.Migrations.AddRejectedToParticipantRole.up/0 forward
server # [  780.164776] mobilizon_ctl[1749]: 22:05:23.877 [info] execute "ALTER TYPE public.participant_role ADD VALUE IF NOT EXISTS 'rejected'"
server # [  780.187863] mobilizon_ctl[1749]: 22:05:23.915 [info] enum label "rejected" already exists, skipping
server # [  780.207215] mobilizon_ctl[1749]: 22:05:23.926 [info] == Migrated 20190929175229 in 0.0s
server # [  780.294712] mobilizon_ctl[1749]: 22:05:24.030 [info] == Running 20191001074442 Mobilizon.Storage.Repo.Migrations.AddLocaleToUsers.change/0 forward
server # [  780.322619] mobilizon_ctl[1749]: 22:05:24.039 [info] alter table users
server # [  780.370237] mobilizon_ctl[1749]: 22:05:24.087 [info] == Migrated 20191001074442 in 0.0s
server # [  780.448508] mobilizon_ctl[1749]: 22:05:24.184 [info] == Running 20191002093208 Mobilizon.Storage.Repo.Migrations.AddDraftFlagToEvents.change/0 forward
server # [  780.467147] mobilizon_ctl[1749]: 22:05:24.192 [info] alter table events
server # [  780.515608] mobilizon_ctl[1749]: 22:05:24.248 [info] == Migrated 20191002093208 in 0.0s
server # [  780.605422] mobilizon_ctl[1749]: 22:05:24.335 [info] == Running 20191018075904 Mobilizon.Storage.Repo.Migrations.MoveSQLColumnsFromVarCharToText.up/0 forward
server # [  780.652815] mobilizon_ctl[1749]: 22:05:24.383 [info] alter table events
server # [  780.834962] mobilizon_ctl[1749]: 22:05:24.563 [info] alter table addresses
server # [  780.885155] mobilizon_ctl[1749]: 22:05:24.606 [info] alter table bots
server # [  780.918384] mobilizon_ctl[1749]: 22:05:24.647 [info] alter table report_notes
server # [  781.017115] mobilizon_ctl[1749]: 22:05:24.747 [info] alter table reports
server # [  781.111240] mobilizon_ctl[1749]: 22:05:24.784 [info] alter table sessions
server # [  781.153204] mobilizon_ctl[1749]: 22:05:24.871 [info] alter table tracks
server # [  781.208853] mobilizon_ctl[1749]: 22:05:24.923 [info] == Migrated 20191018075904 in 0.5s
server # [  781.345476] mobilizon_ctl[1749]: 22:05:25.083 [info] == Running 20191022083446 Mobilizon.Storage.Repo.Migrations.AddEagerMaterializedViewForSearchingEvents.up/0 forward
server # [  781.393472] mobilizon_ctl[1749]: 22:05:25.104 [info] create table event_search
server # [  781.578693] mobilizon_ctl[1749]: 22:05:25.300 [info] create index event_search_document_index
server # [  781.649648] mobilizon_ctl[1749]: 22:05:25.376 [info] execute "CREATE INDEX event_search_title_trgm_index ON event_search USING gin (title gin_trgm_ops)"
server # [  781.709793] mobilizon_ctl[1749]: 22:05:25.438 [info] create index event_search_id_index
server # [  781.779060] mobilizon_ctl[1749]: 22:05:25.492 [info] == Migrated 20191022083446 in 0.4s
server # [  781.881682] mobilizon_ctl[1749]: 22:05:25.616 [info] == Running 20191023133805 Mobilizon.Storage.Repo.Migrations.DeleteActorsCascadeToFollowers.up/0 forward
server # [  781.906590] mobilizon_ctl[1749]: 22:05:25.640 [info] drop constraint followers_actor_id_fkey from table followers
server # [  781.988952] mobilizon_ctl[1749]: 22:05:25.717 [info] drop constraint followers_target_actor_id_fkey from table followers
server # [  782.049055] mobilizon_ctl[1749]: 22:05:25.775 [info] alter table followers
server # [  782.299707] mobilizon_ctl[1749]: 22:05:25.970 [info] == Migrated 20191023133805 in 0.3s
server # [  782.358110] mobilizon_ctl[1749]: 22:05:26.087 [info] == Running 20191023143659 Mobilizon.Storage.Repo.Migrations.MoveParticipantsStatsToEvent.up/0 forward
server # [  782.380576] mobilizon_ctl[1749]: 22:05:26.103 [info] alter table events
server # [  782.445991] mobilizon_ctl[1749]: 22:05:26.171 [info] == Migrated 20191023143659 in 0.0s
server # [  782.571571] mobilizon_ctl[1749]: 22:05:26.305 [info] == Running 20191024204726 Mobilizon.Storage.Repo.Migrations.AddTagsToComments.up/0 forward
server # [  782.594673] mobilizon_ctl[1749]: 22:05:26.315 [info] create table comments_tags
server # [  782.748844] mobilizon_ctl[1749]: 22:05:26.471 [info] == Migrated 20191024204726 in 0.1s
server # [  782.860886] mobilizon_ctl[1749]: 22:05:26.597 [info] == Running 20191025083642 Mobilizon.Storage.Repo.Migrations.AddMentionTables.change/0 forward
server # [  782.910308] mobilizon_ctl[1749]: 22:05:26.637 [info] create table mentions
server # [  783.202233] mobilizon_ctl[1749]: 22:05:26.923 [info] create index mentions_actor_id_index
server # [  783.287560] mobilizon_ctl[1749]: 22:05:26.982 [info] == Migrated 20191025083642 in 0.3s
server # [  783.368483] mobilizon_ctl[1749]: 22:05:27.099 [info] == Running 20191025115537 Mobilizon.Storage.Repo.Migrations.AddUniqueIndexOnURLs.change/0 forward
server # [  783.378596] mobilizon_ctl[1749]: 22:05:27.111 [info] create index events_url_index
server # [  783.466894] mobilizon_ctl[1749]: 22:05:27.198 [info] create index comments_url_index
server # [  783.531554] mobilizon_ctl[1749]: 22:05:27.263 [info] == Migrated 20191025115537 in 0.1s
server # [  783.610103] mobilizon_ctl[1749]: 22:05:27.347 [info] == Running 20191031142145 Mobilizon.Storage.Repo.Migrations.AddUniqueIndexOnActorAndEventForParticipant.change/0 forward
server # [  783.632754] mobilizon_ctl[1749]: 22:05:27.359 [info] create index participants_event_id_actor_id_index
server # [  783.679123] mobilizon_ctl[1749]: 22:05:27.412 [info] == Migrated 20191031142145 in 0.0s
server # [  783.779033] mobilizon_ctl[1749]: 22:05:27.522 [info] == Running 20191104093447 Mobilizon.Storage.Repo.Migrations.AddObanJobsTable.up/0 forward
server # [  785.724907] mobilizon_ctl[1749]: 22:05:29.379 [info] execute "DO $$\nBEGIN\nIF NOT EXISTS (SELECT 1 FROM pg_type\n               WHERE typname = 'oban_job_state'\n                 AND typnamespace = 'public'::regnamespace::oid) THEN\n    CREATE TYPE \"public\".oban_job_state AS ENUM (\n      'available',\n      'scheduled',\n      'executing',\n      'retryable',\n      'completed',\n      'discarded'\n    );\n  END IF;\nEND$$;\n"
server # [  785.793057] mobilizon_ctl[1749]: 22:05:29.510 [info] create table if not exists public.oban_jobs
server # [  786.020773] mobilizon_ctl[1749]: 22:05:29.747 [info] create index if not exists public.oban_jobs_queue_index
server # [  786.107297] mobilizon_ctl[1749]: 22:05:29.827 [info] create index if not exists public.oban_jobs_state_index
server # [  786.177966] mobilizon_ctl[1749]: 22:05:29.903 [info] create index if not exists public.oban_jobs_scheduled_at_index
server # [  786.257128] mobilizon_ctl[1749]: 22:05:29.975 [info] execute "CREATE OR REPLACE FUNCTION \"public\".oban_jobs_notify() RETURNS trigger AS $$\nDECLARE\n  channel text;\n  notice json;\nBEGIN\n  IF (TG_OP = 'INSERT') THEN\n    channel = 'public.oban_insert';\n    notice = json_build_object('queue', NEW.queue, 'state', NEW.state);\n\n    -- No point triggering for a job that isn't scheduled to run now\n    IF NEW.scheduled_at IS NOT NULL AND NEW.scheduled_at > now() AT TIME ZONE 'utc' THEN\n      RETURN null;\n    END IF;\n  ELSE\n    channel = 'public.oban_update';\n    notice = json_build_object('queue', NEW.queue, 'new_state', NEW.state, 'old_state', OLD.state);\n  END IF;\n\n  PERFORM pg_notify(channel, notice::text);\n\n  RETURN NULL;\nEND;\n$$ LANGUAGE plpgsql;\n"
server # [  786.350473] mobilizon_ctl[1749]: 22:05:30.061 [info] execute "DROP TRIGGER IF EXISTS oban_notify ON \"public\".oban_jobs"
server # [  786.378315] mobilizon_ctl[1749]: 22:05:30.083 [info] trigger "oban_notify" for relation "public.oban_jobs" does not exist, skipping
server # [  786.397848] mobilizon_ctl[1749]: 22:05:30.087 [info] execute "CREATE TRIGGER oban_notify\nAFTER INSERT OR UPDATE OF state ON \"public\".oban_jobs\nFOR EACH ROW EXECUTE PROCEDURE \"public\".oban_jobs_notify();\n"
server # [  786.477246] mobilizon_ctl[1749]: 22:05:30.170 [info] drop index if exists public.oban_jobs_scheduled_at_index
server # [  786.527209] mobilizon_ctl[1749]: 22:05:30.235 [info] create index public.oban_jobs_scheduled_at_index
server # [  786.633322] mobilizon_ctl[1749]: 22:05:30.348 [info] create check constraint worker_length on table public.oban_jobs
server # [  786.658877] mobilizon_ctl[1749]: 22:05:30.398 [info] create check constraint queue_length on table public.oban_jobs
server # [  786.746938] mobilizon_ctl[1749]: 22:05:30.436 [info] execute "CREATE OR REPLACE FUNCTION \"public\".oban_wrap_id(value bigint) RETURNS int AS $$\nBEGIN\n  RETURN (CASE WHEN value > 2147483647 THEN mod(value, 2147483647) ELSE value END)::int;\nEND;\n$$ LANGUAGE plpgsql IMMUTABLE;\n"
server # [  786.772280] mobilizon_ctl[1749]: 22:05:30.483 [info] alter table public.oban_jobs
server # [  786.794734] mobilizon_ctl[1749]: 22:05:30.527 [info] execute "DROP FUNCTION IF EXISTS \"public\".oban_wrap_id(value bigint)"
server # [  786.840482] mobilizon_ctl[1749]: 22:05:30.559 [info] drop index if exists public.oban_jobs_scheduled_at_index
server # [  786.871541] mobilizon_ctl[1749]: 22:05:30.603 [info] drop index if exists public.oban_jobs_queue_index
server # [  786.913725] mobilizon_ctl[1749]: 22:05:30.630 [info] drop index if exists public.oban_jobs_state_index
server # [  786.936834] mobilizon_ctl[1749]: 22:05:30.658 [info] create index if not exists public.oban_jobs_queue_state_scheduled_at_id_index
server # [  786.992978] mobilizon_ctl[1749]: 22:05:30.723 [info] create index if not exists public.oban_jobs_attempted_at_id_index
server # [  787.060860] mobilizon_ctl[1749]: 22:05:30.795 [info] alter table public.oban_jobs
server # [  787.125229] mobilizon_ctl[1749]: 22:05:30.851 [info] alter table public.oban_jobs
server # [  787.177730] mobilizon_ctl[1749]: 22:05:30.902 [info] drop index if exists public.oban_jobs_queue_state_scheduled_at_id_index
server # [  787.200615] mobilizon_ctl[1749]: 22:05:30.927 [info] create index if not exists public.oban_jobs_state_queue_priority_scheduled_at_id_index
server # [  787.277571] mobilizon_ctl[1749]: 22:05:31.006 [info] execute "CREATE OR REPLACE FUNCTION \"public\".oban_jobs_notify() RETURNS trigger AS $$\nDECLARE\n  channel text;\n  notice json;\nBEGIN\n  IF NEW.state = 'available' THEN\n    channel = 'public.oban_insert';\n    notice = json_build_object('queue', NEW.queue);\n\n    PERFORM pg_notify(channel, notice::text);\n  END IF;\n\n  RETURN NULL;\nEND;\n$$ LANGUAGE plpgsql;\n"
server # [  787.308820] mobilizon_ctl[1749]: 22:05:31.039 [info] execute "DROP TRIGGER IF EXISTS oban_notify ON \"public\".oban_jobs"
server # [  787.342945] mobilizon_ctl[1749]: 22:05:31.067 [info] execute "CREATE TRIGGER oban_notify\nAFTER INSERT ON \"public\".oban_jobs\nFOR EACH ROW EXECUTE PROCEDURE \"public\".oban_jobs_notify();\n"
server # [  787.365039] mobilizon_ctl[1749]: 22:05:31.090 [info] alter table public.oban_jobs
server # [  787.759253] mobilizon_ctl[1749]: 22:05:31.452 [info] execute "DO $$\nDECLARE\n  version int;\n  already bool;\nBEGIN\n  SELECT current_setting('server_version_num')::int INTO version;\n  SELECT '{cancelled}' <@ enum_range(NULL::\"public\".oban_job_state)::text[] INTO already;\n\n  IF already THEN\n    RETURN;\n  ELSIF version >= 120000 THEN\n    ALTER TYPE \"public\".oban_job_state ADD VALUE IF NOT EXISTS 'cancelled';\n  ELSE\n    ALTER TYPE \"public\".oban_job_state RENAME TO old_oban_job_state;\n\n    CREATE TYPE \"public\".oban_job_state AS ENUM (\n      'available',\n      'scheduled',\n      'executing',\n      'retryable',\n      'completed',\n      'discarded',\n      'cancelled'\n    );\n\n    ALTER TABLE \"public\".oban_jobs RENAME column state TO _state;\n    ALTER TABLE \"public\".oban_jobs ADD state \"public\".oban_job_state NOT NULL default 'available';\n\n    UPDATE \"public\".oban_jobs SET state = _state::text::\"public\".oban_job_state;\n\n    ALTER TABLE \"public\".oban_jobs DROP column _state;\n    DROP TYPE \"public\".old_oban_job_state;\n  END IF;\nEND$$;\n"
server # [  787.808812] mobilizon_ctl[1749]: 22:05:31.550 [info] create index if not exists public.oban_jobs_state_queue_priority_scheduled_at_id_index
server # [  787.834463] mobilizon_ctl[1749]: 22:05:31.570 [info] relation "oban_jobs_state_queue_priority_scheduled_at_id_index" already exists, skipping
server # [  787.854186] mobilizon_ctl[1749]: 22:05:31.571 [info] alter table public.oban_jobs
server # [  787.963734] mobilizon_ctl[1749]: 22:05:31.692 [info] create check constraint priority_range on table public.oban_jobs
server # [  788.021522] mobilizon_ctl[1749]: 22:05:31.750 [info] create check constraint positive_max_attempts on table public.oban_jobs
server # [  788.056859] mobilizon_ctl[1749]: 22:05:31.787 [info] create check constraint attempt_range on table public.oban_jobs
server # [  788.099848] mobilizon_ctl[1749]: 22:05:31.823 [info] drop index if exists public.oban_jobs_args_vector
server # [  788.121611] mobilizon_ctl[1749]: 22:05:31.843 [info] index "oban_jobs_args_vector" does not exist, skipping
server # [  788.153367] mobilizon_ctl[1749]: 22:05:31.844 [info] drop index if exists public.oban_jobs_worker_gist
server # [  788.184935] mobilizon_ctl[1749]: 22:05:31.883 [info] index "oban_jobs_worker_gist" does not exist, skipping
server # [  788.213112] mobilizon_ctl[1749]: 22:05:31.884 [info] drop index if exists public.oban_jobs_attempted_at_id_index
server # [  788.225966] mobilizon_ctl[1749]: 22:05:31.941 [info] create index if not exists public.oban_jobs_args_index
server # [  788.279563] mobilizon_ctl[1749]: 22:05:32.012 [info] create index if not exists public.oban_jobs_meta_index
server # [  788.349741] mobilizon_ctl[1749]: 22:05:32.083 [info] create table if not exists public.oban_peers
server # [  788.481074] mobilizon_ctl[1749]: 22:05:32.214 [info] execute "ALTER TABLE \"public\".oban_peers SET UNLOGGED"
server # [  788.647928] mobilizon_ctl[1749]: 22:05:32.379 [info] drop constraint priority_range from table public.oban_jobs
server # [  788.681903] mobilizon_ctl[1749]: 22:05:32.411 [info] create check constraint non_negative_priority on table public.oban_jobs
server # [  788.774133] mobilizon_ctl[1749]: 22:05:32.450 [info] execute "DROP TRIGGER IF EXISTS oban_notify ON \"public\".oban_jobs"
server # [  788.786007] mobilizon_ctl[1749]: 22:05:32.486 [info] execute "DROP FUNCTION IF EXISTS \"public\".oban_jobs_notify()"
server # [  788.809634] mobilizon_ctl[1749]: 22:05:32.517 [info] create index if not exists public.oban_jobs_state_cancelled_at_index
server # [  788.865726] mobilizon_ctl[1749]: 22:05:32.598 [info] create index if not exists public.oban_jobs_state_discarded_at_index
server # [  788.934701] mobilizon_ctl[1749]: 22:05:32.647 [info] execute "COMMENT ON TABLE \"public\".oban_jobs IS '13'"
server # [  788.961193] mobilizon_ctl[1749]: 22:05:32.668 [info] == Migrated 20191104093447 in 5.1s
server # [  789.091402] mobilizon_ctl[1749]: 22:05:32.823 [info] == Running 20191106114524 Mobilizon.Storage.Repo.Migrations.RemoveFloorFromAddresses.up/0 forward
server # [  789.126224] mobilizon_ctl[1749]: 22:05:32.836 [info] alter table addresses
server # [  789.158545] mobilizon_ctl[1749]: 22:05:32.869 [info] == Migrated 20191106114524 in 0.0s
server # [  789.249221] mobilizon_ctl[1749]: 22:05:32.983 [info] == Running 20191106141051 Mobilizon.Storage.Repo.Migrations.AddTypeToAddresses.change/0 forward
server # [  789.266316] mobilizon_ctl[1749]: 22:05:32.991 [info] alter table addresses
server # [  789.303490] mobilizon_ctl[1749]: 22:05:33.027 [info] == Migrated 20191106141051 in 0.0s
server # [  789.388713] mobilizon_ctl[1749]: 22:05:33.123 [info] == Running 20191114155534 Mobilizon.Storage.Repo.Migrations.CascadeCommentDeletion.up/0 forward
server # [  789.413038] mobilizon_ctl[1749]: 22:05:33.138 [info] drop constraint comments_in_reply_to_comment_id_fkey from table comments
server # [  789.481623] mobilizon_ctl[1749]: 22:05:33.205 [info] drop constraint comments_origin_comment_id_fkey from table comments
server # [  789.531843] mobilizon_ctl[1749]: 22:05:33.254 [info] alter table comments
server # [  789.670926] mobilizon_ctl[1749]: 22:05:33.396 [info] == Migrated 20191114155534 in 0.2s
server # [  789.833618] mobilizon_ctl[1749]: 22:05:33.508 [info] == Running 20191122154018 Mobilizon.Storage.Repo.Migrations.AddDeletedAtOnComments.up/0 forward
server # [  789.855293] mobilizon_ctl[1749]: 22:05:33.531 [info] drop constraint if exists comments_actor_id_fkey from table comments
server # [  789.869958] mobilizon_ctl[1749]: 22:05:33.566 [info] constraint "comments_actor_id_fkey" of relation "comments" does not exist, skipping
server # [  789.882248] mobilizon_ctl[1749]: 22:05:33.567 [info] alter table comments
server # [  790.075254] mobilizon_ctl[1749]: 22:05:33.787 [info] == Migrated 20191122154018 in 0.2s
server # [  790.183495] mobilizon_ctl[1749]: 22:05:33.915 [info] == Running 20191126173510 Mobilizon.Storage.Repo.Migrations.AddLocalFieldToReports.up/0 forward
server # [  790.213153] mobilizon_ctl[1749]: 22:05:33.934 [info] alter table reports
server # [  790.274654] mobilizon_ctl[1749]: 22:05:33.989 [info] rename column uri to url on table reports
server # [  790.290464] mobilizon_ctl[1749]: 22:05:34.013 [info] == Migrated 20191126173510 in 0.0s
server # [  790.403395] mobilizon_ctl[1749]: 22:05:34.137 [info] == Running 20191127163737 Mobilizon.Repo.Migrations.CreateTombstones.change/0 forward
server # [  790.441887] mobilizon_ctl[1749]: 22:05:34.164 [info] create table tombstones
server # [  790.609879] mobilizon_ctl[1749]: 22:05:34.323 [info] create index tombstones_uri_index
server # [  790.663720] mobilizon_ctl[1749]: 22:05:34.390 [info] == Migrated 20191127163737 in 0.2s
server # [  790.777036] mobilizon_ctl[1749]: 22:05:34.508 [info] == Running 20191129091227 Mobilizon.Storage.Repo.Migrations.AddTimestampsToFollowers.change/0 forward
server # [  790.862957] mobilizon_ctl[1749]: 22:05:34.528 [info] alter table followers
server # [  790.889164] mobilizon_ctl[1749]: 22:05:34.600 [info] == Migrated 20191129091227 in 0.0s
server # [  790.992820] mobilizon_ctl[1749]: 22:05:34.723 [info] == Running 20191204164224 Mobilizon.Storage.Repo.Migrations.DeleteEventCascadeToComments.up/0 forward
server # [  791.025889] mobilizon_ctl[1749]: 22:05:34.751 [info] drop constraint if exists comments_event_id_fkey from table comments
server # [  791.084758] mobilizon_ctl[1749]: 22:05:34.814 [info] alter table comments
server # [  791.201046] mobilizon_ctl[1749]: 22:05:34.920 [info] == Migrated 20191204164224 in 0.1s
server # [  791.297506] mobilizon_ctl[1749]: 22:05:35.027 [info] == Running 20191206144028 Mobilizon.Repo.Migrations.CreateShares.up/0 forward
server # [  791.341367] mobilizon_ctl[1749]: 22:05:35.058 [info] create table shares
server # [  791.533200] mobilizon_ctl[1749]: 22:05:35.255 [info] create index if not exists shares_uri_actor_id_index
server # [  791.606910] mobilizon_ctl[1749]: 22:05:35.334 [info] == Migrated 20191206144028 in 0.3s
server # [  791.729056] mobilizon_ctl[1749]: 22:05:35.458 [info] == Running 20191219172017 Mobilizon.Storage.Repo.Migrations.AddMetadataToParticipant.up/0 forward
server # [  791.757562] mobilizon_ctl[1749]: 22:05:35.480 [info] drop index if exists participants_event_id_actor_id_index
server # [  791.803861] mobilizon_ctl[1749]: 22:05:35.530 [info] alter table participants
server # [  791.951714] mobilizon_ctl[1749]: 22:05:35.644 [info] execute "CREATE UNIQUE INDEX participants_metadata_confirmation_token_index ON participants((metadata->>'confirmation_token'))"
server # [  791.985136] mobilizon_ctl[1749]: 22:05:35.707 [info] == Migrated 20191219172017 in 0.2s
server # [  792.069368] mobilizon_ctl[1749]: 22:05:35.805 [info] == Running 20191223173537 Mobilizon.Storage.Repo.Migrations.AddNotConfirmedStatusToParticipants.up/0 forward
server # [  792.087141] mobilizon_ctl[1749]: 22:05:35.808 [info] execute "ALTER TYPE participant_role ADD VALUE IF NOT EXISTS 'not_confirmed'"
server # [  792.111090] mobilizon_ctl[1749]: 22:05:35.847 [info] enum label "not_confirmed" already exists, skipping
server # [  792.126963] mobilizon_ctl[1749]: 22:05:35.848 [info] == Migrated 20191223173537 in 0.0s
server # [  792.207381] mobilizon_ctl[1749]: 22:05:35.950 [info] == Running 20200116095117 Mobilizon.Repo.Migrations.CreateAdminSettings.change/0 forward
server # [  792.248051] mobilizon_ctl[1749]: 22:05:35.981 [info] create table admin_settings
server # [  792.384865] mobilizon_ctl[1749]: 22:05:36.120 [info] create index admin_settings_group_name_index
server # [  792.466365] mobilizon_ctl[1749]: 22:05:36.181 [info] == Migrated 20200116095117 in 0.2s
server # [  792.545632] mobilizon_ctl[1749]: 22:05:36.283 [info] == Running 20200210100910 Mobilizon.Storage.Repo.Migrations.AddUnconfirmedEmailToUsersTable.change/0 forward
server # [  792.576873] mobilizon_ctl[1749]: 22:05:36.296 [info] alter table users
server # [  792.608829] mobilizon_ctl[1749]: 22:05:36.340 [info] == Migrated 20200210100910 in 0.0s
server # [  792.692368] mobilizon_ctl[1749]: 22:05:36.423 [info] == Running 20200213154309 Mobilizon.Storage.Repo.Migrations.UpgradeObanJobsToV8.up/0 forward
server # [  792.777790] mobilizon_ctl[1749]: 22:05:36.499 [info] == Migrated 20200213154309 in 0.0s
server # [  792.873137] mobilizon_ctl[1749]: 22:05:36.599 [info] == Running 20200214135231 Mobilizon.Storage.Repo.Migrations.AddLastRefreshedAtToActors.change/0 forward
server # [  792.892498] mobilizon_ctl[1749]: 22:05:36.611 [info] alter table actors
server # [  792.985816] mobilizon_ctl[1749]: 22:05:36.659 [info] == Migrated 20200214135231 in 0.0s
server # [  793.053181] mobilizon_ctl[1749]: 22:05:36.776 [info] == Running 20200218085757 Mobilizon.Storage.Repo.Migrations.AddNewRolesToMember.up/0 forward
server # [  793.077005] mobilizon_ctl[1749]: 22:05:36.790 [info] execute "ALTER TYPE member_role ADD VALUE IF NOT EXISTS 'invited'"
server # [  793.100795] mobilizon_ctl[1749]: 22:05:36.827 [info] enum label "invited" already exists, skipping
server # [  793.133457] mobilizon_ctl[1749]: 22:05:36.835 [info] execute "ALTER TYPE member_role ADD VALUE IF NOT EXISTS 'rejected'"
server # [  793.153588] mobilizon_ctl[1749]: 22:05:36.863 [info] enum label "rejected" already exists, skipping
server # [  793.169537] mobilizon_ctl[1749]: 22:05:36.864 [info] == Migrated 20200218085757 in 0.0s
server # [  793.264854] mobilizon_ctl[1749]: 22:05:36.992 [info] == Running 20200218170232 Mobilizon.Storage.Repo.Migrations.MoveMemberIdToUuid.up/0 forward
server # [  793.298101] mobilizon_ctl[1749]: 22:05:37.008 [info] alter table members
server # [  793.464922] mobilizon_ctl[1749]: 22:05:37.182 [info] == Migrated 20200218170232 in 0.1s
server # [  793.593006] mobilizon_ctl[1749]: 22:05:37.319 [info] == Running 20200219152611 Mobilizon.Storage.Repo.Migrations.AddMembersEndpointToActors.up/0 forward
server # [  793.618462] mobilizon_ctl[1749]: 22:05:37.338 [info] alter table actors
server # [  793.679108] mobilizon_ctl[1749]: 22:05:37.398 [info] == Migrated 20200219152611 in 0.0s
server # [  793.821855] mobilizon_ctl[1749]: 22:05:37.543 [info] == Running 20200221095721 Mobilizon.Repo.Migrations.CreateTodos.change/0 forward
server # [  793.901401] mobilizon_ctl[1749]: 22:05:37.618 [info] create table todo_lists
server # [  794.242318] mobilizon_ctl[1749]: 22:05:37.899 [info] create table todos
server # [  794.488870] mobilizon_ctl[1749]: 22:05:38.191 [info] == Migrated 20200221095721 in 0.6s
server # [  794.571381] mobilizon_ctl[1749]: 22:05:38.307 [info] == Running 20200221160744 Mobilizon.Repo.Migrations.CreateResources.change/0 forward
server # [  794.613407] mobilizon_ctl[1749]: 22:05:38.340 [info] create table resource
server # [  794.883569] mobilizon_ctl[1749]: 22:05:38.603 [info] == Migrated 20200221160744 in 0.2s
server # [  795.012880] mobilizon_ctl[1749]: 22:05:38.735 [info] == Running 20200406115807 Mobilizon.Storage.Repo.Migrations.AddConversations.change/0 forward
server # [  795.051794] mobilizon_ctl[1749]: 22:05:38.764 [info] create table conversations
server # [  795.389830] mobilizon_ctl[1749]: 22:05:39.082 [info] alter table comments
server # [  795.436389] mobilizon_ctl[1749]: 22:05:39.163 [info] == Migrated 20200406115807 in 0.4s
server # [  795.532846] mobilizon_ctl[1749]: 22:05:39.267 [info] == Running 20200410100554 Mobilizon.Storage.Repo.Migrations.AddNumberEditsToComment.change/0 forward
server # [  795.552883] mobilizon_ctl[1749]: 22:05:39.275 [info] alter table comments
server # [  795.598305] mobilizon_ctl[1749]: 22:05:39.326 [info] == Migrated 20200410100554 in 0.0s
server # [  795.687287] mobilizon_ctl[1749]: 22:05:39.416 [info] == Running 20200513142813 Mobilizon.Storage.Repo.Migrations.AddResourcesAndTodosEndpointsToActor.change/0 forward
server # [  795.705898] mobilizon_ctl[1749]: 22:05:39.426 [info] alter table actors
server # [  795.756915] mobilizon_ctl[1749]: 22:05:39.483 [info] == Migrated 20200513142813 in 0.0s
server # [  795.836851] mobilizon_ctl[1749]: 22:05:39.572 [info] == Running 20200514101612 Mobilizon.Storage.Repo.Migrations.AddLocalAttributeToResourcesAndTodos.change/0 forward
server # [  795.862174] mobilizon_ctl[1749]: 22:05:39.587 [info] alter table resource
server # [  795.899052] mobilizon_ctl[1749]: 22:05:39.631 [info] alter table todo_lists
server # [  795.946678] mobilizon_ctl[1749]: 22:05:39.678 [info] alter table todos
server # [  795.997115] mobilizon_ctl[1749]: 22:05:39.728 [info] == Migrated 20200514101612 in 0.1s
server # [  796.090882] mobilizon_ctl[1749]: 22:05:39.823 [info] == Running 20200518084949 Mobilizon.Storage.Repo.Migrations.MoveInviterFromMetadataToMemberTable.change/0 forward
server # [  796.105914] mobilizon_ctl[1749]: 22:05:39.835 [info] alter table members
server # [  796.225229] mobilizon_ctl[1749]: 22:05:39.953 [info] == Migrated 20200518084949 in 0.1s
server # [  796.301233] mobilizon_ctl[1749]: 22:05:40.043 [info] == Running 20200519082820 Mobilizon.Storage.Repo.Migrations.AddUniqueURLContraintToSomeTables.change/0 forward
server # [  796.334219] mobilizon_ctl[1749]: 22:05:40.063 [info] create index members_url_index
server # [  796.434867] mobilizon_ctl[1749]: 22:05:40.120 [info] create index resource_url_index
server # [  796.458406] mobilizon_ctl[1749]: 22:05:40.183 [info] create index todo_lists_url_index
server # [  796.510463] mobilizon_ctl[1749]: 22:05:40.247 [info] create index todos_url_index
server # [  796.574294] mobilizon_ctl[1749]: 22:05:40.299 [info] == Migrated 20200519082820 in 0.2s
server # [  796.685571] mobilizon_ctl[1749]: 22:05:40.416 [info] == Running 20200526131523 Mobilizon.Repo.Migrations.CreateUserSettings.change/0 forward
server # [  796.725905] mobilizon_ctl[1749]: 22:05:40.443 [info] create table user_settings
server # [  796.841521] mobilizon_ctl[1749]: 22:05:40.555 [info] == Migrated 20200526131523 in 0.1s
server # [  796.936903] mobilizon_ctl[1749]: 22:05:40.678 [info] == Running 20200605154921 Mobilizon.Storage.Repo.Migrations.AddNotificationPendingParticipationToSettings.change/0 forward
server # [  796.965795] mobilizon_ctl[1749]: 22:05:40.698 [info] alter table user_settings
server # [  797.014028] mobilizon_ctl[1749]: 22:05:40.742 [info] == Migrated 20200605154921 in 0.0s
server # [  797.110395] mobilizon_ctl[1749]: 22:05:40.835 [info] == Running 20200612155254 Mobilizon.Storage.Repo.Migrations.AddDisabledParameterToUsers.change/0 forward
server # [  797.137035] mobilizon_ctl[1749]: 22:05:40.851 [info] alter table users
server # [  797.197514] mobilizon_ctl[1749]: 22:05:40.907 [info] == Migrated 20200612155254 in 0.0s
server # [  797.297151] mobilizon_ctl[1749]: 22:05:41.032 [info] == Running 20200630123819 Mobilizon.Storage.Repo.Migrations.AddProviderToUserAndMakePasswordMandatory.up/0 forward
server # [  797.332649] mobilizon_ctl[1749]: 22:05:41.044 [info] alter table users
server # [  797.387091] mobilizon_ctl[1749]: 22:05:41.119 [info] == Migrated 20200630123819 in 0.0s
server # [  797.523872] mobilizon_ctl[1749]: 22:05:41.211 [info] == Running 20200708080516 Mobilizon.Repo.Migrations.CreatePosts.up/0 forward
server # [  797.634292] mobilizon_ctl[1749]: 22:05:41.371 [info] execute "CREATE TYPE public.post_visibility AS ENUM ('public', 'unlisted', 'restricted', 'private')"
server # [  797.686319] mobilizon_ctl[1749]: 22:05:41.410 [info] create table posts
server # [  797.927481] mobilizon_ctl[1749]: 22:05:41.651 [info] create table posts_tags
server # [  798.031165] mobilizon_ctl[1749]: 22:05:41.760 [info] alter table actors
server # [  798.078243] mobilizon_ctl[1749]: 22:05:41.814 [info] == Migrated 20200708080516 in 0.5s
server # [  798.183346] mobilizon_ctl[1749]: 22:05:41.920 [info] == Running 20200717142633 Mobilizon.Storage.Repo.Migrations.RenameConversationsToDiscussions.up/0 forward
server # [  798.228690] mobilizon_ctl[1749]: 22:05:41.949 [info] rename table conversations to discussions
server # [  798.281065] mobilizon_ctl[1749]: 22:05:41.979 [info] rename column conversation_id to discussion_id on table comments
server # [  798.301796] mobilizon_ctl[1749]: 22:05:42.007 [info] alter table actors
server # [  798.351306] mobilizon_ctl[1749]: 22:05:42.075 [info] == Migrated 20200717142633 in 0.1s
server # [  798.473425] mobilizon_ctl[1749]: 22:05:42.200 [info] == Running 20200721131521 Mobilizon.Storage.Repo.Migrations.AddUrlToConversation.up/0 forward
server # [  798.574223] mobilizon_ctl[1749]: 22:05:42.240 [info] drop constraint if exists comments_conversation_id_fkey from table comments
server # [  798.605556] mobilizon_ctl[1749]: 22:05:42.329 [info] drop constraint if exists comments_discussion_id_fkey from table comments
server # [  798.638752] mobilizon_ctl[1749]: 22:05:42.347 [info] constraint "comments_discussion_id_fkey" of relation "comments" does not exist, skipping
server # [  798.662086] mobilizon_ctl[1749]: 22:05:42.348 [info] alter table discussions
server # [  798.781069] mobilizon_ctl[1749]: 22:05:42.504 [info] alter table comments
server # [  798.901763] mobilizon_ctl[1749]: 22:05:42.619 [info] == Migrated 20200721131521 in 0.4s
server # [  799.026856] mobilizon_ctl[1749]: 22:05:42.764 [info] == Running 20200805124620 Mobilizon.Storage.Repo.Migrations.AddAddressToActors.change/0 forward
server # [  799.065242] mobilizon_ctl[1749]: 22:05:42.786 [info] alter table actors
server # [  799.196549] mobilizon_ctl[1749]: 22:05:42.919 [info] == Migrated 20200805124620 in 0.1s
server # [  799.294882] mobilizon_ctl[1749]: 22:05:43.027 [info] == Running 20200817080549 Mobilizon.Storage.Repo.Migrations.AddPublishedAtToEntities.up/0 forward
server # [  799.321906] mobilizon_ctl[1749]: 22:05:43.035 [info] alter table comments
server # [  799.412941] mobilizon_ctl[1749]: 22:05:43.124 [info] alter table resource
server # [  799.509801] mobilizon_ctl[1749]: 22:05:43.221 [info] alter table todo_lists
server # [  799.646927] mobilizon_ctl[1749]: 22:05:43.318 [info] alter table todos
server # [  799.714068] mobilizon_ctl[1749]: 22:05:43.424 [info] == Migrated 20200817080549 in 0.3s
server # [  799.825794] mobilizon_ctl[1749]: 22:05:43.552 [info] == Running 20200828071543 Mobilizon.Storage.Repo.Migrations.AddLoginInformationToUser.change/0 forward
server # [  799.851269] mobilizon_ctl[1749]: 22:05:43.567 [info] alter table users
server # [  799.915041] mobilizon_ctl[1749]: 22:05:43.642 [info] == Migrated 20200828071543 in 0.0s
server # [  800.051119] mobilizon_ctl[1749]: 22:05:43.780 [info] == Running 20200901101307 Mobilizon.Storage.Repo.Migrations.FixRelayVisibility.up/0 forward
server # [  800.255599] mobilizon_ctl[1749]: 22:05:43.968 [info] == Migrated 20200901101307 in 0.1s
server # [  800.365351] mobilizon_ctl[1749]: 22:05:44.099 [info] == Running 20200928150725 Mobilizon.Storage.Repo.Migrations.AddContactsToEvents.change/0 forward
server # [  800.397231] mobilizon_ctl[1749]: 22:05:44.112 [info] create table event_contacts
server # [  800.563875] mobilizon_ctl[1749]: 22:05:44.277 [info] == Migrated 20200928150725 in 0.1s
server # [  800.737238] mobilizon_ctl[1749]: 22:05:44.397 [info] == Running 20201006132530 Mobilizon.Storage.Repo.Migrations.ChangeDefaultNotificationPendingParticipation.up/0 forward
server # [  800.754170] mobilizon_ctl[1749]: 22:05:44.400 [info] alter table user_settings
server # [  800.793355] mobilizon_ctl[1749]: 22:05:44.515 [info] == Migrated 20201006132530 in 0.1s
server # [  800.889841] mobilizon_ctl[1749]: 22:05:44.620 [info] == Running 20201103141811 Mobilizon.Storage.Repo.Migrations.AddNotificationPendingMembershipToSettings.change/0 forward
server # [  800.903434] mobilizon_ctl[1749]: 22:05:44.630 [info] alter table user_settings
server # [  800.952633] mobilizon_ctl[1749]: 22:05:44.677 [info] == Migrated 20201103141811 in 0.0s
server # [  801.057993] mobilizon_ctl[1749]: 22:05:44.780 [info] == Running 20201105145719 Mobilizon.Storage.Repo.Migrations.RepairGroupsWithMissingURLs.up/0 forward
server # [  801.443049] mobilizon_ctl[1749]: 22:05:45.164 [info] == Migrated 20201105145719 in 0.3s
server # [  801.554562] mobilizon_ctl[1749]: 22:05:45.282 [info] == Running 20201114174929 Mobilizon.Storage.Repo.Migrations.FixObanMigrationsForOlderPostgreSQLVersions.up/0 forward
server # [  801.594990] mobilizon_ctl[1749]: 22:05:45.319 [info] == Migrated 20201114174929 in 0.0s
server # [  801.755300] mobilizon_ctl[1749]: 22:05:45.423 [info] == Running 20201114175249 Mobilizon.Storage.Repo.Migrations.UpgradeObanJobsToV9.up/0 forward
server # [  801.842395] mobilizon_ctl[1749]: 22:05:45.559 [info] == Migrated 20201114175249 in 0.1s
server # [  801.934940] mobilizon_ctl[1749]: 22:05:45.671 [info] == Running 20201120161229 Mobilizon.Storage.Repo.Migrations.FixPictureDeletion.up/0 forward
server # [  801.974277] mobilizon_ctl[1749]: 22:05:45.703 [info] drop constraint if exists posts_picture_id_fkey from table posts
server # [  802.050845] mobilizon_ctl[1749]: 22:05:45.775 [info] alter table posts
server # [  802.126825] mobilizon_ctl[1749]: 22:05:45.866 [info] drop constraint if exists events_picture_id_fkey from table events
server # [  802.189558] mobilizon_ctl[1749]: 22:05:45.919 [info] alter table events
server # [  802.306373] mobilizon_ctl[1749]: 22:05:46.019 [info] == Migrated 20201120161229 in 0.3s
server # [  802.401105] mobilizon_ctl[1749]: 22:05:46.131 [info] == Running 20201124094655 Mobilizon.Storage.Repo.Migrations.AddMediaTables.change/0 forward
server # [  802.435119] mobilizon_ctl[1749]: 22:05:46.172 [info] rename table pictures to medias
server # [  802.493342] mobilizon_ctl[1749]: 22:05:46.219 [info] create table events_medias
server # [  802.685920] mobilizon_ctl[1749]: 22:05:46.401 [info] create table posts_medias
server # [  802.914196] mobilizon_ctl[1749]: 22:05:46.586 [info] create table comments_medias
server # [  803.045764] mobilizon_ctl[1749]: 22:05:46.764 [info] == Migrated 20201124094655 in 0.6s
server # [  803.181063] mobilizon_ctl[1749]: 22:05:46.900 [info] == Running 20210127153325 Mobilizon.Storage.Repo.Migrations.UpgradeObanJobsToV10.up/0 forward
server # [  803.264188] mobilizon_ctl[1749]: 22:05:46.986 [info] == Migrated 20210127153325 in 0.0s
server # [  803.365475] mobilizon_ctl[1749]: 22:05:47.099 [info] == Running 20210210143432 Mobilizon.Storage.Repo.Migrations.AddLocationSettingsToUser.change/0 forward
server # [  803.409132] mobilizon_ctl[1749]: 22:05:47.123 [info] alter table user_settings
server # [  803.533836] mobilizon_ctl[1749]: 22:05:47.243 [info] == Migrated 20210210143432 in 0.1s
server # [  803.634555] mobilizon_ctl[1749]: 22:05:47.369 [info] == Running 20210215092515 Mobilizon.Storage.Repo.Migrations.AddActivityTable.change/0 forward
server # [  803.673247] mobilizon_ctl[1749]: 22:05:47.406 [info] create table activities
server # [  804.038096] mobilizon_ctl[1749]: 22:05:47.722 [info] == Migrated 20210215092515 in 0.3s
server # [  804.137103] mobilizon_ctl[1749]: 22:05:47.870 [info] == Running 20210217164549 Mobilizon.Storage.Repo.Migrations.AddMemberSinceToMembers.up/0 forward
server # [  804.169369] mobilizon_ctl[1749]: 22:05:47.879 [info] alter table members
server # [  804.315385] mobilizon_ctl[1749]: 22:05:48.039 [info] == Migrated 20210217164549 in 0.1s
server # [  804.388802] mobilizon_ctl[1749]: 22:05:48.123 [info] == Running 20210310084210 Mobilizon.Storage.Repo.Migrations.AddIndexesToActivities.change/0 forward
server # [  804.409546] mobilizon_ctl[1749]: 22:05:48.131 [info] create index activity_group_id
server # [  804.446902] mobilizon_ctl[1749]: 22:05:48.185 [info] create index activity_filter
server # [  804.500785] mobilizon_ctl[1749]: 22:05:48.236 [info] == Migrated 20210310084210 in 0.1s
server # [  804.595072] mobilizon_ctl[1749]: 22:05:48.328 [info] == Running 20210422140923 Mobilizon.Storage.Repo.Migrations.CleanupAddresses.up/0 forward
server # [  804.686051] mobilizon_ctl[1749]: 22:05:48.411 [info] == Migrated 20210422140923 in 0.0s
server # [  804.766564] mobilizon_ctl[1749]: 22:05:48.513 [info] == Running 20210422155913 Mobilizon.Storage.Repo.Migrations.AddIndexToAddresses.up/0 forward
server # [  804.795901] mobilizon_ctl[1749]: 22:05:48.525 [info] create index if not exists addresses_url_index
server # [  804.855018] mobilizon_ctl[1749]: 22:05:48.579 [info] == Migrated 20210422155913 in 0.0s
server # [  804.934890] mobilizon_ctl[1749]: 22:05:48.668 [info] == Running 20210427091034 Mobilizon.Storage.Repo.Migrations.RepairUsersDefaultActors.up/0 forward
server # [  805.043167] mobilizon_ctl[1749]: 22:05:48.724 [info] == Migrated 20210427091034 in 0.0s
server # [  805.101034] mobilizon_ctl[1749]: 22:05:48.831 [info] == Running 20210505172402 Mobilizon.Storage.Repo.Migrations.AddGroupNotificationAndLastNotificationDateSettings.change/0 forward
server # [  805.122031] mobilizon_ctl[1749]: 22:05:48.846 [info] alter table user_settings
server # [  805.165068] mobilizon_ctl[1749]: 22:05:48.897 [info] == Migrated 20210505172402 in 0.0s
server # [  805.250457] mobilizon_ctl[1749]: 22:05:48.983 [info] == Running 20210506080303 Mobilizon.Repo.Migrations.CreateUserPushSubscriptions.change/0 forward
server # [  805.281675] mobilizon_ctl[1749]: 22:05:49.007 [info] create table user_push_subscriptions
server # [  805.423702] mobilizon_ctl[1749]: 22:05:49.158 [info] create index user_push_subscriptions_user_id_digest_index
server # [  805.491582] mobilizon_ctl[1749]: 22:05:49.218 [info] == Migrated 20210506080303 in 0.2s
server # [  805.593798] mobilizon_ctl[1749]: 22:05:49.319 [info] == Running 20210512084824 Mobilizon.Storage.Repo.Migrations.RepairRelayAndAnonymousActors.up/0 forward
server # [  805.660765] mobilizon_ctl[1749]: 22:05:49.383 [info] == Migrated 20210512084824 in 0.0s
server # [  805.744953] mobilizon_ctl[1749]: 22:05:49.472 [info] == Running 20210526203337 Mobilizon.Storage.Repo.Migrations.AddUserActivitySettings.change/0 forward
server # [  805.770302] mobilizon_ctl[1749]: 22:05:49.496 [info] create table user_activity_settings
server # [  805.939162] mobilizon_ctl[1749]: 22:05:49.673 [info] create index user_activity_settings_user_id_key_method_index
server # [  806.054844] mobilizon_ctl[1749]: 22:05:49.741 [info] == Migrated 20210526203337 in 0.2s
server # [  806.101533] mobilizon_ctl[1749]: 22:05:49.831 [info] == Running 20210601082412 Mobilizon.Storage.Repo.Migrations.AddIsAnnouncementToComments.change/0 forward
server # [  806.117097] mobilizon_ctl[1749]: 22:05:49.843 [info] alter table comments
server # [  806.160795] mobilizon_ctl[1749]: 22:05:49.894 [info] == Migrated 20210601082412 in 0.0s
server # [  806.270967] mobilizon_ctl[1749]: 22:05:49.995 [info] == Running 20210601082613 Mobilizon.Storage.Repo.Migrations.FixUserSettingsNullableFields.change/0 forward
server # [  806.300899] mobilizon_ctl[1749]: 22:05:50.020 [info] alter table user_settings
server # [  806.353158] mobilizon_ctl[1749]: 22:05:50.087 [info] == Migrated 20210601082613 in 0.0s
server # [  806.440685] mobilizon_ctl[1749]: 22:05:50.175 [info] == Running 20210608133040 Mobilizon.Storage.Repo.Migrations.AddMetadataToMedia.change/0 forward
server # [  806.462918] mobilizon_ctl[1749]: 22:05:50.184 [info] alter table medias
server # [  806.500981] mobilizon_ctl[1749]: 22:05:50.228 [info] == Migrated 20210608133040 in 0.0s
server # [  806.605729] mobilizon_ctl[1749]: 22:05:50.335 [info] == Running 20210622133516 Mobilizon.Storage.Repo.Migrations.CleanupPosts.up/0 forward
server # [  806.667533] mobilizon_ctl[1749]: 22:05:50.405 [info] == Migrated 20210622133516 in 0.0s
server # [  806.763008] mobilizon_ctl[1749]: 22:05:50.506 [info] == Running 20210622133555 Mobilizon.Storage.Repo.Migrations.AddIndexToPosts.up/0 forward
server # [  806.785287] mobilizon_ctl[1749]: 22:05:50.523 [info] create index if not exists posts_url_index
server # [  806.849918] mobilizon_ctl[1749]: 22:05:50.579 [info] == Migrated 20210622133555 in 0.0s
server # [  806.976963] mobilizon_ctl[1749]: 22:05:50.708 [info] == Running 20210730143924 Mobilizon.Storage.Repo.Migrations.PutUniqueIndexOnParticipantsUrls.up/0 forward
server # [  806.993604] mobilizon_ctl[1749]: 22:05:50.720 [info] create index if not exists participants_url_index
server # [  807.130240] mobilizon_ctl[1749]: 22:05:50.799 [info] == Migrated 20210730143924 in 0.0s
server # [  807.209012] mobilizon_ctl[1749]: 22:05:50.936 [info] == Running 20210805142745 Mobilizon.Storage.Repo.Migrations.AddMetadataForEvents.change/0 forward
server # [  807.223886] mobilizon_ctl[1749]: 22:05:50.951 [info] alter table events
server # [  807.284698] mobilizon_ctl[1749]: 22:05:50.999 [info] == Migrated 20210805142745 in 0.0s
server # [  807.388929] mobilizon_ctl[1749]: 22:05:51.124 [info] == Running 20210819161507 Mobilizon.Storage.Repo.Migrations.AddLanguageToEntities.change/0 forward
server # [  807.420629] mobilizon_ctl[1749]: 22:05:51.140 [info] alter table events
server # [  807.487063] mobilizon_ctl[1749]: 22:05:51.207 [info] alter table comments
server # [  807.538264] mobilizon_ctl[1749]: 22:05:51.264 [info] alter table posts
server # [  807.628958] mobilizon_ctl[1749]: 22:05:51.352 [info] == Migrated 20210819161507 in 0.2s
server # [  807.731051] mobilizon_ctl[1749]: 22:05:51.474 [info] == Running 20211001101902 Mobilizon.Repo.Migrations.CreateExports.change/0 forward
server # [  807.783356] mobilizon_ctl[1749]: 22:05:51.504 [info] create table exports
server # [  807.991577] mobilizon_ctl[1749]: 22:05:51.711 [info] create index exports_file_path_index
server # [  808.053130] mobilizon_ctl[1749]: 22:05:51.772 [info] == Migrated 20211001101902 in 0.2s
server # [  808.195367] mobilizon_ctl[1749]: 22:05:51.884 [info] == Running 20211008084901 Mobilizon.Storage.Repo.Migrations.AddTimezoneToAddresses.change/0 forward
server # [  808.210156] mobilizon_ctl[1749]: 22:05:51.896 [info] alter table addresses
server # [  808.229801] mobilizon_ctl[1749]: 22:05:51.931 [info] == Migrated 20211008084901 in 0.0s
server # [  808.334209] mobilizon_ctl[1749]: 22:05:52.067 [info] == Running 20211013090405 Mobilizon.Storage.Repo.Migrations.AddCodeToParticipants.change/0 forward
server # [  808.361617] mobilizon_ctl[1749]: 22:05:52.076 [info] alter table participants
server # [  808.401413] mobilizon_ctl[1749]: 22:05:52.132 [info] == Migrated 20211013090405 in 0.0s
server # [  808.523623] mobilizon_ctl[1749]: 22:05:52.255 [info] == Running 20211022093530 Mobilizon.Storage.Repo.Migrations.AddNotifyToFollowers.change/0 forward
server # [  808.554128] mobilizon_ctl[1749]: 22:05:52.267 [info] alter table followers
server # [  808.610680] mobilizon_ctl[1749]: 22:05:52.331 [info] == Migrated 20211022093530 in 0.0s
server # [  808.722502] mobilizon_ctl[1749]: 22:05:52.459 [info] == Running 20211223141104 Mobilizon.Storage.Repo.Migrations.AddInstanceMaterializedView.up/0 forward
server # [  808.840778] mobilizon_ctl[1749]: 22:05:52.559 [info] execute "CREATE MATERIALIZED VIEW instances AS\nSELECT\n  a.domain,\n  COUNT(DISTINCT(p.id)) AS person_count,\n  COUNT(DISTINCT(g.id)) AS group_count,\n  COUNT(DISTINCT(e.id)) AS event_count,\n  COUNT(f1.id) AS followers_count,\n  COUNT(f2.id) AS followings_count,\n  COUNT(r.id) AS reports_count,\n  SUM(COALESCE((m.file->>'size')::int, 0)) AS media_size\nFROM actors a\nLEFT JOIN actors p ON a.id = p.id AND p.type = 'Person'\nLEFT JOIN actors g ON a.id = g.id AND g.type = 'Group'\nLEFT JOIN events e ON a.id = e.organizer_actor_id\nLEFT JOIN followers f1 ON a.id = f1.actor_id\nLEFT JOIN followers f2 ON a.id = f2.target_actor_id\nLEFT JOIN reports r ON r.reported_id = a.id\nLEFT JOIN medias m ON m.actor_id = a.id\nWHERE a.domain IS NOT NULL\nGROUP BY a.domain;\n"
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  809.890799] mobilizon_ctl[1749]: 22:05:53.580 [info] execute "CREATE OR REPLACE FUNCTION refresh_instances()\nRETURNS trigger AS $$\nBEGIN\n  REFRESH MATERIALIZED VIEW instances;\n  RETURN NULL;\nEND;\n$$ LANGUAGE plpgsql;\n"
server # [  809.916929] mobilizon_ctl[1749]: 22:05:53.627 [info] execute "DROP TRIGGER IF EXISTS refresh_instances_trigger ON actors;\n"
server # [  809.953474] mobilizon_ctl[1749]: 22:05:53.659 [info] trigger "refresh_instances_trigger" for relation "actors" does not exist, skipping
server # [  809.970592] mobilizon_ctl[1749]: 22:05:53.660 [info] execute "CREATE TRIGGER refresh_instances_trigger\nAFTER INSERT OR UPDATE OR DELETE\nON actors\nFOR EACH STATEMENT\nEXECUTE PROCEDURE refresh_instances();\n"
server # [  809.984006] mobilizon_ctl[1749]: 22:05:53.687 [info] create index if not exists instances_domain_index
server # [  810.124028] mobilizon_ctl[1749]: 22:05:53.839 [info] == Migrated 20211223141104 in 1.3s
server # [  810.242298] mobilizon_ctl[1749]: 22:05:53.963 [info] == Running 20220321154138 Mobilizon.Storage.Repo.Migrations.CreateObanPeers.up/0 forward
server # [  810.309110] mobilizon_ctl[1749]: 22:05:54.035 [info] == Migrated 20220321154138 in 0.0s
server # [  810.397605] mobilizon_ctl[1749]: 22:05:54.134 [info] == Running 20220321154142 Mobilizon.Storage.Repo.Migrations.SwapPrimaryObanIndexes.change/0 forward
server # [  810.427303] mobilizon_ctl[1749]: 22:05:54.148 [info] create index if not exists public.oban_jobs_state_queue_priority_scheduled_at_id_index
server # [  810.466170] mobilizon_ctl[1749]: 22:05:54.202 [info] relation "oban_jobs_state_queue_priority_scheduled_at_id_index" already exists, skipping
server # [  810.505039] mobilizon_ctl[1749]: 22:05:54.203 [info] drop index if exists public.oban_jobs_queue_state_priority_scheduled_at_id_index
server # [  810.529131] mobilizon_ctl[1749]: 22:05:54.236 [info] index "oban_jobs_queue_state_priority_scheduled_at_id_index" does not exist, skipping
server # [  810.546096] mobilizon_ctl[1749]: 22:05:54.246 [info] == Migrated 20220321154142 in 0.1s
server # [  810.597193] systemd[1]: mobilizon.service: start-pre operation timed out. Terminating.
server # [  810.617420] systemd[1]: mobilizon.service: Control process exited, code=killed, status=15/TERM
server # [  810.963922] mobilizon_ctl[1749]: 22:05:54.348 [notice] SIGTERM received - shutting down
server # [  810.997693] mobilizon_ctl[1749]: 22:05:54.628 [notice] SIGTERM received - shutting down
server # [  811.110003] mobilizon_ctl[1749]: 22:05:54.648 [info] == Running 20220328153640 Mobilizon.Storage.Repo.Migrations.SetAllEventsCategoryToMeeting.up/0 forward
server # [  811.429789] mobilizon_ctl[1749]: 22:05:54.709 [info] execute "UPDATE events SET category = 'MEETING'"
server # [  811.720684] mobilizon_ctl[1749]: ** (EXIT from #PID<0.94.0>) shutdown
server # [  811.862353] postgres[1888]: [1888] LOG:  unexpected EOF on client connection with an open transaction
server # [  811.943842] postgres[1887]: [1887] LOG:  could not receive data from client: Connection reset by peer
server # [  811.971199] postgres[1887]: [1887] LOG:  unexpected EOF on client connection with an open transaction
server # [  812.417291] systemd[1]: mobilizon.service: Failed with result 'timeout'.
server # [  812.437718] systemd[1]: Failed to start Mobilizon federated organization and mobilization platform.
server # [  812.471887] systemd[1]: mobilizon.service: Consumed 1min 47.888s CPU time over 5min 1.785s wall clock time, 80.7M memory peak.
server # [  812.938910] systemd[1]: mobilizon.service: Scheduled restart job, restart counter is at 1.
server # [  813.141955] systemd[1]: Starting Mobilizon PostgreSQL setup...
server # [  820.606023] mobilizon-postgresql-start[2218]: NOTICE:  extension "postgis" already exists, skipping
server # [  820.629892] mobilizon-postgresql-start[2218]: NOTICE:  extension "pg_trgm" already exists, skipping
server # [  820.631990] mobilizon-postgresql-start[2218]: NOTICE:  extension "unaccent" already exists, skipping
server # [  820.642856] mobilizon-postgresql-start[2218]: CREATE EXTENSION
server # [  820.673791] mobilizon-postgresql-start[2218]: CREATE EXTENSION
server # [  820.683380] mobilizon-postgresql-start[2218]: CREATE EXTENSION
server # [  822.066102] mobilizon-postgresql-start[2223]: ALTER DATABASE
server # [  822.143155] systemd[1]: mobilizon-postgresql.service: Deactivated successfully.
server # [  822.159220] systemd[1]: Finished Mobilizon PostgreSQL setup.
server # [  822.184019] systemd[1]: mobilizon-postgresql.service: Consumed 2.378s CPU time over 8.988s wall clock time, 1.9M memory peak.
server # [  822.389428] systemd[1]: Starting Mobilizon setup secrets...
server # [  823.311113] mobilizon-setup-secrets-start[2226]: + '[' '!' -f /var/lib/mobilizon/secret-env.sh ']'
server # [  823.351453] systemd[1]: mobilizon-setup-secrets.service: Deactivated successfully.
server # [  823.362391] systemd[1]: Finished Mobilizon setup secrets.
server # [  823.475872] systemd[1]: Starting Mobilizon federated organization and mobilization platform...
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  857.555056] postgres[1373]: [1373] LOG:  checkpoint complete: wrote 1941 buffers (11.8%); 0 WAL file(s) added, 0 removed, 1 recycled; write=202.244 s, sync=1.917 s, total=204.371 s; sync files=600, longest=0.027 s, average=0.004 s; distance=13867 kB, estimate=13867 kB; lsn=0/25160D8, redo lsn=0/2277C50
server # [  869.089286] mobilizon_ctl[2235]: Loading app..
server # [  869.104556] mobilizon_ctl[2235]: Starting dependencies..
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  900.677505] systemd[1]: Starting Cleanup of Temporary Directories...
server # [  906.753749] systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully.
server # [  906.771090] systemd[1]: Finished Cleanup of Temporary Directories.
server # [  918.599266] mobilizon_ctl[2235]: 22:07:42.102 [info] == Running 20220328153640 Mobilizon.Storage.Repo.Migrations.SetAllEventsCategoryToMeeting.up/0 forward
server # [  918.694913] mobilizon_ctl[2235]: 22:07:42.419 [info] execute "UPDATE events SET category = 'MEETING'"
server # [  918.835174] mobilizon_ctl[2235]: 22:07:42.564 [info] == Migrated 20220328153640 in 0.2s
server # [  921.407539] mobilizon_ctl[2235]: 22:07:45.092 [info] == Running 20220407083712 Mobilizon.Storage.Repo.Migrations.AddIndexesToAddresses.up/0 forward
server # [  921.445132] mobilizon_ctl[2235]: 22:07:45.107 [info] create index if not exists idx_addresses_geom_x
server # [  921.545003] mobilizon_ctl[2235]: 22:07:45.274 [info] create index if not exists idx_addresses_geom_y
server # [  921.617646] mobilizon_ctl[2235]: 22:07:45.336 [info] == Migrated 20220407083712 in 0.2s
server # [  921.751064] mobilizon_ctl[2235]: 22:07:45.483 [info] == Running 20220505091224 Mobilizon.Storage.Repo.Migrations.ChangeRefreshInstanceTriggerToOnlyExecuteOnRelays.up/0 forward
server # [  921.780786] mobilizon_ctl[2235]: 22:07:45.492 [info] execute "DROP TRIGGER IF EXISTS refresh_instances_trigger ON actors;\n"
server # [  921.831766] mobilizon_ctl[2235]: 22:07:45.569 [info] execute "CREATE TRIGGER refresh_instances_trigger_new\nAFTER INSERT OR UPDATE\nON actors\nFOR EACH ROW\nWHEN (NEW.preferred_username = 'relay')\nEXECUTE PROCEDURE refresh_instances();\n"
server # [  921.914993] mobilizon_ctl[2235]: 22:07:45.639 [info] execute "CREATE TRIGGER refresh_instances_trigger_old\nAFTER DELETE\nON actors\nFOR EACH ROW\nWHEN (OLD.preferred_username = 'relay')\nEXECUTE PROCEDURE refresh_instances();\n"
server # [  921.953445] mobilizon_ctl[2235]: 22:07:45.675 [info] == Migrated 20220505091224 in 0.1s
server # [  922.069634] mobilizon_ctl[2235]: 22:07:45.798 [info] == Running 20220506105150 Mobilizon.Storage.Repo.Migrations.RemoveRefreshInstanceTriggers.up/0 forward
server # [  922.094450] mobilizon_ctl[2235]: 22:07:45.811 [info] execute "DROP TRIGGER IF EXISTS refresh_instances_trigger_new ON actors;\n"
server # [  922.142528] mobilizon_ctl[2235]: 22:07:45.874 [info] execute "DROP TRIGGER IF EXISTS refresh_instances_trigger_old ON actors;\n"
server # [  922.187002] mobilizon_ctl[2235]: 22:07:45.907 [info] == Migrated 20220506105150 in 0.1s
server # [  922.281188] mobilizon_ctl[2235]: 22:07:46.016 [info] == Running 20230208101626 Mobilizon.Repo.Migrations.CreateApplications.change/0 forward
server # [  922.333468] mobilizon_ctl[2235]: 22:07:46.064 [info] create table applications
server # [  922.654383] mobilizon_ctl[2235]: 22:07:46.343 [info] create index applications_owner_id_owner_type_index
server # [  922.702616] mobilizon_ctl[2235]: 22:07:46.428 [info] == Migrated 20230208101626 in 0.4s
server # [  922.841245] mobilizon_ctl[2235]: 22:07:46.568 [info] == Running 20230215125801 Mobilizon.Repo.Migrations.CreateApplicationTokens.change/0 forward
server # [  922.913264] mobilizon_ctl[2235]: 22:07:46.612 [info] create table application_tokens
server # [  923.250303] mobilizon_ctl[2235]: 22:07:46.984 [info] create index application_tokens_user_id_application_id_index
server # [  923.329024] mobilizon_ctl[2235]: 22:07:47.058 [info] == Migrated 20230215125801 in 0.4s
server # [  923.455561] mobilizon_ctl[2235]: 22:07:47.183 [info] == Running 20230217084253 Mobilizon.Repo.Migrations.CreateApplicationDeviceActivation.change/0 forward
server # [  923.492880] mobilizon_ctl[2235]: 22:07:47.223 [info] create table application_device_activation
server # [  923.762468] mobilizon_ctl[2235]: 22:07:47.459 [info] == Migrated 20230217084253 in 0.2s
server # [  923.832859] mobilizon_ctl[2235]: 22:07:47.566 [info] == Running 20230605143534 Mobilizon.Storage.Repo.Migrations.AllowMultipleEventsToBeReported.up/0 forward
server # [  923.851036] mobilizon_ctl[2235]: 22:07:47.583 [info] create table reports_events
server # [  923.956836] mobilizon_ctl[2235]: 22:07:47.683 [info] == Migrated 20230605143534 in 0.1s
server # [  924.063334] mobilizon_ctl[2235]: 22:07:47.787 [info] == Running 20230605153836 Mobilizon.Storage.Repo.Migrations.BackfillReportEventsWithOldEvents.up/0 forward
server # [  924.098084] mobilizon_ctl[2235]: 22:07:47.824 [info] == Migrated 20230605153836 in 0.0s
server # [  924.189107] mobilizon_ctl[2235]: 22:07:47.927 [info] == Running 20230605154106 Mobilizon.Storage.Repo.Migrations.RemoveObsoleteEventIdOnReports.up/0 forward
server # [  924.218129] mobilizon_ctl[2235]: 22:07:47.936 [info] alter table reports
server # [  924.271574] mobilizon_ctl[2235]: 22:07:48.005 [info] == Migrated 20230605154106 in 0.0s
server # [  924.357278] mobilizon_ctl[2235]: 22:07:48.091 [info] == Running 20230831153358 Mobilizon.Storage.Repo.Migrations.RemoveOnDeleteCascadeForReports.up/0 forward
server # [  924.451327] mobilizon_ctl[2235]: 22:07:48.179 [info] execute "DROP MATERIALIZED VIEW IF EXISTS instances;\n"
server # [  924.584801] mobilizon_ctl[2235]: 22:07:48.311 [info] drop constraint reports_reported_id_fkey from table reports
server # [  924.637332] mobilizon_ctl[2235]: 22:07:48.365 [info] drop constraint reports_reporter_id_fkey from table reports
server # [  924.676910] mobilizon_ctl[2235]: 22:07:48.414 [info] drop constraint reports_manager_id_fkey from table reports
server # [  924.774045] mobilizon_ctl[2235]: 22:07:48.460 [info] alter table reports
server # [  924.965716] mobilizon_ctl[2235]: 22:07:48.691 [info] drop constraint report_notes_moderator_id_fkey from table report_notes
server # [  925.012897] mobilizon_ctl[2235]: 22:07:48.738 [info] alter table report_notes
server # [  925.117762] mobilizon_ctl[2235]: 22:07:48.846 [info] execute "CREATE MATERIALIZED VIEW instances AS\nSELECT\n  a.domain,\n  COUNT(DISTINCT(p.id)) AS person_count,\n  COUNT(DISTINCT(g.id)) AS group_count,\n  COUNT(DISTINCT(e.id)) AS event_count,\n  COUNT(f1.id) AS followers_count,\n  COUNT(f2.id) AS followings_count,\n  COUNT(r.id) AS reports_count,\n  SUM(COALESCE((m.file->>'size')::int, 0)) AS media_size\nFROM actors a\nLEFT JOIN actors p ON a.id = p.id AND p.type = 'Person'\nLEFT JOIN actors g ON a.id = g.id AND g.type = 'Group'\nLEFT JOIN events e ON a.id = e.organizer_actor_id\nLEFT JOIN followers f1 ON a.id = f1.actor_id\nLEFT JOIN followers f2 ON a.id = f2.target_actor_id\nLEFT JOIN reports r ON r.reported_id = a.id\nLEFT JOIN medias m ON m.actor_id = a.id\nWHERE a.domain IS NOT NULL\nGROUP BY a.domain;\n"
server # [  925.938408] mobilizon_ctl[2235]: 22:07:49.626 [info] == Migrated 20230831153358 in 1.5s
server # [  926.032055] mobilizon_ctl[2235]: 22:07:49.763 [info] == Running 20230901160000 Mobilizon.Storage.Repo.Migrations.AddExternalUrlForEvents.up/0 forward
server # [  926.170044] mobilizon_ctl[2235]: 22:07:49.887 [info] alter table events
server # [  926.215261] mobilizon_ctl[2235]: 22:07:49.944 [info] execute "ALTER TABLE events ALTER COLUMN join_options TYPE VARCHAR USING join_options::text"
server # [  926.693076] mobilizon_ctl[2235]: 22:07:50.428 [info] execute "ALTER TABLE events ALTER COLUMN join_options DROP DEFAULT"
server # [  926.773044] mobilizon_ctl[2235]: 22:07:50.478 [info] execute "DROP TYPE public.join_options"
server # [  926.790124] mobilizon_ctl[2235]: 22:07:50.509 [info] execute "CREATE TYPE public.join_options AS ENUM ('free', 'restricted', 'invite', 'external')"
server # [  926.834545] mobilizon_ctl[2235]: 22:07:50.564 [info] execute "ALTER TABLE events ALTER COLUMN join_options TYPE join_options USING join_options::join_options"
server # [  927.173993] mobilizon_ctl[2235]: 22:07:50.849 [info] execute "ALTER TABLE events ALTER COLUMN join_options SET DEFAULT 'free'::join_options"
server # [  927.185997] mobilizon_ctl[2235]: 22:07:50.878 [info] == Migrated 20230901160000 in 1.1s
server # [  927.377253] mobilizon_ctl[2235]: 22:07:51.103 [info] == Running 20230920071502 Mobilizon.Storage.Repo.Migrations.AddActorConversations.up/0 forward
server # [  927.422545] mobilizon_ctl[2235]: 22:07:51.144 [info] create table conversations
server # [  927.672795] mobilizon_ctl[2235]: 22:07:51.387 [info] create table conversation_participants
server # [  927.856858] mobilizon_ctl[2235]: 22:07:51.574 [info] alter table comments
server # [  927.966474] mobilizon_ctl[2235]: 22:07:51.686 [info] == Migrated 20230920071502 in 0.5s
server # [  928.057813] mobilizon_ctl[2235]: 22:07:51.787 [info] == Running 20231220092536 Mobilizon.Storage.Repo.Migrations.AddActorInstances.change/0 forward
server # [  928.107256] mobilizon_ctl[2235]: 22:07:51.830 [info] create table instance_actors
server # [  928.386792] mobilizon_ctl[2235]: 22:07:52.070 [info] create index instance_actors_domain_index
server # [  928.398357] mobilizon_ctl[2235]: 22:07:52.119 [info] == Migrated 20231220092536 in 0.3s
server # [  928.482753] mobilizon_ctl[2235]: 22:07:52.219 [info] == Running 20240104103036 Mobilizon.Storage.Repo.Migrations.ChangeActorInstanceDescriptionTypeToText.up/0 forward
server # [  928.502135] mobilizon_ctl[2235]: 22:07:52.227 [info] alter table instance_actors
server # [  928.544768] mobilizon_ctl[2235]: 22:07:52.275 [info] == Migrated 20240104103036 in 0.0s
server # [  928.626134] mobilizon_ctl[2235]: 22:07:52.367 [info] == Running 20240222121054 Mobilizon.Storage.Repo.Migrations.CreateAdminSettingsMedias.change/0 forward
server # [  928.660839] mobilizon_ctl[2235]: 22:07:52.388 [info] create table admin_settings_medias
server # [  928.835601] mobilizon_ctl[2235]: 22:07:52.558 [info] create index admin_settings_medias_group_name_index
server # [  928.898157] mobilizon_ctl[2235]: 22:07:52.631 [info] == Migrated 20240222121054 in 0.2s
server # [  928.979793] mobilizon_ctl[2235]: 22:07:52.719 [info] == Running 20240725130410 Mobilizon.Storage.Repo.Migrations.AddEventPhysicalAddressIndex.up/0 forward
server # [  929.002275] mobilizon_ctl[2235]: 22:07:52.730 [info] create index events_phys_addr_id
server # [  929.053318] mobilizon_ctl[2235]: 22:07:52.787 [info] == Migrated 20240725130410 in 0.0s
server # [  929.136993] mobilizon_ctl[2235]: 22:07:52.870 [info] == Running 20250521145952 Mobilizon.Storage.Repo.Migrations.AddUuidToMedia.change/0 forward
server # [  929.167035] mobilizon_ctl[2235]: 22:07:52.879 [info] alter table medias
server # [  929.386627] mobilizon_ctl[2235]: 22:07:53.068 [info] create index medias_uuid_index
server # [  929.422364] mobilizon_ctl[2235]: 22:07:53.146 [info] == Migrated 20250521145952 in 0.2s
server # [  929.549498] mobilizon_ctl[2235]: 22:07:53.289 [info] == Running 20250911120910 Mobilizon.Storage.Repo.Migrations.AddModerationToUser.change/0 forward
server # [  929.578159] mobilizon_ctl[2235]: 22:07:53.300 [info] alter table users
server # [  929.638381] mobilizon_ctl[2235]: 22:07:53.360 [info] == Migrated 20250911120910 in 0.0s
server # [  929.765346] mobilizon_ctl[2235]: 22:07:53.491 [info] == Running 20250919143627 Mobilizon.Storage.Repo.Migrations.UpdateRoleToUser.change/0 forward
server # [  929.793322] mobilizon_ctl[2235]: 22:07:53.498 [info] execute "ALTER TYPE user_role ADD VALUE IF NOT EXISTS 'pending';"
server # [  929.811214] mobilizon_ctl[2235]: 22:07:53.523 [info] enum label "pending" already exists, skipping
server # [  929.834259] mobilizon_ctl[2235]: 22:07:53.529 [info] == Migrated 20250919143627 in 0.0s
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  929.933382] mobilizon_ctl[2235]: 22:07:53.660 [info] == Running 20251027133219 Mobilizon.Storage.Repo.Migrations.CreateInvitations.change/0 forward
server # [  929.969004] mobilizon_ctl[2235]: 22:07:53.706 [info] create table invitations
server # [  930.215923] mobilizon_ctl[2235]: 22:07:53.942 [info] create index invitations_token_index
server # [  930.276937] mobilizon_ctl[2235]: 22:07:54.002 [info] == Migrated 20251027133219 in 0.3s
server # [  930.431487] mobilizon_ctl[2235]: 22:07:54.114 [info] == Running 20251111093015 Mobilizon.Storage.Repo.Migrations.AddAllowToGroup.change/0 forward
server # [  930.445940] mobilizon_ctl[2235]: 22:07:54.126 [info] alter table actors
server # [  930.495116] mobilizon_ctl[2235]: 22:07:54.215 [info] == Migrated 20251111093015 in 0.0s
server # [  931.191236] systemd[1]: Started Mobilizon federated organization and mobilization platform.
server # [  931.343225] systemd[1]: Reached target Multi-User System.
server # [  931.395029] systemd[1]: Startup finished in 7.157s (kernel) + 1min 34.964s (initrd) + 13min 49.266s (userspace) = 15min 31.388s.
server # [  952.717769] postgres[1373]: [1373] LOG:  checkpoint starting: time
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [  992.775690] postgres[1373]: [1373] LOG:  checkpoint complete: wrote 373 buffers (2.3%); 0 WAL file(s) added, 0 removed, 0 recycled; write=39.042 s, sync=0.640 s, total=40.054 s; sync files=174, longest=0.024 s, average=0.004 s; distance=3134 kB, estimate=12794 kB; lsn=0/2603220, redo lsn=0/2587698
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1228.024581] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1252.903832] postgres[1373]: [1373] LOG:  checkpoint starting: time
server # [ 1257.518140] postgres[1373]: [1373] LOG:  checkpoint complete: wrote 43 buffers (0.3%); 0 WAL file(s) added, 0 removed, 0 recycled; write=4.414 s, sync=0.056 s, total=4.606 s; sync files=9, longest=0.023 s, average=0.007 s; distance=507 kB, estimate=11565 kB; lsn=0/2606510, redo lsn=0/2606480
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1313.713548] mobilizon[2451]: 22:14:17.347 [info] No tzdata release files found in custom data dir. Copying release file from tzdata priv dir.
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1321.682997] mobilizon[2451]: 22:14:24.755 [info] Source for database :city not found: "/var/lib/mobilizon/geo/GeoLite2-City.mmdb"
server # [ 1321.783140] systemd[1]: Starting Virtual Console Setup...
server # [ 1322.613197] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [ 1322.658117] systemd[1]: Stopped Virtual Console Setup.
server # [ 1323.370691] systemd[1]: Starting Virtual Console Setup...
server # [ 1329.525948] mobilizon[2451]: 22:14:33.174 [info] Loading 122 CA(s) from :otp store
server # [ 1334.698192] systemd-vconsole-setup[3087]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [ 1334.837557] systemd[1]: Finished Virtual Console Setup.
server # [ 1335.139200] mobilizon[2451]: 22:14:38.816 [info] Running Mobilizon.Web.Endpoint with Bandit 1.10.3 at ::1:41395 (http)
server # [ 1335.182733] mobilizon[2451]: 22:14:38.859 [info] Access Mobilizon.Web.Endpoint at https://acme.test
server # [ 1336.259026] mobilizon[2451]: 22:14:39.936 [info] {"message":"notifier only receiving messages from its own node, functionality may be degraded","source":"oban","event":"notifier:switch","connectivity_status":"solitary"}
server # [ 1336.296995] mobilizon[2451]: 22:14:40.030 [info] {"message":"peer became leader","node":"mobilizon@server","source":"oban","event":"peer:election","leader":true,"was_leader":false}
server # [ 1348.479312] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1356.480024] mobilizon[2451]: 22:15:00.171 [info] {"source":"oban","duration":47627,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 1365.911218] mobilizon[2451]: 22:15:09.627 [info] {"source":"oban","duration":74275,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server # [ 1368.121490] 8021q: 802.1Q VLAN Support v1.8
server # [ 1370.200738] cfg80211: Loading compiled-in X.509 certificates for regulatory database
server # [ 1370.702453] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
server # [ 1370.710774] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
server # [ 1370.764870] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
server # [ 1370.768798] cfg80211: failed to load regulatory.db
server # [ 1374.721959] (udev-worker)[3215]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
server # [ 1374.731528] (udev-worker)[3215]: Network interface NamePolicy= disabled on kernel command line.
server # [ 1374.751549] (udev-worker)[3217]: Network interface NamePolicy= disabled on kernel command line.
server # [ 1375.897679] systemd[1]: Condition check resulted in Virtio network device being skipped.
server # [ 1376.142307] systemd[1]: Starting Address configuration of eth1...
server # [ 1378.865927] 8021q: adding VLAN 0 to HW filter on device eth0
server # [ 1378.824493] dhcpcd[1186]: eth0: waiting for carrier
server # [ 1378.875354] dhcpcd[1186]: eth0: carrier acquired
server # [ 1379.064570] 8021q: adding VLAN 0 to HW filter on device eth1
server # [ 1379.429666] dhcpcd[1186]: DUID 00:01:00:01:32:27:67:fb:52:54:00:12:34:56
server # [ 1379.472873] dhcpcd[1186]: eth0: IAID 00:12:34:56
server # [ 1379.475925] dhcpcd[1186]: eth0: adding address fe80::5054:ff:fe12:3456
server # [ 1379.587419] network-addresses-eth1-start[3228]: adding address 192.168.1.1/24... done
server # [ 1379.869050] network-addresses-eth1-start[3228]: adding address 2001:db8:1::1/64... done
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1380.388535] dhcpcd[1186]: eth0: soliciting a DHCP lease
server # [ 1380.455938] systemd[1]: Finished Address configuration of eth1.
server # [ 1380.495112] dhcpcd[1186]: eth0: offered 10.0.2.15 from 10.0.2.2
server # [ 1380.519129] dhcpcd[1186]: eth0: probing address 10.0.2.15/24
server # [ 1382.072032] dhcpcd[1186]: eth0: soliciting an IPv6 router
server # [ 1382.088771] dhcpcd[1186]: eth0: Router Advertisement from fe80::2
server # [ 1382.112644] dhcpcd[1186]: eth0: adding address fec0::5054:ff:fe12:3456/64
server # [ 1382.166727] dhcpcd[1186]: eth0: adding route to fec0::/64
server # [ 1382.183996] dhcpcd[1186]: eth0: adding default route via fe80::2
server # [ 1385.691507] dhcpcd[1186]: eth0: leased 10.0.2.15 for 86400 seconds
server # [ 1385.717013] dhcpcd[1186]: eth0: adding route to 10.0.2.0/24
server # [ 1385.727449] dhcpcd[1186]: eth0: adding default route via 10.0.2.2
server # [ 1395.979507] mobilizon[2451]: 22:15:39.698 [info] {"source":"oban","duration":66252,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server # [ 1402.994589] systemd-logind[1059]: Watching system buttons on /dev/input/event1 (gpio-keys)
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1412.509573] systemd-logind[1059]: Watching system buttons on /dev/input/event0 (QEMU QEMU USB Keyboard)
server # [ 1416.510830] mobilizon[2451]: 22:16:00.222 [info] {"source":"oban","duration":29338,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 1426.046751] mobilizon[2451]: 22:16:09.766 [info] {"source":"oban","duration":66534,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1456.137988] mobilizon[2451]: 22:16:39.831 [info] {"source":"oban","duration":59745,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1476.543452] mobilizon[2451]: 22:17:00.251 [info] {"source":"oban","duration":23170,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 1486.183508] mobilizon[2451]: 22:17:09.896 [info] {"source":"oban","duration":57979,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1516.283015] mobilizon[2451]: 22:17:39.991 [info] {"source":"oban","duration":87879,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1536.574341] mobilizon[2451]: 22:18:00.279 [info] {"source":"oban","duration":23111,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 1546.350433] mobilizon[2451]: 22:18:10.062 [info] {"source":"oban","duration":67284,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server # [ 1552.615841] postgres[1373]: [1373] LOG:  checkpoint starting: time
server # [ 1554.866610] postgres[1373]: [1373] LOG:  checkpoint complete: wrote 21 buffers (0.1%); 0 WAL file(s) added, 0 removed, 0 recycled; write=2.100 s, sync=0.056 s, total=2.264 s; sync files=17, longest=0.019 s, average=0.004 s; distance=9 kB, estimate=10410 kB; lsn=0/2608CC0, redo lsn=0/2608C40
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1568.530256] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [ 1568.553906] systemd[1]: Stopped Virtual Console Setup.
server # [ 1568.570363] systemd[1]: systemd-vconsole-setup.service: Consumed 1.876s CPU time over 4min 5.200s wall clock time, 2.5M memory peak.
server # [ 1568.583112] systemd[1]: Stopping Virtual Console Setup...
server # [ 1568.725168] systemd[1]: Starting Virtual Console Setup...
server # [ 1569.567909] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
server # [ 1569.597056] systemd[1]: Stopped Virtual Console Setup.
server # [ 1569.993115] systemd[1]: Starting Virtual Console Setup...
server # [ 1575.382948] systemd-vconsole-setup[3921]: Configuration of first virtual console was skipped, ignoring remaining ones.
server # [ 1575.527470] systemd[1]: Finished Virtual Console Setup.
server # [ 1576.421385] mobilizon[2451]: 22:18:40.124 [info] {"source":"oban","duration":59513,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server # [ 1583.897977] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
server # [ 1584.163174] systemd-logind[1059]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1596.566912] mobilizon[2451]: 22:19:00.299 [info] {"source":"oban","duration":15473,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 1606.423474] mobilizon[2451]: 22:19:10.154 [info] {"source":"oban","duration":21418,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1636.448965] mobilizon[2451]: 22:19:40.182 [info] {"source":"oban","duration":24739,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1656.582761] mobilizon[2451]: 22:20:00.313 [info] {"source":"oban","duration":9127,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 1666.487861] mobilizon[2451]: 22:20:10.220 [info] {"source":"oban","duration":34478,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1696.525448] mobilizon[2451]: 22:20:40.258 [info] {"source":"oban","duration":29558,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1716.594410] mobilizon[2451]: 22:21:00.330 [info] {"source":"oban","duration":11909,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 1726.575312] mobilizon[2451]: 22:21:10.308 [info] {"source":"oban","duration":45407,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1756.609516] mobilizon[2451]: 22:21:40.341 [info] {"source":"oban","duration":28144,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1776.606108] mobilizon[2451]: 22:22:00.342 [info] {"source":"oban","duration":8198,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 1786.634579] mobilizon[2451]: 22:22:10.368 [info] {"source":"oban","duration":24236,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1816.662599] mobilizon[2451]: 22:22:40.397 [info] {"source":"oban","duration":24667,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1836.643228] mobilizon[2451]: 22:23:00.355 [info] {"source":"oban","duration":8605,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 1846.700716] mobilizon[2451]: 22:23:10.426 [info] {"source":"oban","duration":24145,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server # [ 1852.970730] postgres[1373]: [1373] LOG:  checkpoint starting: time
server # [ 1853.089115] postgres[1373]: [1373] LOG:  checkpoint complete: wrote 1 buffers (0.0%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.022 s, sync=0.008 s, total=0.134 s; sync files=1, longest=0.008 s, average=0.008 s; distance=4 kB, estimate=9369 kB; lsn=0/2609D30, redo lsn=0/2609CD8
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1876.726976] mobilizon[2451]: 22:23:40.461 [info] {"source":"oban","duration":30446,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1896.636621] mobilizon[2451]: 22:24:00.370 [info] {"source":"oban","duration":8724,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 1906.757237] mobilizon[2451]: 22:24:10.492 [info] {"source":"oban","duration":28309,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1936.785719] mobilizon[2451]: 22:24:40.519 [info] {"source":"oban","duration":23262,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1956.652019] mobilizon[2451]: 22:25:00.383 [info] {"source":"oban","duration":9199,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 1966.814196] mobilizon[2451]: 22:25:10.549 [info] {"source":"oban","duration":25658,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 1996.849876] mobilizon[2451]: 22:25:40.586 [info] {"source":"oban","duration":32156,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2016.668924] mobilizon[2451]: 22:26:00.399 [info] {"source":"oban","duration":10803,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2026.890446] mobilizon[2451]: 22:26:10.621 [info] {"source":"oban","duration":28971,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2056.936613] mobilizon[2451]: 22:26:40.666 [info] {"source":"oban","duration":43167,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2076.677910] mobilizon[2451]: 22:27:00.412 [info] {"source":"oban","duration":9822,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2086.979292] mobilizon[2451]: 22:27:10.697 [info] {"source":"oban","duration":26397,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2116.989645] mobilizon[2451]: 22:27:40.722 [info] {"source":"oban","duration":23134,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2136.723652] mobilizon[2451]: 22:28:00.423 [info] {"source":"oban","duration":7830,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2147.014794] mobilizon[2451]: 22:28:10.750 [info] {"source":"oban","duration":24126,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server # [ 2153.166805] postgres[1373]: [1373] LOG:  checkpoint starting: time
server # [ 2153.712975] postgres[1373]: [1373] LOG:  checkpoint complete: wrote 5 buffers (0.0%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.434 s, sync=0.042 s, total=0.571 s; sync files=7, longest=0.016 s, average=0.006 s; distance=18 kB, estimate=8434 kB; lsn=0/260E748, redo lsn=0/260E6F0
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2177.054419] mobilizon[2451]: 22:28:40.788 [info] {"source":"oban","duration":34213,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2196.707028] mobilizon[2451]: 22:29:00.439 [info] {"source":"oban","duration":12021,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2207.086804] mobilizon[2451]: 22:29:10.816 [info] {"source":"oban","duration":24047,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2237.105900] mobilizon[2451]: 22:29:40.842 [info] {"source":"oban","duration":22017,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2256.725258] mobilizon[2451]: 22:30:00.458 [info] {"source":"oban","duration":13469,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2267.133362] mobilizon[2451]: 22:30:10.869 [info] {"source":"oban","duration":23435,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2297.167293] mobilizon[2451]: 22:30:40.898 [info] {"source":"oban","duration":25846,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2316.741096] mobilizon[2451]: 22:31:00.474 [info] {"source":"oban","duration":11170,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2327.203378] mobilizon[2451]: 22:31:10.926 [info] {"source":"oban","duration":24526,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2357.221883] mobilizon[2451]: 22:31:40.955 [info] {"source":"oban","duration":25749,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2376.771278] mobilizon[2451]: 22:32:00.500 [info] {"source":"oban","duration":21419,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2387.246083] mobilizon[2451]: 22:32:10.978 [info] {"source":"oban","duration":18633,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2417.270883] mobilizon[2451]: 22:32:41.003 [info] {"source":"oban","duration":22364,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2436.782449] mobilizon[2451]: 22:33:00.518 [info] {"source":"oban","duration":13278,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2447.306920] mobilizon[2451]: 22:33:11.042 [info] {"source":"oban","duration":32134,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server # [ 2452.822198] postgres[1373]: [1373] LOG:  checkpoint starting: time
server # [ 2452.913723] postgres[1373]: [1373] LOG:  checkpoint complete: wrote 1 buffers (0.0%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.020 s, sync=0.009 s, total=0.115 s; sync files=1, longest=0.009 s, average=0.009 s; distance=4 kB, estimate=7591 kB; lsn=0/260F7E0, redo lsn=0/260F788
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2477.345438] mobilizon[2451]: 22:33:41.075 [info] {"source":"oban","duration":29160,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2496.798310] mobilizon[2451]: 22:34:00.533 [info] {"source":"oban","duration":9710,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2507.369571] mobilizon[2451]: 22:34:11.105 [info] {"source":"oban","duration":26435,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2537.397208] mobilizon[2451]: 22:34:41.133 [info] {"source":"oban","duration":23508,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2556.834083] mobilizon[2451]: 22:35:00.549 [info] {"source":"oban","duration":10291,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2567.424574] mobilizon[2451]: 22:35:11.157 [info] {"source":"oban","duration":18792,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2597.446648] mobilizon[2451]: 22:35:41.182 [info] {"source":"oban","duration":21206,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2616.829580] mobilizon[2451]: 22:36:00.565 [info] {"source":"oban","duration":11087,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2627.467083] mobilizon[2451]: 22:36:11.203 [info] {"source":"oban","duration":17642,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2657.498582] mobilizon[2451]: 22:36:41.230 [info] {"source":"oban","duration":24014,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2676.845979] mobilizon[2451]: 22:37:00.581 [info] {"source":"oban","duration":9891,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2687.523724] mobilizon[2451]: 22:37:11.259 [info] {"source":"oban","duration":26762,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2717.553629] mobilizon[2451]: 22:37:41.289 [info] {"source":"oban","duration":25519,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2736.878983] mobilizon[2451]: 22:38:00.595 [info] {"source":"oban","duration":7964,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2747.581345] mobilizon[2451]: 22:38:11.312 [info] {"source":"oban","duration":19883,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server # [ 2752.985071] postgres[1373]: [1373] LOG:  checkpoint starting: time
server # [ 2753.069505] postgres[1373]: [1373] LOG:  checkpoint complete: wrote 1 buffers (0.0%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.018 s, sync=0.007 s, total=0.107 s; sync files=1, longest=0.007 s, average=0.007 s; distance=4 kB, estimate=6832 kB; lsn=0/26108B8, redo lsn=0/2610860
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2777.603039] mobilizon[2451]: 22:38:41.338 [info] {"source":"oban","duration":23094,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2796.877057] mobilizon[2451]: 22:39:00.610 [info] {"source":"oban","duration":10807,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2807.633808] mobilizon[2451]: 22:39:11.368 [info] {"source":"oban","duration":25947,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2837.660942] mobilizon[2451]: 22:39:41.393 [info] {"source":"oban","duration":20811,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2856.890797] mobilizon[2451]: 22:40:00.625 [info] {"source":"oban","duration":10890,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2867.683085] mobilizon[2451]: 22:40:11.418 [info] {"source":"oban","duration":22443,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2897.710467] mobilizon[2451]: 22:40:41.445 [info] {"source":"oban","duration":22764,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2916.930361] mobilizon[2451]: 22:41:00.650 [info] {"source":"oban","duration":16237,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2927.741080] mobilizon[2451]: 22:41:11.473 [info] {"source":"oban","duration":24745,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2957.761406] mobilizon[2451]: 22:41:41.493 [info] {"source":"oban","duration":17338,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 2976.935806] mobilizon[2451]: 22:42:00.667 [info] {"source":"oban","duration":11835,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 2987.777625] mobilizon[2451]: 22:42:11.514 [info] {"source":"oban","duration":15873,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3017.812040] mobilizon[2451]: 22:42:41.544 [info] {"source":"oban","duration":26428,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3036.954655] mobilizon[2451]: 22:43:00.681 [info] {"source":"oban","duration":9230,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 3047.838892] mobilizon[2451]: 22:43:11.570 [info] {"source":"oban","duration":22317,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server # [ 3053.182745] postgres[1373]: [1373] LOG:  checkpoint starting: time
server # [ 3053.503659] postgres[1373]: [1373] LOG:  checkpoint complete: wrote 3 buffers (0.0%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.225 s, sync=0.025 s, total=0.354 s; sync files=3, longest=0.013 s, average=0.009 s; distance=17 kB, estimate=6151 kB; lsn=0/2614D88, redo lsn=0/2614D30
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3077.858563] mobilizon[2451]: 22:43:41.593 [info] {"source":"oban","duration":19756,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3096.969246] mobilizon[2451]: 22:44:00.695 [info] {"source":"oban","duration":10215,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 3107.879761] mobilizon[2451]: 22:44:11.612 [info] {"source":"oban","duration":13804,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3137.902239] mobilizon[2451]: 22:44:41.638 [info] {"source":"oban","duration":22095,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3156.982732] mobilizon[2451]: 22:45:00.711 [info] {"source":"oban","duration":10404,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 3167.921808] mobilizon[2451]: 22:45:11.658 [info] {"source":"oban","duration":16696,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3197.964963] mobilizon[2451]: 22:45:41.691 [info] {"source":"oban","duration":29069,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3216.990513] mobilizon[2451]: 22:46:00.725 [info] {"source":"oban","duration":9842,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 3227.981963] mobilizon[2451]: 22:46:11.713 [info] {"source":"oban","duration":19132,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3258.001510] mobilizon[2451]: 22:46:41.737 [info] {"source":"oban","duration":20968,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3277.006456] mobilizon[2451]: 22:47:00.742 [info] {"source":"oban","duration":12040,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 3288.041439] mobilizon[2451]: 22:47:11.773 [info] {"source":"oban","duration":31258,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3318.056720] mobilizon[2451]: 22:47:41.793 [info] {"source":"oban","duration":14406,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3337.042746] mobilizon[2451]: 22:48:00.759 [info] {"source":"oban","duration":13377,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 3348.099761] mobilizon[2451]: 22:48:11.822 [info] {"source":"oban","duration":26305,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server # [ 3352.537777] postgres[1373]: [1373] LOG:  checkpoint starting: time
server # [ 3352.643558] postgres[1373]: [1373] LOG:  checkpoint complete: wrote 1 buffers (0.0%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.021 s, sync=0.011 s, total=0.130 s; sync files=1, longest=0.011 s, average=0.011 s; distance=4 kB, estimate=5536 kB; lsn=0/2615E20, redo lsn=0/2615DC8
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3378.110852] mobilizon[2451]: 22:48:41.842 [info] {"source":"oban","duration":16315,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3397.042169] mobilizon[2451]: 22:49:00.778 [info] {"source":"oban","duration":13476,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 3408.149200] mobilizon[2451]: 22:49:11.883 [info] {"source":"oban","duration":37029,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3438.182625] mobilizon[2451]: 22:49:41.901 [info] {"source":"oban","duration":14966,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3457.057133] mobilizon[2451]: 22:50:00.793 [info] {"source":"oban","duration":9365,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 3468.188383] mobilizon[2451]: 22:50:11.921 [info] {"source":"oban","duration":15874,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3498.205307] mobilizon[2451]: 22:50:41.941 [info] {"source":"oban","duration":15448,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3517.073148] mobilizon[2451]: 22:51:00.809 [info] {"source":"oban","duration":10632,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 3528.222512] mobilizon[2451]: 22:51:11.959 [info] {"source":"oban","duration":14607,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3558.254940] mobilizon[2451]: 22:51:41.986 [info] {"source":"oban","duration":23400,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
server: Guest root shell did not produce any data yet...
server:   To debug, enter the VM and run 'systemctl status backdoor.service'.
server # [ 3577.094998] mobilizon[2451]: 22:52:00.830 [info] {"source":"oban","duration":14373,"event":"plugin:stop","plugin":"Oban.Plugins.Cron","jobs":[]}
server # [ 3588.273252] mobilizon[2451]: 22:52:12.009 [info] {"source":"oban","duration":19861,"event":"plugin:stop","plugin":"Oban.Plugins.Pruner","pruned_count":0}
timeout reached; test terminating...
kill QemuMachine (pid 12)
server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/lqn6mbgzzdrqq2qkwddcmxj9z6amdd86-python3-3.13.13/bin/python3.13)
cleanup
kill QemuMachine (pid 12)
Terminated                 /nix/store/ai81aac95a6vphah91kz7nj49ackc2gv-nixos-test-driver-mobilizon/bin/nixos-test-driver -o $out