From nobody Fri Oct 27 10:15:25 2023 X-Original-To: freebsd-stable@mlmmj.nyi.freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2610:1c1:1:606c::19:1]) by mlmmj.nyi.freebsd.org (Postfix) with ESMTP id 4SGz7n2FCwz4y51m for ; Fri, 27 Oct 2023 10:15:33 +0000 (UTC) (envelope-from void@f-m.fm) Received: from out3-smtp.messagingengine.com (out3-smtp.messagingengine.com [66.111.4.27]) (using TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits) key-exchange X25519 server-signature RSA-PSS (4096 bits) server-digest SHA256) (Client did not present a certificate) by mx1.freebsd.org (Postfix) with ESMTPS id 4SGz7m3XzFz3gGm for ; Fri, 27 Oct 2023 10:15:32 +0000 (UTC) (envelope-from void@f-m.fm) Authentication-Results: mx1.freebsd.org; dkim=pass header.d=f-m.fm header.s=fm3 header.b=aaMYLtPz; dkim=pass header.d=messagingengine.com header.s=fm3 header.b=f5Wn+uV7; spf=pass (mx1.freebsd.org: domain of void@f-m.fm designates 66.111.4.27 as permitted sender) smtp.mailfrom=void@f-m.fm; dmarc=pass (policy=none) header.from=f-m.fm Received: from compute1.internal (compute1.nyi.internal [10.202.2.41]) by mailout.nyi.internal (Postfix) with ESMTP id 62C3F5C01B3 for ; Fri, 27 Oct 2023 06:15:30 -0400 (EDT) Received: from mailfrontend1 ([10.202.2.162]) by compute1.internal (MEProxy); Fri, 27 Oct 2023 06:15:30 -0400 DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=f-m.fm; h=cc :content-type:content-type:date:date:from:from:in-reply-to :message-id:mime-version:reply-to:sender:subject:subject:to:to; s=fm3; t=1698401730; x=1698488130; bh=WZdjxCp3bh23wXzyYWJMOrvGO 73c2yml5QdgM9BXObQ=; b=aaMYLtPzyefWpHlzR8vUGSKPkcOW6h39mDLPq3Pe/ p/jbU3dmkEJJPsfHTp1Nw7LZRUz4iC34ddmB3/wgl14RvyHV/kw9CFMR+Vy8rDVD nA7y0pYkcgnGDxDXVXYiYG7VNwgp1/BX7FetdMYaTA1/ryu4YR81ztuBqoZfBlKv r5jAg6yRfRbZGKd3XAMAbp+4UdzLve56N/+TxUB8GX2L+bqpXor0gxIh6oYHDKii 0V/97k5LwyYw0A/+pQs6CgOEWvLRSbdF3giHBshAJCdX9QyelCkb12HHmbOXrzOu T4btzeK/Jtb0rS5U7qSetT2G7Ibvz/sjIbBKjim5oic+g== DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d= messagingengine.com; h=cc:content-type:content-type:date:date :feedback-id:feedback-id:from:from:in-reply-to:message-id :mime-version:reply-to:sender:subject:subject:to:to:x-me-proxy :x-me-proxy:x-me-sender:x-me-sender:x-sasl-enc; s=fm3; t= 1698401730; x=1698488130; bh=WZdjxCp3bh23wXzyYWJMOrvGO73c2yml5Qd gM9BXObQ=; b=f5Wn+uV7ZWzjJr0urgEmaoJpGSlVn+aQTVcZR+1ruuhI9HtNzQ5 py1SgP2Pdm0jWbSKLSySrOHjWBlH7T0NCJgqop33PJPqq1G6R1QLrNjGLSoat04V UkaiG9+Ek76Y/XUmJoFexVgijnERf5GewSKc4ZhGISBiIrzx3Vz4qmA4ZkSOuVpE jFQjR+Wp9TyrRlKRFL1WkbmrccqykkFnoatVGV378rppzGllrFK9Nsyj5gDSFdl6 jAL/q9J0i7F1W66dlXF1iXkKY9ZvibGX8Z8bV87bwVhHid2Wj08yGKq+o/+zAlNa dGh1NR+PS13cOjT2skmWe4g9Hscv4DZwrtQ== X-ME-Sender: X-ME-Received: X-ME-Proxy-Cause: gggruggvucftvghtrhhoucdtuddrgedvkedrleeggddvjecutefuodetggdotefrodftvf curfhrohhfihhlvgemucfhrghsthforghilhdpqfgfvfdpuffrtefokffrpgfnqfghnecu uegrihhlohhuthemuceftddtnecunecujfgurhepfffhvffukfggtggusehttdertddttd dvnecuhfhrohhmpehvohhiugcuoehvohhiugesfhdqmhdrfhhmqeenucggtffrrghtthgv rhhnpeevteeivdfffffhleeggeeugeevtdeihfetheetheehteeigfetudfgheelveekhf enucffohhmrghinheptghrrgiflhdrtggrthenucevlhhushhtvghrufhiiigvpedtnecu rfgrrhgrmhepmhgrihhlfhhrohhmpehvohhiugesfhdqmhdrfhhm X-ME-Proxy: Feedback-ID: i2541463c:Fastmail Received: by mail.messagingengine.com (Postfix) with ESMTPA for ; Fri, 27 Oct 2023 06:15:29 -0400 (EDT) Date: Fri, 27 Oct 2023 11:15:25 +0100 From: void To: freebsd-stable@freebsd.org Subject: periodic daily takes a very long time to run (14-stable) Message-ID: Mail-Followup-To: freebsd-stable@freebsd.org List-Id: Production branch of FreeBSD source code List-Archive: https://lists.freebsd.org/archives/freebsd-stable List-Help: List-Post: List-Subscribe: List-Unsubscribe: Sender: owner-freebsd-stable@freebsd.org X-BeenThere: freebsd-stable@freebsd.org MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii; format=flowed Content-Disposition: inline X-Spamd-Result: default: False [-4.12 / 15.00]; DWL_DNSWL_LOW(-1.00)[messagingengine.com:dkim]; NEURAL_HAM_LONG(-1.00)[-1.000]; NEURAL_HAM_MEDIUM(-1.00)[-1.000]; NEURAL_HAM_SHORT(-0.52)[-0.517]; DMARC_POLICY_ALLOW(-0.50)[f-m.fm,none]; MID_RHS_NOT_FQDN(0.50)[]; R_SPF_ALLOW(-0.20)[+ip4:66.111.4.27]; R_DKIM_ALLOW(-0.20)[f-m.fm:s=fm3,messagingengine.com:s=fm3]; MIME_GOOD(-0.10)[text/plain]; RCVD_IN_DNSWL_LOW(-0.10)[66.111.4.27:from]; PREVIOUSLY_DELIVERED(0.00)[freebsd-stable@freebsd.org]; FROM_HAS_DN(0.00)[]; RCPT_COUNT_ONE(0.00)[1]; TO_MATCH_ENVRCPT_ALL(0.00)[]; ARC_NA(0.00)[]; RCVD_TLS_LAST(0.00)[]; ASN(0.00)[asn:19151, ipnet:66.111.4.0/24, country:US]; RCVD_COUNT_THREE(0.00)[3]; TO_DN_NONE(0.00)[]; FREEMAIL_FROM(0.00)[f-m.fm]; MLMMJ_DEST(0.00)[freebsd-stable@freebsd.org]; DKIM_TRACE(0.00)[f-m.fm:+,messagingengine.com:+]; MIME_TRACE(0.00)[0:+]; FROM_EQ_ENVFROM(0.00)[]; FREEMAIL_ENVFROM(0.00)[f-m.fm]; RCVD_VIA_SMTP_AUTH(0.00)[] X-Rspamd-Queue-Id: 4SGz7m3XzFz3gGm X-Spamd-Bar: ---- Hello list, I'm asking this in order to determine whether I've got something misconfigured or maybe my expectations need recalibrating, or maybe both. context is rpi4b with 8GB and usb3-connected 1tb zfs hard disk. /etc/daily.local has been moved out of the way to try to fix the issue. When periodic daily runs, it seems to take a long time. It's running now and has been running for overan hour so far. top shows PID USERNAME THR PRI NICE SIZE RES STATE C TIME WCPU COMMAND 21649 root 1 20 0 18M 6668K zio->i 1 0:40 0.53% find There's plenty of resources 93 processes: 1 running, 92 sleeping CPU: 0.1% user, 0.0% nice, 0.5% system, 0.0% interrupt, 99.4% idle Mem: 202M Active, 688M Inact, 69M Laundry, 3079M Wired, 216K Buf, 3780M Free ARC: 975M Total, 552M MFU, 244M MRU, 808K Anon, 21M Header, 158M Other 229M Compressed, 905M Uncompressed, 3.95:1 Ratio Swap: 12G Total, 12G Free but the 'find' thing does heavy disk i/o and everything else reading from or writing to disk slows to a crawl. # cat /etc/periodic.conf daily_status_smart_devices="da0" daily_status_include_submit_mailq="NO" daily_clean_hoststat_enable="NO" daily_queuerun_enable="NO" daily_submit_queuerun="NO" daily_scrub_zfs_enable="YES" daily_scrub_zfs_pools="" daily_scrub_zfs_default_threshold="7" daily_status_ntpd_enable="YES" daily_clean_disks_enable="YES" zpool last scrubbed on the 21st; it's not happening right now there's the following in /etc/sysctl.conf relevant to the context: vfs.zfs.min_auto_ashift=12 # # filesystem vm.pageout_oom_seq=120 vm.pfault_oom_attempts=-1 vm.pageout_update_period=0 # vfs.zfs.resilver_min_time_ms=5000 vfs.zfs.arc.min=536870912 vfs.zfs.arc_max=1073741824 The OOM settings are there for poudriere. # zdb | grep ashift ashift: 12 # ps xx | grep periodic 68824 11 S+ 0:00.00 grep periodic 16115 14 I+ 0:00.00 /bin/sh - /usr/sbin/periodic daily 17425 14 I+ 0:00.00 lockf -s -t 0 /var/run/periodic.daily.lock /bin/sh /usr/sbin/periodic LOCKED daily 17747 14 I+ 0:00.01 /bin/sh /usr/sbin/periodic LOCKED daily <=== why are there two of these? 19460 14 I+ 0:00.00 /bin/sh /usr/sbin/periodic LOCKED daily <=== 19921 14 I+ 0:00.00 /bin/sh /etc/periodic/daily/100.clean-disks <=== also here 21312 14 I+ 0:00.00 /bin/sh /etc/periodic/daily/100.clean-disks <=== I'm not sure if it's relevant, but the disk, when the zroot/zfs was initialised, was set to enforce 4k blocks, geli-encrypted swap, geli-encrypted fs. Because it's an rpi4, there's no aes-ni equivalent hardware. But the slowdown doesn't show much in other areas, only a couple, like this problem and when git updates src or ports. smartctl shows no remapped or pending blocks. What else can I do to debug the issue? --