Diff of the two buildlogs: -- --- b1/build.log 2021-07-24 19:07:03.932653191 +0000 +++ b2/build.log 2021-07-24 19:20:17.682899405 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Sat Jul 24 07:03:33 -12 2021 -I: pbuilder-time-stamp: 1627153413 +I: Current time: Sat Aug 27 15:30:07 +14 2022 +I: pbuilder-time-stamp: 1661563807 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bullseye-reproducible-base.tgz] I: copying local configuration @@ -16,8 +16,8 @@ I: copying [./fenicsx-performance-tests_0.0~git20210119.80e82ac-1.debian.tar.xz] I: Extracting source gpgv: unknown type of key resource 'trustedkeys.kbx' -gpgv: keyblock resource '/tmp/dpkg-verify-sig.ljMhOw8m/trustedkeys.kbx': General error -gpgv: Signature made Fri Feb 12 03:42:28 2021 -12 +gpgv: keyblock resource '/tmp/dpkg-verify-sig.URZ7K8wa/trustedkeys.kbx': General error +gpgv: Signature made Sat Feb 13 05:42:28 2021 +14 gpgv: using RSA key 23C9A93E585819E9126D0A36573EF1E4BD5A01FA gpgv: Can't check signature: No public key dpkg-source: warning: failed to verify signature on ./fenicsx-performance-tests_0.0~git20210119.80e82ac-1.dsc @@ -26,135 +26,169 @@ dpkg-source: info: unpacking fenicsx-performance-tests_0.0~git20210119.80e82ac-1.debian.tar.xz I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/28942/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/22285/tmp/hooks/D01_modify_environment starting +debug: Running on codethink15-arm64. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +Removing 'diversion of /bin/sh to /bin/sh.distrib by dash' +Adding 'diversion of /bin/sh to /bin/sh.distrib by bash' +Removing 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by dash' +Adding 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by bash' +I: Setting pbuilder2's login shell to /bin/bash +I: Setting pbuilder2's GECOS to second user,second room,second work-phone,second home-phone,second other +I: user script /srv/workspace/pbuilder/22285/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/22285/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='arm64' - DEBIAN_FRONTEND='noninteractive' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:hostcomplete:interactive_comments:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="1" [2]="4" [3]="1" [4]="release" [5]="aarch64-unknown-linux-gnu") + BASH_VERSION='5.1.4(1)-release' + BUILDDIR=/build + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=arm64 + DEBIAN_FRONTEND=noninteractive DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all,-fixfilepath parallel=8' - DISTRIBUTION='' - HOME='/var/lib/jenkins' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION= + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/var/lib/jenkins + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - MAIL='/var/mail/root' - OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' - PBCURRENTCOMMANDLINEOPERATION='build' - PBUILDER_OPERATION='build' - PBUILDER_PKGDATADIR='/usr/share/pbuilder' - PBUILDER_PKGLIBDIR='/usr/lib/pbuilder' - PBUILDER_SYSCONFDIR='/etc' - PPID='28942' - PS1='# ' - PS2='> ' + LANG=C + LANGUAGE=nl_BE:nl + LC_ALL=C + MACHTYPE=aarch64-unknown-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=22285 PS4='+ ' - PWD='/' - SHELL='/bin/bash' - SHLVL='2' - SUDO_COMMAND='/usr/bin/timeout -k 18.1h 18h /usr/bin/ionice -c 3 /usr/bin/nice /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/tmp.KevUTSxycz/pbuilderrc_5azU --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.KevUTSxycz/b1 --logfile b1/build.log fenicsx-performance-tests_0.0~git20210119.80e82ac-1.dsc' - SUDO_GID='117' - SUDO_UID='110' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - USERNAME='root' - _='/usr/bin/systemd-run' - http_proxy='http://192.168.101.16:3128' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/tmp.KevUTSxycz/pbuilderrc_1hLB --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.KevUTSxycz/b2 --logfile b2/build.log --extrapackages usrmerge fenicsx-performance-tests_0.0~git20210119.80e82ac-1.dsc' + SUDO_GID=117 + SUDO_UID=110 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + USERNAME=root + _='I: set' + http_proxy=http://192.168.101.16:3128 I: uname -a - Linux codethink14-arm64 4.15.0-151-generic #157-Ubuntu SMP Fri Jul 9 21:03:48 UTC 2021 aarch64 GNU/Linux + Linux i-capture-the-hostname 4.15.0-151-generic #157-Ubuntu SMP Fri Jul 9 21:03:48 UTC 2021 aarch64 GNU/Linux I: ls -l /bin total 5252 - -rwxr-xr-x 1 root root 1282512 Jun 21 14:26 bash - -rwxr-xr-x 3 root root 34808 Jul 20 2020 bunzip2 - -rwxr-xr-x 3 root root 34808 Jul 20 2020 bzcat - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzcmp -> bzdiff - -rwxr-xr-x 1 root root 2225 Jul 20 2020 bzdiff - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzegrep -> bzgrep - -rwxr-xr-x 1 root root 4877 Sep 4 2019 bzexe - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzfgrep -> bzgrep - -rwxr-xr-x 1 root root 3775 Jul 20 2020 bzgrep - -rwxr-xr-x 3 root root 34808 Jul 20 2020 bzip2 - -rwxr-xr-x 1 root root 14264 Jul 20 2020 bzip2recover - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzless -> bzmore - -rwxr-xr-x 1 root root 1297 Jul 20 2020 bzmore - -rwxr-xr-x 1 root root 39832 Sep 22 2020 cat - -rwxr-xr-x 1 root root 64512 Sep 22 2020 chgrp - -rwxr-xr-x 1 root root 60368 Sep 22 2020 chmod - -rwxr-xr-x 1 root root 64528 Sep 22 2020 chown - -rwxr-xr-x 1 root root 138896 Sep 22 2020 cp - -rwxr-xr-x 1 root root 129544 Dec 10 2020 dash - -rwxr-xr-x 1 root root 101384 Sep 22 2020 date - -rwxr-xr-x 1 root root 80984 Sep 22 2020 dd - -rwxr-xr-x 1 root root 89824 Sep 22 2020 df - -rwxr-xr-x 1 root root 143088 Sep 22 2020 dir - -rwxr-xr-x 1 root root 76152 Feb 7 02:38 dmesg - lrwxrwxrwx 1 root root 8 Nov 6 2019 dnsdomainname -> hostname - lrwxrwxrwx 1 root root 8 Nov 6 2019 domainname -> hostname - -rwxr-xr-x 1 root root 35632 Sep 22 2020 echo - -rwxr-xr-x 1 root root 28 Nov 9 2020 egrep - -rwxr-xr-x 1 root root 31512 Sep 22 2020 false - -rwxr-xr-x 1 root root 28 Nov 9 2020 fgrep - -rwxr-xr-x 1 root root 64856 Feb 7 02:38 findmnt - -rwsr-xr-x 1 root root 34824 Feb 26 04:12 fusermount - -rwxr-xr-x 1 root root 178400 Nov 9 2020 grep - -rwxr-xr-x 2 root root 2346 Mar 2 11:30 gunzip - -rwxr-xr-x 1 root root 6376 Mar 2 11:30 gzexe - -rwxr-xr-x 1 root root 93744 Mar 2 11:30 gzip - -rwxr-xr-x 1 root root 18440 Nov 6 2019 hostname - -rwxr-xr-x 1 root root 68720 Sep 22 2020 ln - -rwxr-xr-x 1 root root 52720 Feb 7 2020 login - -rwxr-xr-x 1 root root 143088 Sep 22 2020 ls - -rwxr-xr-x 1 root root 161960 Feb 7 02:38 lsblk - -rwxr-xr-x 1 root root 85200 Sep 22 2020 mkdir - -rwxr-xr-x 1 root root 68744 Sep 22 2020 mknod - -rwxr-xr-x 1 root root 43976 Sep 22 2020 mktemp - -rwxr-xr-x 1 root root 51368 Feb 7 02:38 more - -rwsr-xr-x 1 root root 51360 Feb 7 02:38 mount - -rwxr-xr-x 1 root root 14496 Feb 7 02:38 mountpoint - -rwxr-xr-x 1 root root 134808 Sep 22 2020 mv - lrwxrwxrwx 1 root root 8 Nov 6 2019 nisdomainname -> hostname - lrwxrwxrwx 1 root root 14 Apr 18 03:38 pidof -> /sbin/killall5 - -rwxr-xr-x 1 root root 35720 Sep 22 2020 pwd - lrwxrwxrwx 1 root root 4 Jun 21 14:26 rbash -> bash - -rwxr-xr-x 1 root root 43872 Sep 22 2020 readlink - -rwxr-xr-x 1 root root 68592 Sep 22 2020 rm - -rwxr-xr-x 1 root root 43880 Sep 22 2020 rmdir - -rwxr-xr-x 1 root root 19208 Sep 27 2020 run-parts - -rwxr-xr-x 1 root root 114016 Dec 22 2018 sed - lrwxrwxrwx 1 root root 4 Jul 23 21:25 sh -> dash - -rwxr-xr-x 1 root root 35656 Sep 22 2020 sleep - -rwxr-xr-x 1 root root 72640 Sep 22 2020 stty - -rwsr-xr-x 1 root root 67776 Feb 7 02:38 su - -rwxr-xr-x 1 root root 35672 Sep 22 2020 sync - -rwxr-xr-x 1 root root 535768 Feb 16 21:55 tar - -rwxr-xr-x 1 root root 10568 Sep 27 2020 tempfile - -rwxr-xr-x 1 root root 89120 Sep 22 2020 touch - -rwxr-xr-x 1 root root 31512 Sep 22 2020 true - -rwxr-xr-x 1 root root 14264 Feb 26 04:12 ulockmgr_server - -rwsr-xr-x 1 root root 30880 Feb 7 02:38 umount - -rwxr-xr-x 1 root root 35640 Sep 22 2020 uname - -rwxr-xr-x 2 root root 2346 Mar 2 11:30 uncompress - -rwxr-xr-x 1 root root 143088 Sep 22 2020 vdir - -rwxr-xr-x 1 root root 59584 Feb 7 02:38 wdctl - lrwxrwxrwx 1 root root 8 Nov 6 2019 ypdomainname -> hostname - -rwxr-xr-x 1 root root 1984 Mar 2 11:30 zcat - -rwxr-xr-x 1 root root 1678 Mar 2 11:30 zcmp - -rwxr-xr-x 1 root root 5880 Mar 2 11:30 zdiff - -rwxr-xr-x 1 root root 29 Mar 2 11:30 zegrep - -rwxr-xr-x 1 root root 29 Mar 2 11:30 zfgrep - -rwxr-xr-x 1 root root 2081 Mar 2 11:30 zforce - -rwxr-xr-x 1 root root 7585 Mar 2 11:30 zgrep - -rwxr-xr-x 1 root root 2206 Mar 2 11:30 zless - -rwxr-xr-x 1 root root 1842 Mar 2 11:30 zmore - -rwxr-xr-x 1 root root 4553 Mar 2 11:30 znew -I: user script /srv/workspace/pbuilder/28942/tmp/hooks/D02_print_environment finished + -rwxr-xr-x 1 root root 1282512 Jun 22 2021 bash + -rwxr-xr-x 3 root root 34808 Jul 21 2020 bunzip2 + -rwxr-xr-x 3 root root 34808 Jul 21 2020 bzcat + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzcmp -> bzdiff + -rwxr-xr-x 1 root root 2225 Jul 21 2020 bzdiff + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzegrep -> bzgrep + -rwxr-xr-x 1 root root 4877 Sep 5 2019 bzexe + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzfgrep -> bzgrep + -rwxr-xr-x 1 root root 3775 Jul 21 2020 bzgrep + -rwxr-xr-x 3 root root 34808 Jul 21 2020 bzip2 + -rwxr-xr-x 1 root root 14264 Jul 21 2020 bzip2recover + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzless -> bzmore + -rwxr-xr-x 1 root root 1297 Jul 21 2020 bzmore + -rwxr-xr-x 1 root root 39832 Sep 23 2020 cat + -rwxr-xr-x 1 root root 64512 Sep 23 2020 chgrp + -rwxr-xr-x 1 root root 60368 Sep 23 2020 chmod + -rwxr-xr-x 1 root root 64528 Sep 23 2020 chown + -rwxr-xr-x 1 root root 138896 Sep 23 2020 cp + -rwxr-xr-x 1 root root 129544 Dec 11 2020 dash + -rwxr-xr-x 1 root root 101384 Sep 23 2020 date + -rwxr-xr-x 1 root root 80984 Sep 23 2020 dd + -rwxr-xr-x 1 root root 89824 Sep 23 2020 df + -rwxr-xr-x 1 root root 143088 Sep 23 2020 dir + -rwxr-xr-x 1 root root 76152 Feb 8 2021 dmesg + lrwxrwxrwx 1 root root 8 Nov 8 2019 dnsdomainname -> hostname + lrwxrwxrwx 1 root root 8 Nov 8 2019 domainname -> hostname + -rwxr-xr-x 1 root root 35632 Sep 23 2020 echo + -rwxr-xr-x 1 root root 28 Nov 10 2020 egrep + -rwxr-xr-x 1 root root 31512 Sep 23 2020 false + -rwxr-xr-x 1 root root 28 Nov 10 2020 fgrep + -rwxr-xr-x 1 root root 64856 Feb 8 2021 findmnt + -rwsr-xr-x 1 root root 34824 Feb 27 2021 fusermount + -rwxr-xr-x 1 root root 178400 Nov 10 2020 grep + -rwxr-xr-x 2 root root 2346 Mar 3 2021 gunzip + -rwxr-xr-x 1 root root 6376 Mar 3 2021 gzexe + -rwxr-xr-x 1 root root 93744 Mar 3 2021 gzip + -rwxr-xr-x 1 root root 18440 Nov 8 2019 hostname + -rwxr-xr-x 1 root root 68720 Sep 23 2020 ln + -rwxr-xr-x 1 root root 52720 Feb 8 2020 login + -rwxr-xr-x 1 root root 143088 Sep 23 2020 ls + -rwxr-xr-x 1 root root 161960 Feb 8 2021 lsblk + -rwxr-xr-x 1 root root 85200 Sep 23 2020 mkdir + -rwxr-xr-x 1 root root 68744 Sep 23 2020 mknod + -rwxr-xr-x 1 root root 43976 Sep 23 2020 mktemp + -rwxr-xr-x 1 root root 51368 Feb 8 2021 more + -rwsr-xr-x 1 root root 51360 Feb 8 2021 mount + -rwxr-xr-x 1 root root 14496 Feb 8 2021 mountpoint + -rwxr-xr-x 1 root root 134808 Sep 23 2020 mv + lrwxrwxrwx 1 root root 8 Nov 8 2019 nisdomainname -> hostname + lrwxrwxrwx 1 root root 14 Apr 19 2021 pidof -> /sbin/killall5 + -rwxr-xr-x 1 root root 35720 Sep 23 2020 pwd + lrwxrwxrwx 1 root root 4 Jun 22 2021 rbash -> bash + -rwxr-xr-x 1 root root 43872 Sep 23 2020 readlink + -rwxr-xr-x 1 root root 68592 Sep 23 2020 rm + -rwxr-xr-x 1 root root 43880 Sep 23 2020 rmdir + -rwxr-xr-x 1 root root 19208 Sep 28 2020 run-parts + -rwxr-xr-x 1 root root 114016 Dec 23 2018 sed + lrwxrwxrwx 1 root root 4 Aug 27 15:30 sh -> bash + lrwxrwxrwx 1 root root 4 Aug 27 05:47 sh.distrib -> dash + -rwxr-xr-x 1 root root 35656 Sep 23 2020 sleep + -rwxr-xr-x 1 root root 72640 Sep 23 2020 stty + -rwsr-xr-x 1 root root 67776 Feb 8 2021 su + -rwxr-xr-x 1 root root 35672 Sep 23 2020 sync + -rwxr-xr-x 1 root root 535768 Feb 17 2021 tar + -rwxr-xr-x 1 root root 10568 Sep 28 2020 tempfile + -rwxr-xr-x 1 root root 89120 Sep 23 2020 touch + -rwxr-xr-x 1 root root 31512 Sep 23 2020 true + -rwxr-xr-x 1 root root 14264 Feb 27 2021 ulockmgr_server + -rwsr-xr-x 1 root root 30880 Feb 8 2021 umount + -rwxr-xr-x 1 root root 35640 Sep 23 2020 uname + -rwxr-xr-x 2 root root 2346 Mar 3 2021 uncompress + -rwxr-xr-x 1 root root 143088 Sep 23 2020 vdir + -rwxr-xr-x 1 root root 59584 Feb 8 2021 wdctl + lrwxrwxrwx 1 root root 8 Nov 8 2019 ypdomainname -> hostname + -rwxr-xr-x 1 root root 1984 Mar 3 2021 zcat + -rwxr-xr-x 1 root root 1678 Mar 3 2021 zcmp + -rwxr-xr-x 1 root root 5880 Mar 3 2021 zdiff + -rwxr-xr-x 1 root root 29 Mar 3 2021 zegrep + -rwxr-xr-x 1 root root 29 Mar 3 2021 zfgrep + -rwxr-xr-x 1 root root 2081 Mar 3 2021 zforce + -rwxr-xr-x 1 root root 7585 Mar 3 2021 zgrep + -rwxr-xr-x 1 root root 2206 Mar 3 2021 zless + -rwxr-xr-x 1 root root 1842 Mar 3 2021 zmore + -rwxr-xr-x 1 root root 4553 Mar 3 2021 znew +I: user script /srv/workspace/pbuilder/22285/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -448,7 +482,7 @@ Get: 246 http://deb.debian.org/debian bullseye/main arm64 python3-basix arm64 0.0.1~git20210122.4f10ef2-2 [74.8 kB] Get: 247 http://deb.debian.org/debian bullseye/main arm64 python3-ffcx all 2019.2.0~git20210122.22ca4c0-2 [106 kB] Get: 248 http://deb.debian.org/debian bullseye/main arm64 libdolfinx-dev all 2019.2.0~git20210130.c14cb0a-5 [149 kB] -Fetched 150 MB in 8s (18.1 MB/s) +Fetched 150 MB in 3s (51.5 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package bsdextrautils. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 19646 files and directories currently installed.) @@ -1481,8 +1515,45 @@ Writing extended state information... Building tag database... -> Finished parsing the build-deps +Reading package lists... +Building dependency tree... +Reading state information... +The following additional packages will be installed: + libfile-find-rule-perl libnumber-compare-perl libtext-glob-perl +The following NEW packages will be installed: + libfile-find-rule-perl libnumber-compare-perl libtext-glob-perl usrmerge +0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. +Need to get 59.5 kB of archives. +After this operation, 157 kB of additional disk space will be used. +Get:1 http://deb.debian.org/debian bullseye/main arm64 libnumber-compare-perl all 0.03-1.1 [6956 B] +Get:2 http://deb.debian.org/debian bullseye/main arm64 libtext-glob-perl all 0.11-1 [8888 B] +Get:3 http://deb.debian.org/debian bullseye/main arm64 libfile-find-rule-perl all 0.34-1 [30.6 kB] +Get:4 http://deb.debian.org/debian bullseye/main arm64 usrmerge all 25 [13.0 kB] +debconf: delaying package configuration, since apt-utils is not installed +Fetched 59.5 kB in 0s (1231 kB/s) +Selecting previously unselected package libnumber-compare-perl. +(Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 54776 files and directories currently installed.) +Preparing to unpack .../libnumber-compare-perl_0.03-1.1_all.deb ... +Unpacking libnumber-compare-perl (0.03-1.1) ... +Selecting previously unselected package libtext-glob-perl. +Preparing to unpack .../libtext-glob-perl_0.11-1_all.deb ... +Unpacking libtext-glob-perl (0.11-1) ... +Selecting previously unselected package libfile-find-rule-perl. +Preparing to unpack .../libfile-find-rule-perl_0.34-1_all.deb ... +Unpacking libfile-find-rule-perl (0.34-1) ... +Selecting previously unselected package usrmerge. +Preparing to unpack .../archives/usrmerge_25_all.deb ... +Unpacking usrmerge (25) ... +Setting up libtext-glob-perl (0.11-1) ... +Setting up libnumber-compare-perl (0.03-1.1) ... +Setting up libfile-find-rule-perl (0.34-1) ... +Setting up usrmerge (25) ... +The system has been successfully converted. +Processing triggers for man-db (2.9.4-2) ... +Not building database; man-db/auto-update is not 'true'. I: Building the package -I: Running cd /build/fenicsx-performance-tests-0.0~git20210119.80e82ac/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-genchanges -S > ../fenicsx-performance-tests_0.0~git20210119.80e82ac-1_source.changes +hostname: Temporary failure in name resolution +I: Running cd /build/fenicsx-performance-tests-0.0~git20210119.80e82ac/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-genchanges -S > ../fenicsx-performance-tests_0.0~git20210119.80e82ac-1_source.changes dpkg-buildpackage: info: source package fenicsx-performance-tests dpkg-buildpackage: info: source version 0.0~git20210119.80e82ac-1 dpkg-buildpackage: info: source distribution unstable @@ -1592,10 +1663,10 @@ make[2]: Entering directory '/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu' make -f CMakeFiles/dolfinx-scaling-test.dir/build.make CMakeFiles/dolfinx-scaling-test.dir/depend make[3]: Entering directory '/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu' +[ 11%] Generating Poisson.c +ffcx /build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src/Poisson.ufl [ 22%] Generating Elasticity.c -[ 22%] Generating Poisson.c ffcx /build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src/Elasticity.ufl -ffcx /build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src/Poisson.ufl cd "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu" && /usr/bin/cmake -E cmake_depends "Unix Makefiles" "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src" "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src" "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu" "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu" "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/CMakeFiles/dolfinx-scaling-test.dir/DependInfo.cmake" --color= Dependee "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/CMakeFiles/dolfinx-scaling-test.dir/DependInfo.cmake" is newer than depender "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/CMakeFiles/dolfinx-scaling-test.dir/depend.internal". Dependee "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/CMakeFiles/CMakeDirectoryInformation.cmake" is newer than depender "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/CMakeFiles/dolfinx-scaling-test.dir/depend.internal". @@ -1603,17 +1674,17 @@ make[3]: Leaving directory '/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu' make -f CMakeFiles/dolfinx-scaling-test.dir/build.make CMakeFiles/dolfinx-scaling-test.dir/build make[3]: Entering directory '/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu' -[ 33%] Building CXX object CMakeFiles/dolfinx-scaling-test.dir/elasticity_problem.cpp.o -/usr/bin/c++ -DBOOST_ALL_NO_LIB -DBOOST_CHRONO_DYN_LINK -DBOOST_PROGRAM_OPTIONS_DYN_LINK -DBOOST_TIMER_DYN_LINK -DDOLFINX_VERSION=\"2019.2.9.99\" -DEIGEN_MAX_ALIGN_BYTES=32 -DHAS_SLEPC -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu" -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src" -isystem /usr/lib/python3/dist-packages/ffcx/codegeneration -isystem /usr/include/eigen3 -isystem /usr/include/hdf5/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include -isystem /usr/lib/petscdir/petsc3.14/aarch64-linux-gnu-real/include -isystem /usr/lib/slepcdir/slepc3.14/aarch64-linux-gnu-real/include -g -O2 -fdebug-prefix-map=/build/fenicsx-performance-tests-0.0~git20210119.80e82ac=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -O3 -DNDEBUG -pthread -std=c++17 -o CMakeFiles/dolfinx-scaling-test.dir/elasticity_problem.cpp.o -c "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src/elasticity_problem.cpp" -[ 44%] Building CXX object CMakeFiles/dolfinx-scaling-test.dir/main.cpp.o -[ 55%] Building C object CMakeFiles/dolfinx-scaling-test.dir/Elasticity.c.o -[ 66%] Building CXX object CMakeFiles/dolfinx-scaling-test.dir/mesh.cpp.o -/usr/bin/cc -DBOOST_ALL_NO_LIB -DBOOST_CHRONO_DYN_LINK -DBOOST_PROGRAM_OPTIONS_DYN_LINK -DBOOST_TIMER_DYN_LINK -DDOLFINX_VERSION=\"2019.2.9.99\" -DEIGEN_MAX_ALIGN_BYTES=32 -DHAS_SLEPC -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu" -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src" -isystem /usr/lib/python3/dist-packages/ffcx/codegeneration -isystem /usr/include/eigen3 -isystem /usr/include/hdf5/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include -isystem /usr/lib/petscdir/petsc3.14/aarch64-linux-gnu-real/include -isystem /usr/lib/slepcdir/slepc3.14/aarch64-linux-gnu-real/include -g -O2 -fdebug-prefix-map=/build/fenicsx-performance-tests-0.0~git20210119.80e82ac=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -O3 -DNDEBUG -pthread -o CMakeFiles/dolfinx-scaling-test.dir/Elasticity.c.o -c "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/Elasticity.c" -[ 77%] Building CXX object CMakeFiles/dolfinx-scaling-test.dir/poisson_problem.cpp.o +[ 33%] Building CXX object CMakeFiles/dolfinx-scaling-test.dir/main.cpp.o /usr/bin/c++ -DBOOST_ALL_NO_LIB -DBOOST_CHRONO_DYN_LINK -DBOOST_PROGRAM_OPTIONS_DYN_LINK -DBOOST_TIMER_DYN_LINK -DDOLFINX_VERSION=\"2019.2.9.99\" -DEIGEN_MAX_ALIGN_BYTES=32 -DHAS_SLEPC -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu" -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src" -isystem /usr/lib/python3/dist-packages/ffcx/codegeneration -isystem /usr/include/eigen3 -isystem /usr/include/hdf5/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include -isystem /usr/lib/petscdir/petsc3.14/aarch64-linux-gnu-real/include -isystem /usr/lib/slepcdir/slepc3.14/aarch64-linux-gnu-real/include -g -O2 -fdebug-prefix-map=/build/fenicsx-performance-tests-0.0~git20210119.80e82ac=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -O3 -DNDEBUG -pthread -std=c++17 -o CMakeFiles/dolfinx-scaling-test.dir/main.cpp.o -c "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src/main.cpp" +[ 44%] Building CXX object CMakeFiles/dolfinx-scaling-test.dir/elasticity_problem.cpp.o +[ 55%] Building CXX object CMakeFiles/dolfinx-scaling-test.dir/mesh.cpp.o +/usr/bin/c++ -DBOOST_ALL_NO_LIB -DBOOST_CHRONO_DYN_LINK -DBOOST_PROGRAM_OPTIONS_DYN_LINK -DBOOST_TIMER_DYN_LINK -DDOLFINX_VERSION=\"2019.2.9.99\" -DEIGEN_MAX_ALIGN_BYTES=32 -DHAS_SLEPC -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu" -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src" -isystem /usr/lib/python3/dist-packages/ffcx/codegeneration -isystem /usr/include/eigen3 -isystem /usr/include/hdf5/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include -isystem /usr/lib/petscdir/petsc3.14/aarch64-linux-gnu-real/include -isystem /usr/lib/slepcdir/slepc3.14/aarch64-linux-gnu-real/include -g -O2 -fdebug-prefix-map=/build/fenicsx-performance-tests-0.0~git20210119.80e82ac=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -O3 -DNDEBUG -pthread -std=c++17 -o CMakeFiles/dolfinx-scaling-test.dir/elasticity_problem.cpp.o -c "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src/elasticity_problem.cpp" +[ 66%] Building CXX object CMakeFiles/dolfinx-scaling-test.dir/poisson_problem.cpp.o /usr/bin/c++ -DBOOST_ALL_NO_LIB -DBOOST_CHRONO_DYN_LINK -DBOOST_PROGRAM_OPTIONS_DYN_LINK -DBOOST_TIMER_DYN_LINK -DDOLFINX_VERSION=\"2019.2.9.99\" -DEIGEN_MAX_ALIGN_BYTES=32 -DHAS_SLEPC -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu" -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src" -isystem /usr/lib/python3/dist-packages/ffcx/codegeneration -isystem /usr/include/eigen3 -isystem /usr/include/hdf5/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include -isystem /usr/lib/petscdir/petsc3.14/aarch64-linux-gnu-real/include -isystem /usr/lib/slepcdir/slepc3.14/aarch64-linux-gnu-real/include -g -O2 -fdebug-prefix-map=/build/fenicsx-performance-tests-0.0~git20210119.80e82ac=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -O3 -DNDEBUG -pthread -std=c++17 -o CMakeFiles/dolfinx-scaling-test.dir/mesh.cpp.o -c "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src/mesh.cpp" -[ 88%] Building C object CMakeFiles/dolfinx-scaling-test.dir/Poisson.c.o /usr/bin/c++ -DBOOST_ALL_NO_LIB -DBOOST_CHRONO_DYN_LINK -DBOOST_PROGRAM_OPTIONS_DYN_LINK -DBOOST_TIMER_DYN_LINK -DDOLFINX_VERSION=\"2019.2.9.99\" -DEIGEN_MAX_ALIGN_BYTES=32 -DHAS_SLEPC -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu" -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src" -isystem /usr/lib/python3/dist-packages/ffcx/codegeneration -isystem /usr/include/eigen3 -isystem /usr/include/hdf5/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include -isystem /usr/lib/petscdir/petsc3.14/aarch64-linux-gnu-real/include -isystem /usr/lib/slepcdir/slepc3.14/aarch64-linux-gnu-real/include -g -O2 -fdebug-prefix-map=/build/fenicsx-performance-tests-0.0~git20210119.80e82ac=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -O3 -DNDEBUG -pthread -std=c++17 -o CMakeFiles/dolfinx-scaling-test.dir/poisson_problem.cpp.o -c "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src/poisson_problem.cpp" +[ 77%] Building C object CMakeFiles/dolfinx-scaling-test.dir/Elasticity.c.o +[ 88%] Building C object CMakeFiles/dolfinx-scaling-test.dir/Poisson.c.o +/usr/bin/cc -DBOOST_ALL_NO_LIB -DBOOST_CHRONO_DYN_LINK -DBOOST_PROGRAM_OPTIONS_DYN_LINK -DBOOST_TIMER_DYN_LINK -DDOLFINX_VERSION=\"2019.2.9.99\" -DEIGEN_MAX_ALIGN_BYTES=32 -DHAS_SLEPC -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu" -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src" -isystem /usr/lib/python3/dist-packages/ffcx/codegeneration -isystem /usr/include/eigen3 -isystem /usr/include/hdf5/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include -isystem /usr/lib/petscdir/petsc3.14/aarch64-linux-gnu-real/include -isystem /usr/lib/slepcdir/slepc3.14/aarch64-linux-gnu-real/include -g -O2 -fdebug-prefix-map=/build/fenicsx-performance-tests-0.0~git20210119.80e82ac=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -O3 -DNDEBUG -pthread -o CMakeFiles/dolfinx-scaling-test.dir/Elasticity.c.o -c "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/Elasticity.c" /usr/bin/cc -DBOOST_ALL_NO_LIB -DBOOST_CHRONO_DYN_LINK -DBOOST_PROGRAM_OPTIONS_DYN_LINK -DBOOST_TIMER_DYN_LINK -DDOLFINX_VERSION=\"2019.2.9.99\" -DEIGEN_MAX_ALIGN_BYTES=32 -DHAS_SLEPC -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu" -I"/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/src" -isystem /usr/lib/python3/dist-packages/ffcx/codegeneration -isystem /usr/include/eigen3 -isystem /usr/include/hdf5/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include/openmpi -isystem /usr/lib/aarch64-linux-gnu/openmpi/include -isystem /usr/lib/petscdir/petsc3.14/aarch64-linux-gnu-real/include -isystem /usr/lib/slepcdir/slepc3.14/aarch64-linux-gnu-real/include -g -O2 -fdebug-prefix-map=/build/fenicsx-performance-tests-0.0~git20210119.80e82ac=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -O3 -DNDEBUG -pthread -o CMakeFiles/dolfinx-scaling-test.dir/Poisson.c.o -c "/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/Poisson.c" [100%] Linking CXX executable dolfinx-scaling-test /usr/bin/cmake -E cmake_link_script CMakeFiles/dolfinx-scaling-test.dir/link.txt --verbose=1 @@ -1659,7 +1730,7 @@ Symmetric graph false Number of levels to square graph 1 Number smoothing steps 1 - Complexity: grid = 1.40852 + Complexity: grid = 1.3984 Coarse grid solver -- level ------------------------------- KSP Object: (mg_coarse_) 8 MPI processes type: preonly @@ -1683,33 +1754,33 @@ tolerance for zero pivot 2.22045e-14 using diagonal shift on blocks to prevent zero pivot [INBLOCKS] matrix ordering: nd - factor fill ratio given 5., needed 1.51295 + factor fill ratio given 5., needed 1.50356 Factored matrix follows: Mat Object: 1 MPI processes type: seqaij - rows=558, cols=558, bs=6 + rows=546, cols=546, bs=6 package used to perform factorization: petsc - total: nonzeros=262908, allocated nonzeros=262908 - using I-node routines: found 167 nodes, limit used is 5 + total: nonzeros=235836, allocated nonzeros=235836 + using I-node routines: found 160 nodes, limit used is 5 linear system matrix = precond matrix: Mat Object: 1 MPI processes type: seqaij - rows=558, cols=558, bs=6 - total: nonzeros=173772, allocated nonzeros=173772 + rows=546, cols=546, bs=6 + total: nonzeros=156852, allocated nonzeros=156852 total number of mallocs used during MatSetValues calls=0 - using I-node routines: found 186 nodes, limit used is 5 + using I-node routines: found 182 nodes, limit used is 5 linear system matrix = precond matrix: Mat Object: 8 MPI processes type: mpiaij - rows=558, cols=558, bs=6 - total: nonzeros=173772, allocated nonzeros=173772 + rows=546, cols=546, bs=6 + total: nonzeros=156852, allocated nonzeros=156852 total number of mallocs used during MatSetValues calls=0 - using I-node (on process 0) routines: found 186 nodes, limit used is 5 + using I-node (on process 0) routines: found 182 nodes, limit used is 5 Down solver (pre-smoother) on level 1 ------------------------------- KSP Object: (mg_levels_1_) 8 MPI processes type: chebyshev - eigenvalue estimates used: min = 0.171292, max = 1.88421 - eigenvalues estimate via cg min 0.0307337, max 1.71292 + eigenvalue estimates used: min = 0.170903, max = 1.87994 + eigenvalues estimate via cg min 0.025989, max 1.70903 eigenvalues estimated using cg with translations [0. 0.1; 0. 1.1] KSP Object: (mg_levels_1_esteig_) 8 MPI processes type: cg @@ -1727,17 +1798,17 @@ linear system matrix = precond matrix: Mat Object: 8 MPI processes type: mpiaij - rows=6456, cols=6456, bs=6 - total: nonzeros=1222560, allocated nonzeros=1222560 + rows=6414, cols=6414, bs=6 + total: nonzeros=1204884, allocated nonzeros=1204884 total number of mallocs used during MatSetValues calls=0 using scalable MatPtAP() implementation - using I-node (on process 0) routines: found 250 nodes, limit used is 5 + using I-node (on process 0) routines: found 206 nodes, limit used is 5 Up solver (post-smoother) same as down solver (pre-smoother) Down solver (pre-smoother) on level 2 ------------------------------- KSP Object: (mg_levels_2_) 8 MPI processes type: chebyshev - eigenvalue estimates used: min = 0.261139, max = 2.87253 - eigenvalues estimate via cg min 0.0508916, max 2.61139 + eigenvalue estimates used: min = 0.261731, max = 2.87904 + eigenvalues estimate via cg min 0.0505966, max 2.61731 eigenvalues estimated using cg with translations [0. 0.1; 0. 1.1] KSP Object: (mg_levels_2_esteig_) 8 MPI processes type: cg @@ -1759,7 +1830,7 @@ total: nonzeros=3418020, allocated nonzeros=3418020 total number of mallocs used during MatSetValues calls=0 has attached near null space - using I-node (on process 0) routines: found 3362 nodes, limit used is 5 + using I-node (on process 0) routines: found 3400 nodes, limit used is 5 Up solver (post-smoother) same as down solver (pre-smoother) linear system matrix = precond matrix: Mat Object: 8 MPI processes @@ -1768,45 +1839,45 @@ total: nonzeros=3418020, allocated nonzeros=3418020 total number of mallocs used during MatSetValues calls=0 has attached near null space - using I-node (on process 0) routines: found 3362 nodes, limit used is 5 + using I-node (on process 0) routines: found 3400 nodes, limit used is 5 -[MPI_AVG] Summary of timings | reps wall avg wall tot ------------------------------------------------------------------------------------------- -Build BoxMesh | 1 2.480040 2.480040 -Build dofmap data | 2 0.018835 0.037671 -Build sparsity | 1 0.007605 0.007605 -Compute SCOTCH graph re-ordering | 2 0.001438 0.002877 -Compute dof reordering map | 2 0.009914 0.019828 -Compute entities of dim = 1 | 1 0.174483 0.174483 -Compute entities of dim = 2 | 1 0.130487 0.130487 -Compute graph partition (SCOTCH) | 1 2.331863 2.331863 -Compute local part of mesh dual graph | 1 0.032373 0.032373 -Compute local-to-local map | 1 0.001202 0.001202 -Compute non-local part of mesh dual graph | 1 0.060828 0.060828 -Compute-local-to-global links for global/local adjacency list | 1 0.000692 0.000692 -Distribute in graph creation AdjacencyList | 1 0.007116 0.007116 -Extract partition boundaries from SCOTCH graph | 1 0.001462 0.001462 -Fetch float data from remote processes | 1 0.000788 0.000788 -Get SCOTCH graph data | 1 0.000011 0.000011 -Init dofmap from element dofmap | 2 0.006150 0.012301 -PETSc Krylov solver | 1 1.786299 1.786299 -SCOTCH: call SCOTCH_dgraphBuild | 1 0.014619 0.014619 -SCOTCH: call SCOTCH_dgraphHalo | 1 0.000927 0.000927 -SCOTCH: call SCOTCH_dgraphPart | 1 2.312347 2.312347 -SCOTCH: call SCOTCH_graphBuild | 2 0.000015 0.000030 -SCOTCH: call SCOTCH_graphOrder | 2 0.001293 0.002585 -SparsityPattern::assemble | 1 0.020914 0.020914 -TOPOLOGY: Create sets | 1 0.010248 0.010248 -ZZZ Assemble matrix | 1 0.238180 0.238180 -ZZZ Assemble vector | 1 0.010830 0.010830 -ZZZ Create Mesh | 1 2.480779 2.480779 -ZZZ Create RHS function | 1 0.057809 0.057809 -ZZZ Create boundary conditions | 1 0.035812 0.035812 -ZZZ Create forms | 1 0.000066 0.000066 -ZZZ Create mesh entity permutations | 1 0.318720 0.318720 -ZZZ Create near-nullspace | 1 0.042734 0.042734 -ZZZ FunctionSpace | 1 0.020222 0.020222 -ZZZ Solve | 1 1.786718 1.786718 +[MPI_AVG] Summary of timings | reps wall avg wall tot +-------------------------------------------------------------------------------------------- +Build BoxMesh | 1 14.149770 14.149770 +Build dofmap data | 2 0.412828 0.825656 +Build sparsity | 1 0.118623 0.118623 +Compute SCOTCH graph re-ordering | 2 0.004988 0.009976 +Compute dof reordering map | 2 0.035761 0.071522 +Compute entities of dim = 1 | 1 1.088115 1.088115 +Compute entities of dim = 2 | 1 0.825281 0.825281 +Compute graph partition (SCOTCH) | 1 12.313922 12.313922 +Compute local part of mesh dual graph | 1 0.078031 0.078031 +Compute local-to-local map | 1 0.001289 0.001289 +Compute non-local part of mesh dual graph | 1 0.131104 0.131104 +Compute-local-to-global links for global/local adjacency list | 1 0.000620 0.000620 +Distribute in graph creation AdjacencyList | 1 0.037365 0.037365 +Extract partition boundaries from SCOTCH graph | 1 0.001558 0.001558 +Fetch float data from remote processes | 1 0.077875 0.077875 +Get SCOTCH graph data | 1 0.000018 0.000018 +Init dofmap from element dofmap | 2 0.013831 0.027663 +PETSc Krylov solver | 1 19.055692 19.055692 +SCOTCH: call SCOTCH_dgraphBuild | 1 0.030957 0.030957 +SCOTCH: call SCOTCH_dgraphHalo | 1 0.031868 0.031868 +SCOTCH: call SCOTCH_dgraphPart | 1 12.245046 12.245046 +SCOTCH: call SCOTCH_graphBuild | 2 0.000016 0.000031 +SCOTCH: call SCOTCH_graphOrder | 2 0.003798 0.007595 +SparsityPattern::assemble | 1 0.405807 0.405807 +TOPOLOGY: Create sets | 1 0.065194 0.065194 +ZZZ Assemble matrix | 1 1.022935 1.022935 +ZZZ Assemble vector | 1 0.038854 0.038854 +ZZZ Create Mesh | 1 14.150593 14.150593 +ZZZ Create RHS function | 1 0.168553 0.168553 +ZZZ Create boundary conditions | 1 0.102532 0.102532 +ZZZ Create forms | 1 0.000093 0.000093 +ZZZ Create mesh entity permutations | 1 1.954588 1.954588 +ZZZ Create near-nullspace | 1 1.156032 1.156032 +ZZZ FunctionSpace | 1 0.386088 0.386088 +ZZZ Solve | 1 19.341763 19.341763 *** Number of Krylov iterations: 16 *** Solution norm: 6.02584e-05 ************************************************************************************************************************ @@ -1815,17 +1886,17 @@ ---------------------------------------------- PETSc Performance Summary: ---------------------------------------------- -/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/dolfinx-scaling-test on a named codethink14-arm64 with 8 processors, by pbuilder1 Sat Jul 24 07:06:19 2021 +/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/dolfinx-scaling-test on a named i-capture-the-hostname with 8 processors, by pbuilder2 Sat Aug 27 15:34:42 2022 Using Petsc Release Version 3.14.5, Mar 03, 2021 Max Max/Min Avg Total -Time (sec): 5.032e+00 1.002 5.031e+00 +Time (sec): 3.952e+01 1.001 3.950e+01 Objects: 3.780e+02 1.005 3.762e+02 -Flop: 2.983e+08 1.451 2.292e+08 1.834e+09 -Flop/sec: 5.927e+07 1.451 4.556e+07 3.645e+08 -MPI Messages: 2.574e+03 1.554 2.092e+03 1.674e+04 -MPI Message Lengths: 1.290e+07 1.609 4.934e+03 8.258e+07 -MPI Reductions: 6.500e+02 1.000 +Flop: 2.629e+08 1.263 2.237e+08 1.790e+09 +Flop/sec: 6.657e+06 1.264 5.663e+06 4.530e+07 +MPI Messages: 2.596e+03 1.726 1.858e+03 1.487e+04 +MPI Message Lengths: 1.304e+07 1.668 5.277e+03 7.845e+07 +MPI Reductions: 6.490e+02 1.000 Flop counting convention: 1 flop = 1 real number operation of type (multiply/divide/add/subtract) e.g., VecAXPY() for real vectors of length N --> 2N flop @@ -1833,7 +1904,7 @@ Summary of Stages: ----- Time ------ ----- Flop ------ --- Messages --- -- Message Lengths -- -- Reductions -- Avg %Total Avg %Total Count %Total Avg %Total Count %Total - 0: Main Stage: 5.0314e+00 100.0% 1.8340e+09 100.0% 1.674e+04 100.0% 4.934e+03 100.0% 6.430e+02 98.9% + 0: Main Stage: 3.9504e+01 100.0% 1.7897e+09 100.0% 1.487e+04 100.0% 5.277e+03 100.0% 6.420e+02 98.9% ------------------------------------------------------------------------------------------------------------------------ See the 'Profiling' chapter of the users' manual for details on interpreting output. @@ -1857,80 +1928,80 @@ --- Event Stage 0: Main Stage -BuildTwoSided 95 1.0 1.3123e-01 3.3 0.00e+00 0.0 9.0e+02 4.0e+00 9.5e+01 1 0 5 0 15 1 0 5 0 15 0 -BuildTwoSidedF 76 1.0 1.3042e-01 3.3 0.00e+00 0.0 4.2e+02 5.8e+04 7.6e+01 1 0 3 30 12 1 0 3 30 12 0 -MatMult 192 1.0 3.2685e-01 1.1 1.22e+08 1.1 8.6e+03 3.2e+03 0.0e+00 6 50 51 33 0 6 50 51 33 0 2806 -MatMultAdd 34 1.0 2.1012e-01 3.8 8.82e+06 1.1 7.8e+02 1.1e+03 0.0e+00 4 4 5 1 0 4 4 5 1 0 321 -MatMultTranspose 34 1.0 3.7584e-02 1.1 8.83e+06 1.1 7.8e+02 1.1e+03 0.0e+00 1 4 5 1 0 1 4 5 1 0 1800 -MatSolve 17 0.0 8.7558e-03 0.0 8.93e+06 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 1020 -MatLUFactorSym 1 1.0 2.3273e-021234.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatLUFactorNum 1 1.0 1.2437e-0157051.3 8.05e+07 0.0 0.0e+00 0.0e+00 0.0e+00 0 4 0 0 0 0 4 0 0 0 647 -MatScale 6 1.0 3.0386e-03 1.1 6.26e+05 1.1 9.0e+01 9.0e+02 0.0e+00 0 0 1 0 0 0 0 1 0 0 1580 -MatResidual 34 1.0 5.5935e-02 1.0 2.12e+07 1.1 1.5e+03 3.1e+03 0.0e+00 1 9 9 6 0 1 9 9 6 0 2821 -MatAssemblyBegin 41 1.0 1.7403e-01 2.2 0.00e+00 0.0 4.2e+02 5.8e+04 1.6e+01 3 0 3 30 2 3 0 3 30 2 0 -MatAssemblyEnd 41 1.0 9.8639e-02 1.0 1.70e+05 2.4 1.0e+03 3.3e+02 7.0e+01 2 0 6 0 11 2 0 6 0 11 10 -MatGetRowIJ 1 0.0 3.5960e-04 0.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatCreateSubMat 2 1.0 3.0168e-02 1.0 0.00e+00 0.0 4.9e+01 3.9e+04 3.0e+01 1 0 0 2 5 1 0 0 2 5 0 -MatGetOrdering 1 0.0 7.9020e-04 0.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatCoarsen 2 1.0 1.7633e-03 1.0 0.00e+00 0.0 7.7e+02 6.3e+02 1.0e+01 0 0 5 1 2 0 0 5 1 2 0 -MatZeroEntries 2 1.0 3.2540e-04 4.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatView 6 1.5 4.7811e-03 2.0 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 0 0 0 0 1 0 0 0 0 1 0 -MatAXPY 2 1.0 1.0710e-02 1.1 6.76e+04 1.1 0.0e+00 0.0e+00 2.0e+00 0 0 0 0 0 0 0 0 0 0 47 -MatTranspose 4 1.0 7.9868e-03 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatMatMultSym 6 1.0 1.1287e-01 1.1 0.00e+00 0.0 4.4e+02 5.9e+03 2.0e+01 2 0 3 3 3 2 0 3 3 3 0 -MatMatMultNum 2 1.0 3.1603e-02 1.0 7.48e+06 1.2 9.0e+01 1.8e+04 2.0e+00 1 3 1 2 0 1 3 1 2 0 1726 -MatPtAPSymbolic 2 1.0 3.1222e-01 1.0 0.00e+00 0.0 5.2e+02 3.1e+04 1.4e+01 6 0 3 20 2 6 0 3 20 2 0 -MatPtAPNumeric 2 1.0 4.5979e-01 1.0 6.98e+07 1.2 3.8e+02 3.9e+04 1.2e+01 9 28 2 18 2 9 28 2 18 2 1128 -MatTrnMatMultSym 1 1.0 6.1926e-02 1.0 0.00e+00 0.0 2.9e+02 1.8e+04 1.3e+01 1 0 2 6 2 1 0 2 6 2 0 -MatGetLocalMat 7 1.0 7.9233e-03 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatGetBrAoCol 6 1.0 1.2585e-02 1.2 0.00e+00 0.0 6.3e+02 2.7e+04 0.0e+00 0 0 4 20 0 0 0 4 20 0 0 -VecDot 36 1.0 1.9484e-03 1.0 7.48e+05 1.1 0.0e+00 0.0e+00 3.6e+01 0 0 0 0 6 0 0 0 0 6 2963 -VecMDot 20 1.0 6.2151e-03 2.2 1.24e+06 1.1 0.0e+00 0.0e+00 2.0e+01 0 1 0 0 3 0 1 0 0 3 1533 -VecTDot 74 1.0 8.8739e-03 2.7 1.14e+06 1.1 0.0e+00 0.0e+00 7.4e+01 0 0 0 0 11 0 0 0 0 12 988 -VecNorm 68 1.0 7.2915e-03 1.5 9.94e+05 1.1 0.0e+00 0.0e+00 6.8e+01 0 0 0 0 10 0 0 0 0 11 1051 -VecScale 28 1.0 2.8708e-04 1.1 1.86e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 4996 -VecCopy 116 1.0 1.6554e-03 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecSet 179 1.0 5.4326e-04 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecAXPY 83 1.0 3.4988e-03 1.3 1.32e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 2919 -VecAYPX 237 1.0 7.4190e-03 1.2 2.04e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 2123 -VecAXPBYCZ 68 1.0 3.6105e-03 1.6 1.92e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 4080 -VecMAXPY 22 1.0 2.6370e-03 1.3 1.47e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 4272 -VecAssemblyBegin 61 1.0 2.8427e-03 2.6 0.00e+00 0.0 0.0e+00 0.0e+00 6.0e+01 0 0 0 0 9 0 0 0 0 9 0 -VecAssemblyEnd 61 1.0 1.6542e-04 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecPointwiseMult 180 1.0 6.2573e-03 1.4 1.01e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 1246 -VecScatterBegin 327 1.0 1.3552e-02 1.3 0.00e+00 0.0 1.3e+04 2.5e+03 0.0e+00 0 0 79 40 0 0 0 79 40 0 0 -VecScatterEnd 327 1.0 2.0988e-01 4.3 3.60e+04 4.6 0.0e+00 0.0e+00 0.0e+00 4 0 0 0 0 4 0 0 0 0 1 -VecSetRandom 2 1.0 8.4592e-04 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecNormalize 28 1.0 2.3000e-03 1.6 5.58e+05 1.1 0.0e+00 0.0e+00 2.8e+01 0 0 0 0 4 0 0 0 0 4 1871 -SFSetGraph 19 1.0 8.1120e-05 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFSetUp 19 1.0 2.3133e-03 1.1 0.00e+00 0.0 1.4e+03 3.2e+02 1.9e+01 0 0 8 1 3 0 0 8 1 3 0 -SFBcastOpBegin 304 1.0 1.1889e-02 1.4 0.00e+00 0.0 1.3e+04 2.5e+03 0.0e+00 0 0 78 39 0 0 0 78 39 0 0 -SFBcastOpEnd 304 1.0 2.0345e-01 4.8 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 3 0 0 0 0 3 0 0 0 0 0 -SFReduceBegin 35 1.0 8.3648e-04 1.3 0.00e+00 0.0 8.2e+02 1.2e+03 0.0e+00 0 0 5 1 0 0 0 5 1 0 0 -SFReduceEnd 35 1.0 7.7531e-03 4.0 3.60e+04 4.6 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 16 -SFPack 339 1.0 4.4638e-03 1.7 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFUnpack 339 1.0 5.1632e-04 1.5 3.60e+04 4.6 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 236 -KSPSetUp 7 1.0 4.1941e-02 1.0 1.38e+07 1.1 9.0e+02 3.1e+03 7.2e+01 1 6 5 3 11 1 6 5 3 11 2467 -KSPSolve 1 1.0 1.7771e+00 1.0 2.95e+08 1.5 1.6e+04 4.7e+03 5.5e+02 35 99 98 93 85 35 99 98 93 86 1018 -KSPGMRESOrthog 20 1.0 8.5925e-03 1.8 2.48e+06 1.1 0.0e+00 0.0e+00 2.0e+01 0 1 0 0 3 0 1 0 0 3 2218 -PCGAMGGraph_AGG 2 1.0 1.6329e-01 1.0 6.77e+05 1.1 4.5e+02 3.6e+02 3.8e+01 3 0 3 0 6 3 0 3 0 6 31 -PCGAMGCoarse_AGG 2 1.0 6.7059e-02 1.0 0.00e+00 0.0 1.3e+03 4.8e+03 3.1e+01 1 0 8 8 5 1 0 8 8 5 0 -PCGAMGProl_AGG 2 1.0 3.0235e-02 1.0 0.00e+00 0.0 2.9e+03 1.3e+03 1.9e+02 1 0 17 5 29 1 0 17 5 29 0 -PCGAMGPOpt_AGG 2 1.0 1.4231e-01 1.0 2.36e+07 1.1 1.4e+03 4.9e+03 8.2e+01 3 10 9 8 13 3 10 9 8 13 1235 -GAMG: createProl 2 1.0 4.0338e-01 1.0 2.43e+07 1.1 6.1e+03 2.8e+03 3.4e+02 8 10 36 21 52 8 10 36 21 53 448 - Graph 4 1.0 1.6307e-01 1.0 6.77e+05 1.1 4.5e+02 3.6e+02 3.8e+01 3 0 3 0 6 3 0 3 0 6 31 - MIS/Agg 2 1.0 1.8074e-03 1.0 0.00e+00 0.0 7.7e+02 6.3e+02 1.0e+01 0 0 5 1 2 0 0 5 1 2 0 - SA: col data 2 1.0 1.3444e-02 1.0 0.00e+00 0.0 2.7e+03 1.0e+03 1.7e+02 0 0 16 3 26 0 0 16 3 26 0 - SA: frmProl0 2 1.0 1.6198e-02 1.0 0.00e+00 0.0 2.0e+02 4.5e+03 1.2e+01 0 0 1 1 2 0 0 1 1 2 0 - SA: smooth 2 1.0 9.6123e-02 1.0 8.06e+06 1.2 5.3e+02 8.0e+03 2.8e+01 2 3 3 5 4 2 3 3 5 4 614 -GAMG: partLevel 2 1.0 8.0342e-01 1.0 6.98e+07 1.2 1.0e+03 3.3e+04 8.1e+01 16 28 6 40 12 16 28 6 40 13 646 - repartition 1 1.0 3.2951e-02 1.0 0.00e+00 0.0 9.4e+01 2.1e+04 5.5e+01 1 0 1 2 8 1 0 1 2 9 0 - Invert-Sort 1 1.0 2.0126e-04 1.5 0.00e+00 0.0 0.0e+00 0.0e+00 6.0e+00 0 0 0 0 1 0 0 0 0 1 0 - Move A 1 1.0 2.1144e-02 1.0 0.00e+00 0.0 3.5e+01 5.5e+04 1.6e+01 0 0 0 2 2 0 0 0 2 2 0 - Move P 1 1.0 9.3313e-03 1.0 0.00e+00 0.0 1.4e+01 4.8e+02 1.7e+01 0 0 0 0 3 0 0 0 0 3 0 -PCSetUp 2 1.0 1.3987e+00 1.1 1.75e+08 1.9 8.0e+03 6.6e+03 5.0e+02 25 48 48 64 77 25 48 48 64 78 632 -PCSetUpOnBlocks 17 1.0 1.4863e-01791.1 8.05e+07 0.0 0.0e+00 0.0e+00 0.0e+00 0 4 0 0 0 0 4 0 0 0 542 -PCApply 39 1.0 4.8683e-01 1.0 1.85e+08 2.0 7.7e+03 2.7e+03 4.0e+00 10 48 46 25 1 10 48 46 25 1 1814 +BuildTwoSided 95 1.0 2.6982e+00 1.4 0.00e+00 0.0 8.4e+02 4.0e+00 9.5e+01 6 0 6 0 15 6 0 6 0 15 0 +BuildTwoSidedF 76 1.0 2.0314e+00 1.4 0.00e+00 0.0 4.1e+02 5.6e+04 7.6e+01 4 0 3 29 12 4 0 3 29 12 0 +MatMult 192 1.0 3.2320e+00 1.1 1.25e+08 1.2 7.4e+03 3.6e+03 0.0e+00 8 51 50 34 0 8 51 50 34 0 283 +MatMultAdd 34 1.0 9.2634e-01 2.1 8.93e+06 1.2 7.8e+02 1.1e+03 0.0e+00 2 4 5 1 0 2 4 5 1 0 72 +MatMultTranspose 34 1.0 5.6483e-01 1.9 8.94e+06 1.2 7.8e+02 1.1e+03 0.0e+00 1 4 5 1 0 1 4 5 1 0 118 +MatSolve 17 0.0 8.6754e-03 0.0 8.01e+06 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 923 +MatLUFactorSym 1 1.0 7.3157e-022490.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatLUFactorNum 1 1.0 3.4845e-01130995.8 6.34e+07 0.0 0.0e+00 0.0e+00 0.0e+00 0 4 0 0 0 0 4 0 0 0 182 +MatScale 6 1.0 4.1063e-02 1.4 6.33e+05 1.1 7.8e+01 1.0e+03 0.0e+00 0 0 1 0 0 0 0 1 0 0 116 +MatResidual 34 1.0 5.7653e-01 1.1 2.17e+07 1.2 1.3e+03 3.4e+03 0.0e+00 1 9 9 6 0 1 9 9 6 0 273 +MatAssemblyBegin 41 1.0 1.0605e+00 1.7 0.00e+00 0.0 4.1e+02 5.6e+04 1.6e+01 2 0 3 29 2 2 0 3 29 2 0 +MatAssemblyEnd 41 1.0 1.9416e+00 1.1 1.78e+05 3.4 9.4e+02 3.5e+02 7.0e+01 5 0 6 0 11 5 0 6 0 11 0 +MatGetRowIJ 1 0.0 3.4702e-04 0.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatCreateSubMat 2 1.0 6.9591e-01 1.1 0.00e+00 0.0 4.9e+01 3.5e+04 3.0e+01 2 0 0 2 5 2 0 0 2 5 0 +MatGetOrdering 1 0.0 7.7790e-04 0.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatCoarsen 2 1.0 4.7532e-01 1.1 0.00e+00 0.0 6.3e+02 6.4e+02 9.0e+00 1 0 4 1 1 1 0 4 1 1 0 +MatZeroEntries 2 1.0 3.8926e-04 3.9 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatView 6 1.5 1.3595e-01 2.0 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 0 0 0 0 1 0 0 0 0 1 0 +MatAXPY 2 1.0 6.7919e-02 1.5 6.79e+04 1.2 0.0e+00 0.0e+00 2.0e+00 0 0 0 0 0 0 0 0 0 0 7 +MatTranspose 4 1.0 2.3593e-02 2.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatMatMultSym 6 1.0 7.9249e-01 1.1 0.00e+00 0.0 4.0e+02 6.3e+03 2.0e+01 2 0 3 3 3 2 0 3 3 3 0 +MatMatMultNum 2 1.0 1.5177e-01 1.3 7.67e+06 1.3 7.8e+01 2.0e+04 2.0e+00 0 3 1 2 0 0 3 1 2 0 358 +MatPtAPSymbolic 2 1.0 1.2875e+00 1.0 0.00e+00 0.0 4.8e+02 3.2e+04 1.4e+01 3 0 3 19 2 3 0 3 19 2 0 +MatPtAPNumeric 2 1.0 1.4847e+00 1.0 7.14e+07 1.4 3.6e+02 3.8e+04 1.2e+01 4 28 2 17 2 4 28 2 17 2 335 +MatTrnMatMultSym 1 1.0 6.7174e-01 1.1 0.00e+00 0.0 2.6e+02 1.9e+04 1.3e+01 2 0 2 6 2 2 0 2 6 2 0 +MatGetLocalMat 7 1.0 1.3679e-02 2.8 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatGetBrAoCol 6 1.0 2.3028e-01 1.2 0.00e+00 0.0 5.5e+02 2.9e+04 0.0e+00 1 0 4 20 0 1 0 4 20 0 0 +VecDot 36 1.0 8.3920e-01 1.1 7.46e+05 1.1 0.0e+00 0.0e+00 3.6e+01 2 0 0 0 6 2 0 0 0 6 7 +VecMDot 20 1.0 4.3840e-01 1.7 1.24e+06 1.1 0.0e+00 0.0e+00 2.0e+01 1 1 0 0 3 1 1 0 0 3 22 +VecTDot 74 1.0 1.4527e+00 1.3 1.14e+06 1.1 0.0e+00 0.0e+00 7.4e+01 3 0 0 0 11 3 0 0 0 12 6 +VecNorm 68 1.0 1.4087e+00 1.4 9.94e+05 1.1 0.0e+00 0.0e+00 6.8e+01 3 0 0 0 10 3 0 0 0 11 5 +VecScale 28 1.0 5.2784e-04 1.1 1.86e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 2716 +VecCopy 116 1.0 1.1514e-03 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecSet 179 1.0 5.6012e-04 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecAXPY 83 1.0 3.3803e-03 1.2 1.32e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 3021 +VecAYPX 237 1.0 7.2506e-03 1.3 2.05e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 2171 +VecAXPBYCZ 68 1.0 3.8121e-03 1.5 1.92e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 3862 +VecMAXPY 22 1.0 3.2737e-03 1.2 1.47e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 3439 +VecAssemblyBegin 61 1.0 1.1416e+00 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 6.0e+01 3 0 0 0 9 3 0 0 0 9 0 +VecAssemblyEnd 61 1.0 5.9408e-04 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecPointwiseMult 180 1.0 5.2873e-03 1.4 1.02e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 1474 +VecScatterBegin 327 1.0 2.3359e-02 1.4 0.00e+00 0.0 1.2e+04 2.7e+03 0.0e+00 0 0 79 41 0 0 0 79 41 0 0 +VecScatterEnd 327 1.0 5.2192e+00 1.2 3.19e+04 3.0 0.0e+00 0.0e+00 0.0e+00 12 0 0 0 0 12 0 0 0 0 0 +VecSetRandom 2 1.0 8.8262e-04 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecNormalize 28 1.0 5.5964e-01 1.5 5.59e+05 1.1 0.0e+00 0.0e+00 2.8e+01 1 0 0 0 4 1 0 0 0 4 8 +SFSetGraph 19 1.0 1.1308e-04 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFSetUp 19 1.0 9.3723e-01 1.3 0.00e+00 0.0 1.3e+03 3.4e+02 1.9e+01 2 0 9 1 3 2 0 9 1 3 0 +SFBcastOpBegin 303 1.0 2.0768e-02 1.5 0.00e+00 0.0 1.1e+04 2.8e+03 0.0e+00 0 0 77 40 0 0 0 77 40 0 0 +SFBcastOpEnd 303 1.0 4.9887e+00 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 12 0 0 0 0 12 0 0 0 0 0 +SFReduceBegin 35 1.0 1.2294e-03 1.2 0.00e+00 0.0 8.2e+02 1.2e+03 0.0e+00 0 0 6 1 0 0 0 6 1 0 0 +SFReduceEnd 35 1.0 5.4242e-01 1.9 3.19e+04 3.0 0.0e+00 0.0e+00 0.0e+00 1 0 0 0 0 1 0 0 0 0 0 +SFPack 338 1.0 4.5807e-03 1.6 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFUnpack 338 1.0 1.0694e-03 1.2 3.19e+04 3.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 111 +KSPSetUp 7 1.0 1.5123e+00 1.0 1.42e+07 1.2 7.8e+02 3.4e+03 7.2e+01 4 6 5 3 11 4 6 5 3 11 68 +KSPSolve 1 1.0 1.8868e+01 1.0 2.60e+08 1.3 1.4e+04 5.0e+03 5.5e+02 48 99 97 93 85 48 99 97 93 86 94 +KSPGMRESOrthog 20 1.0 4.4105e-01 1.7 2.49e+06 1.1 0.0e+00 0.0e+00 2.0e+01 1 1 0 0 3 1 1 0 0 3 43 +PCGAMGGraph_AGG 2 1.0 1.3962e+00 1.0 6.94e+05 1.2 3.9e+02 4.0e+02 3.8e+01 3 0 3 0 6 3 0 3 0 6 4 +PCGAMGCoarse_AGG 2 1.0 1.3919e+00 1.0 0.00e+00 0.0 1.1e+03 5.5e+03 3.0e+01 3 0 7 8 5 3 0 7 8 5 0 +PCGAMGProl_AGG 2 1.0 3.8753e+00 1.0 0.00e+00 0.0 2.6e+03 1.4e+03 1.9e+02 10 0 17 5 29 10 0 17 5 29 0 +PCGAMGPOpt_AGG 2 1.0 2.0760e+00 1.0 2.42e+07 1.2 1.3e+03 5.4e+03 8.2e+01 5 10 8 9 13 5 10 8 9 13 84 +GAMG: createProl 2 1.0 8.6927e+00 1.0 2.49e+07 1.2 5.3e+03 3.1e+03 3.4e+02 22 10 36 21 52 22 10 36 21 53 21 + Graph 4 1.0 1.3959e+00 1.0 6.94e+05 1.2 3.9e+02 4.0e+02 3.8e+01 3 0 3 0 6 3 0 3 0 6 4 + MIS/Agg 2 1.0 4.7544e-01 1.1 0.00e+00 0.0 6.3e+02 6.4e+02 9.0e+00 1 0 4 1 1 1 0 4 1 1 0 + SA: col data 2 1.0 3.4797e+00 1.0 0.00e+00 0.0 2.4e+03 1.2e+03 1.7e+02 9 0 16 3 26 9 0 16 3 26 0 + SA: frmProl0 2 1.0 2.8786e-01 1.1 0.00e+00 0.0 2.0e+02 4.3e+03 1.2e+01 1 0 1 1 2 1 0 1 1 2 0 + SA: smooth 2 1.0 8.9896e-01 1.0 8.27e+06 1.3 4.8e+02 8.6e+03 2.8e+01 2 3 3 5 4 2 3 3 5 4 65 +GAMG: partLevel 2 1.0 3.9773e+00 1.0 7.14e+07 1.4 9.3e+02 3.3e+04 8.1e+01 10 28 6 39 12 10 28 6 39 13 125 + repartition 1 1.0 1.2341e+00 1.0 0.00e+00 0.0 9.4e+01 1.9e+04 5.5e+01 3 0 1 2 8 3 0 1 2 9 0 + Invert-Sort 1 1.0 1.6789e-01 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 6.0e+00 0 0 0 0 1 0 0 0 0 1 0 + Move A 1 1.0 3.9625e-01 1.1 0.00e+00 0.0 3.5e+01 4.9e+04 1.6e+01 1 0 0 2 2 1 0 0 2 2 0 + Move P 1 1.0 3.5963e-01 1.0 0.00e+00 0.0 1.4e+01 4.6e+02 1.7e+01 1 0 0 0 3 1 0 0 0 3 0 +PCSetUp 2 1.0 1.4754e+01 1.0 1.45e+08 1.5 7.0e+03 7.1e+03 5.0e+02 36 47 47 63 77 36 47 47 63 78 57 +PCSetUpOnBlocks 17 1.0 4.2261e-011549.3 6.34e+07 0.0 0.0e+00 0.0e+00 0.0e+00 0 4 0 0 0 0 4 0 0 0 150 +PCApply 39 1.0 3.6591e+00 1.1 1.62e+08 1.7 6.9e+03 2.9e+03 4.0e+00 9 48 46 25 1 9 48 46 25 1 235 ------------------------------------------------------------------------------------------------------------------------ Memory usage is given in bytes: @@ -1940,22 +2011,22 @@ --- Event Stage 0: Main Stage - Matrix 68 68 26584552 0. + Matrix 68 68 24616052 0. Matrix Coarsen 2 2 1264 0. Matrix Null Space 1 1 704 0. - Index Set 55 55 114444 0. - IS L to G Mapping 6 6 88620 0. + Index Set 55 55 107948 0. + IS L to G Mapping 6 6 84824 0. Vec Scatter 17 17 13872 0. - Vector 185 185 4464696 0. + Vector 185 185 4446968 0. Star Forest Graph 19 19 21888 0. Krylov Solver 9 9 72064 0. Preconditioner 9 9 9148 0. Viewer 3 2 1696 0. PetscRandom 4 4 2616 0. ======================================================================================================================== -Average time to get PetscTime(): 7.8e-08 -Average time for MPI_Barrier(): 2.704e-06 -Average time for zero size MPI_Send(): 2.2625e-06 +Average time to get PetscTime(): 8.4e-08 +Average time for MPI_Barrier(): 0.0223997 +Average time for zero size MPI_Send(): 0.00799874 #PETSc Option Table entries: --ndofs 10000 --problem_type elasticity @@ -2050,7 +2121,7 @@ Symmetric graph false Number of levels to square graph 1 Number smoothing steps 1 - Complexity: grid = 1.40477 + Complexity: grid = 1.4074 Coarse grid solver -- level ------------------------------- KSP Object: (mg_coarse_) 8 MPI processes type: preonly @@ -2074,33 +2145,33 @@ tolerance for zero pivot 2.22045e-14 using diagonal shift on blocks to prevent zero pivot [INBLOCKS] matrix ordering: nd - factor fill ratio given 5., needed 1.4781 + factor fill ratio given 5., needed 1.51635 Factored matrix follows: Mat Object: 1 MPI processes type: seqaij - rows=516, cols=516, bs=6 + rows=570, cols=570, bs=6 package used to perform factorization: petsc - total: nonzeros=233280, allocated nonzeros=233280 - using I-node routines: found 152 nodes, limit used is 5 + total: nonzeros=265356, allocated nonzeros=265356 + using I-node routines: found 164 nodes, limit used is 5 linear system matrix = precond matrix: Mat Object: 1 MPI processes type: seqaij - rows=516, cols=516, bs=6 - total: nonzeros=157824, allocated nonzeros=157824 + rows=570, cols=570, bs=6 + total: nonzeros=174996, allocated nonzeros=174996 total number of mallocs used during MatSetValues calls=0 - using I-node routines: found 172 nodes, limit used is 5 + using I-node routines: found 189 nodes, limit used is 5 linear system matrix = precond matrix: Mat Object: 8 MPI processes type: mpiaij - rows=516, cols=516, bs=6 - total: nonzeros=157824, allocated nonzeros=157824 + rows=570, cols=570, bs=6 + total: nonzeros=174996, allocated nonzeros=174996 total number of mallocs used during MatSetValues calls=0 - using I-node (on process 0) routines: found 172 nodes, limit used is 5 + using I-node (on process 0) routines: found 189 nodes, limit used is 5 Down solver (pre-smoother) on level 1 ------------------------------- KSP Object: (mg_levels_1_) 8 MPI processes type: chebyshev - eigenvalue estimates used: min = 0.178933, max = 1.96827 - eigenvalues estimate via cg min 0.0264421, max 1.78933 + eigenvalue estimates used: min = 0.172525, max = 1.89777 + eigenvalues estimate via cg min 0.0249434, max 1.72525 eigenvalues estimated using cg with translations [0. 0.1; 0. 1.1] KSP Object: (mg_levels_1_esteig_) 8 MPI processes type: cg @@ -2118,17 +2189,17 @@ linear system matrix = precond matrix: Mat Object: 8 MPI processes type: mpiaij - rows=6462, cols=6462, bs=6 - total: nonzeros=1225692, allocated nonzeros=1225692 + rows=6456, cols=6456, bs=6 + total: nonzeros=1217520, allocated nonzeros=1217520 total number of mallocs used during MatSetValues calls=0 using scalable MatPtAP() implementation - using I-node (on process 0) routines: found 242 nodes, limit used is 5 + using I-node (on process 0) routines: found 236 nodes, limit used is 5 Up solver (post-smoother) same as down solver (pre-smoother) Down solver (pre-smoother) on level 2 ------------------------------- KSP Object: (mg_levels_2_) 8 MPI processes type: chebyshev - eigenvalue estimates used: min = 0.260928, max = 2.87021 - eigenvalues estimate via cg min 0.05003, max 2.60928 + eigenvalue estimates used: min = 0.261574, max = 2.87732 + eigenvalues estimate via cg min 0.0463952, max 2.61574 eigenvalues estimated using cg with translations [0. 0.1; 0. 1.1] KSP Object: (mg_levels_2_esteig_) 8 MPI processes type: cg @@ -2150,7 +2221,7 @@ total: nonzeros=3418020, allocated nonzeros=3418020 total number of mallocs used during MatSetValues calls=0 has attached near null space - using I-node (on process 0) routines: found 3362 nodes, limit used is 5 + using I-node (on process 0) routines: found 3309 nodes, limit used is 5 Up solver (post-smoother) same as down solver (pre-smoother) linear system matrix = precond matrix: Mat Object: 8 MPI processes @@ -2159,46 +2230,46 @@ total: nonzeros=3418020, allocated nonzeros=3418020 total number of mallocs used during MatSetValues calls=0 has attached near null space - using I-node (on process 0) routines: found 3362 nodes, limit used is 5 + using I-node (on process 0) routines: found 3309 nodes, limit used is 5 -[MPI_AVG] Summary of timings | reps wall avg wall tot ------------------------------------------------------------------------------------------- -Build BoxMesh | 1 0.603256 0.603256 -Build dofmap data | 2 0.018739 0.037477 -Build sparsity | 1 0.010519 0.010519 -Compute SCOTCH graph re-ordering | 2 0.001528 0.003056 -Compute dof reordering map | 2 0.009973 0.019946 -Compute entities of dim = 1 | 1 0.151545 0.151545 -Compute entities of dim = 2 | 1 0.123360 0.123360 -Compute graph partition (SCOTCH) | 1 0.516775 0.516775 -Compute local part of mesh dual graph | 1 0.027456 0.027456 -Compute local-to-local map | 1 0.001189 0.001189 -Compute non-local part of mesh dual graph | 1 0.004014 0.004014 -Compute-local-to-global links for global/local adjacency list | 1 0.000656 0.000656 -Distribute in graph creation AdjacencyList | 1 0.007030 0.007030 -Extract partition boundaries from SCOTCH graph | 1 0.001406 0.001406 -Fetch float data from remote processes | 1 0.000772 0.000772 -Get SCOTCH graph data | 1 0.000013 0.000013 -Init dofmap from element dofmap | 2 0.006132 0.012264 -PETSc Krylov solver | 1 2.097091 2.097091 -SCOTCH: call SCOTCH_dgraphBuild | 1 0.000254 0.000254 -SCOTCH: call SCOTCH_dgraphHalo | 1 0.000693 0.000693 -SCOTCH: call SCOTCH_dgraphPart | 1 0.511845 0.511845 -SCOTCH: call SCOTCH_graphBuild | 2 0.000014 0.000028 -SCOTCH: call SCOTCH_graphOrder | 2 0.001382 0.002764 -SparsityPattern::assemble | 1 0.031396 0.031396 -TOPOLOGY: Create sets | 1 0.009991 0.009991 -ZZZ Assemble matrix | 1 0.228220 0.228220 -ZZZ Assemble vector | 1 0.011044 0.011044 -ZZZ Create Mesh | 1 0.603940 0.603940 -ZZZ Create RHS function | 1 0.057123 0.057123 -ZZZ Create boundary conditions | 1 0.035445 0.035445 -ZZZ Create forms | 1 0.000072 0.000072 -ZZZ Create mesh entity permutations | 1 0.288576 0.288576 -ZZZ Create near-nullspace | 1 0.041830 0.041830 -ZZZ FunctionSpace | 1 0.019887 0.019887 -ZZZ Solve | 1 2.097497 2.097497 -*** Number of Krylov iterations: 17 +[MPI_AVG] Summary of timings | reps wall avg wall tot +-------------------------------------------------------------------------------------------- +Build BoxMesh | 1 20.578062 20.578062 +Build dofmap data | 2 0.675591 1.351182 +Build sparsity | 1 0.243246 0.243246 +Compute SCOTCH graph re-ordering | 2 0.001819 0.003638 +Compute dof reordering map | 2 0.039898 0.079797 +Compute entities of dim = 1 | 1 1.228577 1.228577 +Compute entities of dim = 2 | 1 1.330675 1.330675 +Compute graph partition (SCOTCH) | 1 18.210915 18.210915 +Compute local part of mesh dual graph | 1 0.092970 0.092970 +Compute local-to-local map | 1 0.003091 0.003091 +Compute non-local part of mesh dual graph | 1 0.155365 0.155365 +Compute-local-to-global links for global/local adjacency list | 1 0.000610 0.000610 +Distribute in graph creation AdjacencyList | 1 0.073084 0.073084 +Extract partition boundaries from SCOTCH graph | 1 0.002132 0.002132 +Fetch float data from remote processes | 1 0.088370 0.088370 +Get SCOTCH graph data | 1 0.000020 0.000020 +Init dofmap from element dofmap | 2 0.021519 0.043037 +PETSc Krylov solver | 1 27.549562 27.549562 +SCOTCH: call SCOTCH_dgraphBuild | 1 0.036945 0.036945 +SCOTCH: call SCOTCH_dgraphHalo | 1 0.047737 0.047737 +SCOTCH: call SCOTCH_dgraphPart | 1 18.118961 18.118961 +SCOTCH: call SCOTCH_graphBuild | 2 0.000016 0.000031 +SCOTCH: call SCOTCH_graphOrder | 2 0.001628 0.003256 +SparsityPattern::assemble | 1 0.459951 0.459951 +TOPOLOGY: Create sets | 1 0.114739 0.114739 +ZZZ Assemble matrix | 1 1.441963 1.441963 +ZZZ Assemble vector | 1 0.060645 0.060645 +ZZZ Create Mesh | 1 20.578885 20.578885 +ZZZ Create RHS function | 1 0.243058 0.243058 +ZZZ Create boundary conditions | 1 0.166814 0.166814 +ZZZ Create forms | 1 0.001606 0.001606 +ZZZ Create mesh entity permutations | 1 2.609239 2.609239 +ZZZ Create near-nullspace | 1 1.616527 1.616527 +ZZZ FunctionSpace | 1 0.721176 0.721176 +ZZZ Solve | 1 27.837496 27.837496 +*** Number of Krylov iterations: 16 *** Solution norm: 6.02584e-05 ************************************************************************************************************************ *** WIDEN YOUR WINDOW TO 120 CHARACTERS. Use 'enscript -r -fCourier9' to print this document *** @@ -2206,17 +2277,17 @@ ---------------------------------------------- PETSc Performance Summary: ---------------------------------------------- -/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/dolfinx-scaling-test on a named codethink14-arm64 with 8 processors, by pbuilder1 Sat Jul 24 07:06:23 2021 +/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/dolfinx-scaling-test on a named i-capture-the-hostname with 8 processors, by pbuilder2 Sat Aug 27 15:36:45 2022 Using Petsc Release Version 3.14.5, Mar 03, 2021 Max Max/Min Avg Total -Time (sec): 3.484e+00 1.002 3.479e+00 +Time (sec): 5.680e+01 1.001 5.679e+01 Objects: 3.780e+02 1.005 3.762e+02 -Flop: 2.859e+08 1.288 2.335e+08 1.868e+09 -Flop/sec: 8.207e+07 1.285 6.711e+07 5.369e+08 -MPI Messages: 2.684e+03 1.722 1.900e+03 1.520e+04 -MPI Message Lengths: 1.258e+07 1.376 5.401e+03 8.209e+07 -MPI Reductions: 6.530e+02 1.000 +Flop: 2.925e+08 1.411 2.282e+08 1.826e+09 +Flop/sec: 5.150e+06 1.411 4.018e+06 3.214e+07 +MPI Messages: 2.554e+03 2.233 1.822e+03 1.458e+04 +MPI Message Lengths: 1.342e+07 1.734 5.533e+03 8.066e+07 +MPI Reductions: 6.480e+02 1.000 Flop counting convention: 1 flop = 1 real number operation of type (multiply/divide/add/subtract) e.g., VecAXPY() for real vectors of length N --> 2N flop @@ -2224,7 +2295,7 @@ Summary of Stages: ----- Time ------ ----- Flop ------ --- Messages --- -- Message Lengths -- -- Reductions -- Avg %Total Avg %Total Count %Total Avg %Total Count %Total - 0: Main Stage: 3.4795e+00 100.0% 1.8681e+09 100.0% 1.520e+04 100.0% 5.401e+03 100.0% 6.460e+02 98.9% + 0: Main Stage: 5.6795e+01 100.0% 1.8255e+09 100.0% 1.458e+04 100.0% 5.533e+03 100.0% 6.410e+02 98.9% ------------------------------------------------------------------------------------------------------------------------ See the 'Profiling' chapter of the users' manual for details on interpreting output. @@ -2248,80 +2319,80 @@ --- Event Stage 0: Main Stage -BuildTwoSided 95 1.0 1.2442e-01 4.6 0.00e+00 0.0 8.5e+02 4.0e+00 9.5e+01 2 0 6 0 15 2 0 6 0 15 0 -BuildTwoSidedF 76 1.0 1.2419e-01 4.7 0.00e+00 0.0 4.3e+02 5.5e+04 7.6e+01 2 0 3 29 12 2 0 3 29 12 0 -MatMult 201 1.0 5.2928e-01 1.0 1.29e+08 1.1 7.8e+03 3.6e+03 0.0e+00 15 51 51 35 0 15 51 51 35 0 1816 -MatMultAdd 36 1.0 2.0604e-01 3.3 9.34e+06 1.1 8.1e+02 1.2e+03 0.0e+00 5 4 5 1 0 5 4 5 1 0 346 -MatMultTranspose 36 1.0 5.7077e-02 1.1 9.35e+06 1.1 8.1e+02 1.2e+03 0.0e+00 2 4 5 1 0 2 4 5 1 0 1252 -MatSolve 18 0.0 8.2005e-03 0.0 8.39e+06 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 1023 -MatLUFactorSym 1 1.0 2.2013e-021216.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatLUFactorNum 1 1.0 1.0944e-0153645.1 6.78e+07 0.0 0.0e+00 0.0e+00 0.0e+00 0 4 0 0 0 0 4 0 0 0 620 -MatScale 6 1.0 3.1101e-03 1.1 6.26e+05 1.1 7.8e+01 1.0e+03 0.0e+00 0 0 1 0 0 0 0 1 0 0 1541 -MatResidual 36 1.0 1.1924e-01 2.0 2.26e+07 1.1 1.4e+03 3.5e+03 0.0e+00 3 9 9 6 0 3 9 9 6 0 1402 -MatAssemblyBegin 41 1.0 1.7659e-01 2.6 0.00e+00 0.0 4.3e+02 5.5e+04 1.6e+01 4 0 3 29 2 4 0 3 29 2 0 -MatAssemblyEnd 41 1.0 9.6469e-02 1.0 1.72e+05 2.1 9.5e+02 3.5e+02 7.0e+01 3 0 6 0 11 3 0 6 0 11 10 -MatGetRowIJ 1 0.0 3.1766e-04 0.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatCreateSubMat 2 1.0 2.8101e-02 1.0 0.00e+00 0.0 4.9e+01 3.5e+04 3.0e+01 1 0 0 2 5 1 0 0 2 5 0 -MatGetOrdering 1 0.0 8.0072e-04 0.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatCoarsen 2 1.0 1.6623e-03 1.1 0.00e+00 0.0 6.3e+02 6.7e+02 1.0e+01 0 0 4 1 2 0 0 4 1 2 0 -MatZeroEntries 2 1.0 3.7706e-04 4.9 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatView 6 1.5 4.4538e-02 1.9 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 1 0 0 0 1 1 0 0 0 1 0 -MatAXPY 2 1.0 1.0580e-02 1.0 6.71e+04 1.1 0.0e+00 0.0e+00 2.0e+00 0 0 0 0 0 0 0 0 0 0 47 -MatTranspose 4 1.0 8.3745e-03 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatMatMultSym 6 1.0 1.1258e-01 1.1 0.00e+00 0.0 4.0e+02 6.4e+03 2.0e+01 3 0 3 3 3 3 0 3 3 3 0 -MatMatMultNum 2 1.0 3.1244e-02 1.0 7.52e+06 1.1 7.8e+01 2.1e+04 2.0e+00 1 3 1 2 0 1 3 1 2 0 1747 -MatPtAPSymbolic 2 1.0 3.1204e-01 1.0 0.00e+00 0.0 4.9e+02 3.3e+04 1.4e+01 9 0 3 19 2 9 0 3 19 2 0 -MatPtAPNumeric 2 1.0 4.6721e-01 1.0 7.07e+07 1.2 3.6e+02 4.0e+04 1.2e+01 13 27 2 18 2 13 27 2 18 2 1094 -MatTrnMatMultSym 1 1.0 6.0742e-02 1.0 0.00e+00 0.0 2.7e+02 1.9e+04 1.3e+01 2 0 2 6 2 2 0 2 6 2 0 -MatGetLocalMat 7 1.0 7.9192e-03 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatGetBrAoCol 6 1.0 1.2203e-02 1.1 0.00e+00 0.0 5.5e+02 3.0e+04 0.0e+00 0 0 4 20 0 0 0 4 20 0 0 -VecDot 36 1.0 1.8187e-03 1.1 7.43e+05 1.1 0.0e+00 0.0e+00 3.6e+01 0 0 0 0 6 0 0 0 0 6 3174 -VecMDot 20 1.0 6.4941e-03 2.1 1.23e+06 1.1 0.0e+00 0.0e+00 2.0e+01 0 1 0 0 3 0 1 0 0 3 1468 -VecTDot 76 1.0 1.7387e-02 2.8 1.17e+06 1.1 0.0e+00 0.0e+00 7.6e+01 0 0 0 0 12 0 0 0 0 12 523 -VecNorm 69 1.0 3.2897e-02 2.9 1.01e+06 1.1 0.0e+00 0.0e+00 6.9e+01 1 0 0 0 11 1 0 0 0 11 238 -VecScale 28 1.0 3.6120e-04 1.4 1.85e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 3971 -VecCopy 122 1.0 1.6975e-03 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecSet 188 1.0 5.4218e-04 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecAXPY 85 1.0 3.2672e-03 1.2 1.36e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 3225 -VecAYPX 250 1.0 7.5762e-03 1.1 2.14e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 2192 -VecAXPBYCZ 72 1.0 4.1020e-03 1.7 2.01e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 3802 -VecMAXPY 22 1.0 2.5609e-03 1.2 1.45e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 4399 -VecAssemblyBegin 61 1.0 2.6567e-03 2.2 0.00e+00 0.0 0.0e+00 0.0e+00 6.0e+01 0 0 0 0 9 0 0 0 0 9 0 -VecAssemblyEnd 61 1.0 1.6348e-04 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecPointwiseMult 188 1.0 6.9548e-03 1.3 1.05e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 1171 -VecScatterBegin 340 1.0 1.5740e-02 1.5 0.00e+00 0.0 1.2e+04 2.8e+03 0.0e+00 0 0 79 41 0 0 0 79 41 0 0 -VecScatterEnd 340 1.0 4.1925e-01 1.5 3.67e+04 3.4 0.0e+00 0.0e+00 0.0e+00 11 0 0 0 0 11 0 0 0 0 0 -VecSetRandom 2 1.0 8.4226e-04 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecNormalize 28 1.0 2.1791e-03 1.4 5.54e+05 1.1 0.0e+00 0.0e+00 2.8e+01 0 0 0 0 4 0 0 0 0 4 1975 -SFSetGraph 19 1.0 8.0240e-05 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFSetUp 19 1.0 2.1792e-03 1.1 0.00e+00 0.0 1.3e+03 3.4e+02 1.9e+01 0 0 8 1 3 0 0 8 1 3 0 -SFBcastOpBegin 315 1.0 1.3935e-02 1.7 0.00e+00 0.0 1.2e+04 2.9e+03 0.0e+00 0 0 77 41 0 0 0 77 41 0 0 -SFBcastOpEnd 315 1.0 3.9481e-01 1.6 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 10 0 0 0 0 10 0 0 0 0 0 -SFReduceBegin 37 1.0 9.0928e-04 1.5 0.00e+00 0.0 8.5e+02 1.2e+03 0.0e+00 0 0 6 1 0 0 0 6 1 0 0 -SFReduceEnd 37 1.0 2.3983e-02 5.1 3.67e+04 3.4 0.0e+00 0.0e+00 0.0e+00 1 0 0 0 0 1 0 0 0 0 5 -SFPack 352 1.0 4.3484e-03 1.6 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFUnpack 352 1.0 5.8082e-04 1.5 3.67e+04 3.4 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 219 -KSPSetUp 7 1.0 4.1558e-02 1.0 1.39e+07 1.1 7.8e+02 3.5e+03 7.2e+01 1 6 5 3 11 1 6 5 3 11 2491 -KSPSolve 1 1.0 2.0219e+00 1.0 2.83e+08 1.3 1.5e+04 5.2e+03 5.5e+02 58 99 97 93 85 58 99 97 93 86 911 -KSPGMRESOrthog 20 1.0 8.7926e-03 1.7 2.46e+06 1.1 0.0e+00 0.0e+00 2.0e+01 0 1 0 0 3 0 1 0 0 3 2168 -PCGAMGGraph_AGG 2 1.0 1.6396e-01 1.0 6.80e+05 1.1 3.9e+02 4.1e+02 3.8e+01 5 0 3 0 6 5 0 3 0 6 31 -PCGAMGCoarse_AGG 2 1.0 6.5663e-02 1.0 0.00e+00 0.0 1.1e+03 5.6e+03 3.1e+01 2 0 7 7 5 2 0 7 7 5 0 -PCGAMGProl_AGG 2 1.0 3.0428e-02 1.0 0.00e+00 0.0 2.4e+03 1.5e+03 1.9e+02 1 0 16 4 29 1 0 16 4 29 0 -PCGAMGPOpt_AGG 2 1.0 1.4133e-01 1.0 2.37e+07 1.1 1.3e+03 5.5e+03 8.2e+01 4 9 8 8 13 4 9 8 8 13 1244 -GAMG: createProl 2 1.0 4.0179e-01 1.0 2.44e+07 1.1 5.2e+03 3.3e+03 3.4e+02 12 10 34 20 52 12 10 34 20 52 450 - Graph 4 1.0 1.6373e-01 1.0 6.80e+05 1.1 3.9e+02 4.1e+02 3.8e+01 5 0 3 0 6 5 0 3 0 6 31 - MIS/Agg 2 1.0 1.7127e-03 1.1 0.00e+00 0.0 6.3e+02 6.7e+02 1.0e+01 0 0 4 1 2 0 0 4 1 2 0 - SA: col data 2 1.0 1.3335e-02 1.0 0.00e+00 0.0 2.2e+03 1.3e+03 1.7e+02 0 0 14 3 26 0 0 14 3 26 0 - SA: frmProl0 2 1.0 1.6447e-02 1.0 0.00e+00 0.0 2.2e+02 4.0e+03 1.2e+01 0 0 1 1 2 0 0 1 1 2 0 - SA: smooth 2 1.0 9.5076e-02 1.0 8.11e+06 1.1 4.8e+02 8.6e+03 2.8e+01 3 3 3 5 4 3 3 3 5 4 621 -GAMG: partLevel 2 1.0 8.0785e-01 1.0 7.07e+07 1.2 9.4e+02 3.4e+04 8.1e+01 23 27 6 39 12 23 27 6 39 13 633 - repartition 1 1.0 3.0782e-02 1.0 0.00e+00 0.0 9.4e+01 1.9e+04 5.5e+01 1 0 1 2 8 1 0 1 2 9 0 - Invert-Sort 1 1.0 2.2428e-04 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 6.0e+00 0 0 0 0 1 0 0 0 0 1 0 - Move A 1 1.0 1.8957e-02 1.0 0.00e+00 0.0 3.5e+01 4.9e+04 1.6e+01 1 0 0 2 2 1 0 0 2 2 0 - Move P 1 1.0 9.4537e-03 1.0 0.00e+00 0.0 1.4e+01 4.4e+02 1.7e+01 0 0 0 0 3 0 0 0 0 3 0 -PCSetUp 2 1.0 1.3851e+00 1.1 1.58e+08 1.7 6.9e+03 7.5e+03 5.0e+02 36 46 45 63 77 36 46 45 63 78 623 -PCSetUpOnBlocks 18 1.0 1.3243e-01712.0 6.78e+07 0.0 0.0e+00 0.0e+00 0.0e+00 0 4 0 0 0 0 4 0 0 0 512 -PCApply 40 1.0 6.8603e-01 1.0 1.76e+08 1.7 7.2e+03 3.0e+03 4.0e+00 19 49 48 26 1 19 49 48 26 1 1336 +BuildTwoSided 95 1.0 4.1859e+00 1.5 0.00e+00 0.0 8.3e+02 4.0e+00 9.5e+01 6 0 6 0 15 6 0 6 0 15 0 +BuildTwoSidedF 76 1.0 3.3632e+00 1.7 0.00e+00 0.0 4.1e+02 5.8e+04 7.6e+01 5 0 3 29 12 5 0 3 29 12 0 +MatMult 192 1.0 4.3154e+00 1.1 1.25e+08 1.2 7.5e+03 3.7e+03 0.0e+00 7 50 51 34 0 7 50 51 34 0 212 +MatMultAdd 34 1.0 1.4512e+00 2.0 9.12e+06 1.1 7.5e+02 1.2e+03 0.0e+00 2 4 5 1 0 2 4 5 1 0 46 +MatMultTranspose 34 1.0 6.5522e-01 1.2 9.13e+06 1.1 7.5e+02 1.2e+03 0.0e+00 1 4 5 1 0 1 4 5 1 0 103 +MatSolve 17 0.0 9.5701e-03 0.0 9.01e+06 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 942 +MatLUFactorSym 1 1.0 9.4926e-023906.4 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatLUFactorNum 1 1.0 6.1799e-01259659.6 7.91e+07 0.0 0.0e+00 0.0e+00 0.0e+00 0 4 0 0 0 0 4 0 0 0 128 +MatScale 6 1.0 9.0881e-02 2.4 6.44e+05 1.1 7.8e+01 1.0e+03 0.0e+00 0 0 1 0 0 0 0 1 0 0 53 +MatResidual 34 1.0 6.9049e-01 1.0 2.16e+07 1.2 1.3e+03 3.5e+03 0.0e+00 1 9 9 6 0 1 9 9 6 0 228 +MatAssemblyBegin 41 1.0 2.0509e+00 2.6 0.00e+00 0.0 4.1e+02 5.8e+04 1.6e+01 3 0 3 29 2 3 0 3 29 2 0 +MatAssemblyEnd 41 1.0 2.6257e+00 1.1 1.62e+05 2.0 9.3e+02 3.6e+02 7.0e+01 5 0 6 0 11 5 0 6 0 11 0 +MatGetRowIJ 1 0.0 4.1812e-04 0.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatCreateSubMat 2 1.0 8.3142e-01 1.1 0.00e+00 0.0 4.9e+01 4.0e+04 3.0e+01 1 0 0 2 5 1 0 0 2 5 0 +MatGetOrdering 1 0.0 9.0100e-04 0.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatCoarsen 2 1.0 4.6411e-01 1.1 0.00e+00 0.0 5.5e+02 7.5e+02 8.0e+00 1 0 4 1 1 1 0 4 1 1 0 +MatZeroEntries 2 1.0 1.2320e-02158.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatView 6 1.5 2.4388e-01 1.9 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 0 0 0 0 1 0 0 0 0 1 0 +MatAXPY 2 1.0 1.1154e-01 1.9 6.91e+04 1.2 0.0e+00 0.0e+00 2.0e+00 0 0 0 0 0 0 0 0 0 0 5 +MatTranspose 4 1.0 4.7066e-02 2.5 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatMatMultSym 6 1.0 1.2530e+00 1.1 0.00e+00 0.0 4.0e+02 6.5e+03 2.0e+01 2 0 3 3 3 2 0 3 3 3 0 +MatMatMultNum 2 1.0 2.7604e-01 1.2 7.63e+06 1.2 7.8e+01 2.1e+04 2.0e+00 0 3 1 2 0 0 3 1 2 0 197 +MatPtAPSymbolic 2 1.0 1.9820e+00 1.0 0.00e+00 0.0 4.8e+02 3.3e+04 1.4e+01 3 0 3 19 2 3 0 3 19 2 0 +MatPtAPNumeric 2 1.0 2.4175e+00 1.0 7.44e+07 1.3 3.6e+02 4.0e+04 1.2e+01 4 28 2 18 2 4 28 2 18 2 212 +MatTrnMatMultSym 1 1.0 5.9224e-01 1.0 0.00e+00 0.0 2.7e+02 1.9e+04 1.3e+01 1 0 2 6 2 1 0 2 6 2 0 +MatGetLocalMat 7 1.0 1.9364e-02 3.7 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatGetBrAoCol 6 1.0 3.4651e-01 1.4 0.00e+00 0.0 5.5e+02 3.0e+04 0.0e+00 1 0 4 20 0 1 0 4 20 0 0 +VecDot 36 1.0 1.1391e+00 1.1 7.62e+05 1.1 0.0e+00 0.0e+00 3.6e+01 2 0 0 0 6 2 0 0 0 6 5 +VecMDot 20 1.0 6.8289e-01 1.7 1.27e+06 1.2 0.0e+00 0.0e+00 2.0e+01 1 1 0 0 3 1 1 0 0 3 14 +VecTDot 74 1.0 1.7820e+00 1.2 1.16e+06 1.1 0.0e+00 0.0e+00 7.4e+01 3 0 0 0 11 3 0 0 0 12 5 +VecNorm 68 1.0 1.9626e+00 1.3 1.01e+06 1.1 0.0e+00 0.0e+00 6.8e+01 3 0 0 0 10 3 0 0 0 11 4 +VecScale 28 1.0 5.3310e-04 1.1 1.90e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 2690 +VecCopy 116 1.0 1.2895e-03 1.4 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecSet 179 1.0 5.4996e-04 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecAXPY 83 1.0 8.7602e-03 3.2 1.35e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 1166 +VecAYPX 237 1.0 1.2368e-02 2.3 2.09e+06 1.1 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 1273 +VecAXPBYCZ 68 1.0 3.1860e-03 1.4 1.96e+06 1.2 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 4623 +VecMAXPY 22 1.0 4.9980e-03 1.8 1.50e+06 1.2 0.0e+00 0.0e+00 0.0e+00 0 1 0 0 0 0 1 0 0 0 2254 +VecAssemblyBegin 61 1.0 1.4837e+00 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 6.0e+01 2 0 0 0 9 2 0 0 0 9 0 +VecAssemblyEnd 61 1.0 7.0656e-04 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecPointwiseMult 180 1.0 6.1746e-03 1.6 1.04e+06 1.2 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 1263 +VecScatterBegin 327 1.0 4.6938e-02 2.6 0.00e+00 0.0 1.2e+04 2.8e+03 0.0e+00 0 0 79 41 0 0 0 79 41 0 0 +VecScatterEnd 327 1.0 7.2999e+00 1.2 3.67e+04 4.2 0.0e+00 0.0e+00 0.0e+00 12 0 0 0 0 12 0 0 0 0 0 +VecSetRandom 2 1.0 8.7896e-04 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecNormalize 28 1.0 8.3304e-01 1.4 5.71e+05 1.1 0.0e+00 0.0e+00 2.8e+01 1 0 0 0 4 1 0 0 0 4 5 +SFSetGraph 19 1.0 1.4938e-04 1.7 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFSetUp 19 1.0 1.1462e+00 1.2 0.00e+00 0.0 1.2e+03 3.5e+02 1.9e+01 2 0 9 1 3 2 0 9 1 3 0 +SFBcastOpBegin 302 1.0 4.4234e-02 2.9 0.00e+00 0.0 1.1e+04 2.9e+03 0.0e+00 0 0 77 40 0 0 0 77 40 0 0 +SFBcastOpEnd 302 1.0 6.9413e+00 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 11 0 0 0 0 11 0 0 0 0 0 +SFReduceBegin 35 1.0 1.3252e-0213.9 0.00e+00 0.0 7.8e+02 1.2e+03 0.0e+00 0 0 5 1 0 0 0 5 1 0 0 +SFReduceEnd 35 1.0 6.5582e-01 1.3 3.67e+04 4.2 0.0e+00 0.0e+00 0.0e+00 1 0 0 0 0 1 0 0 0 0 0 +SFPack 337 1.0 4.6368e-03 1.5 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFUnpack 337 1.0 1.0536e-0211.6 3.67e+04 4.2 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 11 +KSPSetUp 7 1.0 1.8282e+00 1.0 1.41e+07 1.2 7.8e+02 3.5e+03 7.2e+01 3 6 5 3 11 3 6 5 3 11 57 +KSPSolve 1 1.0 2.7168e+01 1.0 2.89e+08 1.4 1.4e+04 5.3e+03 5.5e+02 48 99 97 93 85 48 99 97 93 85 66 +KSPGMRESOrthog 20 1.0 6.8554e-01 1.7 2.53e+06 1.2 0.0e+00 0.0e+00 2.0e+01 1 1 0 0 3 1 1 0 0 3 28 +PCGAMGGraph_AGG 2 1.0 2.1372e+00 1.0 6.90e+05 1.2 3.9e+02 4.1e+02 3.8e+01 4 0 3 0 6 4 0 3 0 6 2 +PCGAMGCoarse_AGG 2 1.0 1.3542e+00 1.1 0.00e+00 0.0 1.0e+03 6.1e+03 2.9e+01 2 0 7 8 4 2 0 7 8 5 0 +PCGAMGProl_AGG 2 1.0 5.9113e+00 1.0 0.00e+00 0.0 2.4e+03 1.5e+03 1.9e+02 10 0 16 5 29 10 0 16 5 29 0 +PCGAMGPOpt_AGG 2 1.0 3.3770e+00 1.0 2.41e+07 1.2 1.3e+03 5.5e+03 8.2e+01 6 10 9 9 13 6 10 9 9 13 52 +GAMG: createProl 2 1.0 1.2669e+01 1.0 2.48e+07 1.2 5.0e+03 3.3e+03 3.4e+02 22 10 35 21 52 22 10 35 21 53 14 + Graph 4 1.0 2.1369e+00 1.0 6.90e+05 1.2 3.9e+02 4.1e+02 3.8e+01 4 0 3 0 6 4 0 3 0 6 2 + MIS/Agg 2 1.0 4.6423e-01 1.1 0.00e+00 0.0 5.5e+02 7.5e+02 8.0e+00 1 0 4 1 1 1 0 4 1 1 0 + SA: col data 2 1.0 5.1979e+00 1.0 0.00e+00 0.0 2.2e+03 1.3e+03 1.7e+02 9 0 15 3 26 9 0 15 3 26 0 + SA: frmProl0 2 1.0 4.5084e-01 1.1 0.00e+00 0.0 2.0e+02 4.7e+03 1.2e+01 1 0 1 1 2 1 0 1 1 2 0 + SA: smooth 2 1.0 1.4314e+00 1.0 8.24e+06 1.2 4.8e+02 8.8e+03 2.8e+01 2 3 3 5 4 2 3 3 5 4 41 +GAMG: partLevel 2 1.0 6.0011e+00 1.0 7.44e+07 1.3 9.3e+02 3.4e+04 8.1e+01 11 28 6 40 12 11 28 6 40 13 85 + repartition 1 1.0 1.6266e+00 1.0 0.00e+00 0.0 9.4e+01 2.2e+04 5.5e+01 3 0 1 3 8 3 0 1 3 9 0 + Invert-Sort 1 1.0 2.0003e-01 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 6.0e+00 0 0 0 0 1 0 0 0 0 1 0 + Move A 1 1.0 5.2812e-01 1.1 0.00e+00 0.0 3.5e+01 5.6e+04 1.6e+01 1 0 0 2 2 1 0 0 2 2 0 + Move P 1 1.0 3.7939e-01 1.1 0.00e+00 0.0 1.4e+01 4.8e+02 1.7e+01 1 0 0 0 3 1 0 0 0 3 0 +PCSetUp 2 1.0 2.1335e+01 1.0 1.71e+08 1.8 6.8e+03 7.6e+03 5.0e+02 36 48 46 64 77 36 48 46 64 78 41 +PCSetUpOnBlocks 17 1.0 7.1405e-012989.9 7.91e+07 0.0 0.0e+00 0.0e+00 0.0e+00 0 4 0 0 0 0 4 0 0 0 111 +PCApply 39 1.0 5.0841e+00 1.1 1.83e+08 2.0 6.8e+03 3.0e+03 4.0e+00 9 48 47 25 1 9 48 47 25 1 173 ------------------------------------------------------------------------------------------------------------------------ Memory usage is given in bytes: @@ -2331,22 +2402,22 @@ --- Event Stage 0: Main Stage - Matrix 68 68 25585472 0. + Matrix 68 68 26320224 0. Matrix Coarsen 2 2 1264 0. Matrix Null Space 1 1 704 0. - Index Set 55 55 116288 0. - IS L to G Mapping 6 6 89704 0. + Index Set 55 55 119712 0. + IS L to G Mapping 6 6 89364 0. Vec Scatter 17 17 13872 0. - Vector 185 185 4467440 0. + Vector 185 185 4413304 0. Star Forest Graph 19 19 21888 0. Krylov Solver 9 9 72064 0. Preconditioner 9 9 9148 0. Viewer 3 2 1696 0. PetscRandom 4 4 2616 0. ======================================================================================================================== -Average time to get PetscTime(): 8.2e-08 -Average time for MPI_Barrier(): 2.968e-06 -Average time for zero size MPI_Send(): 0.00148766 +Average time to get PetscTime(): 8e-08 +Average time for MPI_Barrier(): 0.0215095 +Average time for zero size MPI_Send(): 0.00299554 #PETSc Option Table entries: --ndofs 80000 --problem_type elasticity @@ -2463,42 +2534,42 @@ total number of mallocs used during MatSetValues calls=0 not using I-node (on process 0) routines -[MPI_AVG] Summary of timings | reps wall avg wall tot ------------------------------------------------------------------------------------------- -Build BoxMesh | 1 8.003082 8.003082 -Build dofmap data | 2 0.254127 0.508254 -Build sparsity | 1 0.095683 0.095683 -Compute SCOTCH graph re-ordering | 2 0.005791 0.011581 -Compute connectivity 2-3 | 1 0.004100 0.004100 -Compute dof reordering map | 2 0.036660 0.073321 -Compute entities of dim = 1 | 1 0.652919 0.652919 -Compute entities of dim = 2 | 1 0.647498 0.647498 -Compute graph partition (SCOTCH) | 1 6.893197 6.893197 -Compute local part of mesh dual graph | 1 0.105916 0.105916 -Compute local-to-local map | 1 0.004804 0.004804 -Compute non-local part of mesh dual graph | 1 0.089661 0.089661 -Compute-local-to-global links for global/local adjacency list | 1 0.001991 0.001991 -Distribute in graph creation AdjacencyList | 1 0.028483 0.028483 -Extract partition boundaries from SCOTCH graph | 1 0.003939 0.003939 -Fetch float data from remote processes | 1 0.047586 0.047586 -Get SCOTCH graph data | 1 0.000015 0.000015 -Init dofmap from element dofmap | 2 0.025212 0.050424 -PETSc Krylov solver | 1 1.482533 1.482533 -SCOTCH: call SCOTCH_dgraphBuild | 1 0.006911 0.006911 -SCOTCH: call SCOTCH_dgraphHalo | 1 0.016533 0.016533 -SCOTCH: call SCOTCH_dgraphPart | 1 6.858005 6.858005 -SCOTCH: call SCOTCH_graphBuild | 2 0.000035 0.000071 -SCOTCH: call SCOTCH_graphOrder | 2 0.005486 0.010973 -SparsityPattern::assemble | 1 0.053668 0.053668 -TOPOLOGY: Create sets | 1 0.074101 0.074101 -ZZZ Assemble | 1 0.795956 0.795956 -ZZZ Assemble matrix | 1 0.135100 0.135100 -ZZZ Assemble vector | 1 0.064333 0.064333 -ZZZ Create Mesh | 1 8.004012 8.004012 -ZZZ Create mesh entity permutations | 1 1.351143 1.351143 -ZZZ FunctionSpace | 1 0.223584 0.223584 -ZZZ Solve | 1 1.485918 1.485918 -*** Number of Krylov iterations: 8 +[MPI_AVG] Summary of timings | reps wall avg wall tot +-------------------------------------------------------------------------------------------- +Build BoxMesh | 1 27.656128 27.656128 +Build dofmap data | 2 0.890244 1.780487 +Build sparsity | 1 0.498553 0.498553 +Compute SCOTCH graph re-ordering | 2 0.025674 0.051348 +Compute connectivity 2-3 | 1 0.026013 0.026013 +Compute dof reordering map | 2 0.137486 0.274973 +Compute entities of dim = 1 | 1 2.655607 2.655607 +Compute entities of dim = 2 | 1 2.714975 2.714975 +Compute graph partition (SCOTCH) | 1 24.245441 24.245441 +Compute local part of mesh dual graph | 1 0.269759 0.269759 +Compute local-to-local map | 1 0.012953 0.012953 +Compute non-local part of mesh dual graph | 1 0.148952 0.148952 +Compute-local-to-global links for global/local adjacency list | 1 0.001715 0.001715 +Distribute in graph creation AdjacencyList | 1 0.127775 0.127775 +Extract partition boundaries from SCOTCH graph | 1 0.013901 0.013901 +Fetch float data from remote processes | 1 0.125574 0.125574 +Get SCOTCH graph data | 1 0.000020 0.000020 +Init dofmap from element dofmap | 2 0.081247 0.162495 +PETSc Krylov solver | 1 33.595803 33.595803 +SCOTCH: call SCOTCH_dgraphBuild | 1 0.038271 0.038271 +SCOTCH: call SCOTCH_dgraphHalo | 1 0.035368 0.035368 +SCOTCH: call SCOTCH_dgraphPart | 1 24.134741 24.134741 +SCOTCH: call SCOTCH_graphBuild | 2 0.000037 0.000074 +SCOTCH: call SCOTCH_graphOrder | 2 0.024316 0.048631 +SparsityPattern::assemble | 1 0.773049 0.773049 +TOPOLOGY: Create sets | 1 0.172460 0.172460 +ZZZ Assemble | 1 4.431418 4.431418 +ZZZ Assemble matrix | 1 0.648133 0.648133 +ZZZ Assemble vector | 1 0.122056 0.122056 +ZZZ Create Mesh | 1 27.657099 27.657099 +ZZZ Create mesh entity permutations | 1 5.552085 5.552085 +ZZZ FunctionSpace | 1 0.881358 0.881358 +ZZZ Solve | 1 33.726850 33.726850 +*** Number of Krylov iterations: 7 *** Solution norm: 14540.9 ************************************************************************************************************************ *** WIDEN YOUR WINDOW TO 120 CHARACTERS. Use 'enscript -r -fCourier9' to print this document *** @@ -2506,17 +2577,17 @@ ---------------------------------------------- PETSc Performance Summary: ---------------------------------------------- -/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/dolfinx-scaling-test on a named codethink14-arm64 with 8 processors, by pbuilder1 Sat Jul 24 07:06:36 2021 +/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/dolfinx-scaling-test on a named i-capture-the-hostname with 8 processors, by pbuilder2 Sat Aug 27 15:39:04 2022 Using Petsc Release Version 3.14.5, Mar 03, 2021 Max Max/Min Avg Total -Time (sec): 1.188e+01 1.000 1.188e+01 +Time (sec): 7.256e+01 1.000 7.256e+01 Objects: 3.800e+01 1.000 3.800e+01 -Flop: 4.016e+06 1.070 3.912e+06 3.129e+07 -Flop/sec: 3.381e+05 1.070 3.293e+05 2.635e+06 -MPI Messages: 1.140e+02 2.000 8.800e+01 7.040e+02 -MPI Message Lengths: 6.015e+05 1.483 5.465e+03 3.847e+06 -MPI Reductions: 6.900e+01 1.000 +Flop: 3.564e+06 1.041 3.514e+06 2.811e+07 +Flop/sec: 4.912e+04 1.041 4.843e+04 3.874e+05 +MPI Messages: 1.260e+02 1.750 9.900e+01 7.920e+02 +MPI Message Lengths: 5.788e+05 1.458 4.809e+03 3.809e+06 +MPI Reductions: 6.600e+01 1.000 Flop counting convention: 1 flop = 1 real number operation of type (multiply/divide/add/subtract) e.g., VecAXPY() for real vectors of length N --> 2N flop @@ -2524,7 +2595,7 @@ Summary of Stages: ----- Time ------ ----- Flop ------ --- Messages --- -- Message Lengths -- -- Reductions -- Avg %Total Avg %Total Count %Total Avg %Total Count %Total - 0: Main Stage: 1.1877e+01 100.0% 3.1293e+07 100.0% 7.040e+02 100.0% 5.465e+03 100.0% 6.200e+01 89.9% + 0: Main Stage: 7.2557e+01 100.0% 2.8111e+07 100.0% 7.920e+02 100.0% 4.809e+03 100.0% 5.900e+01 89.4% ------------------------------------------------------------------------------------------------------------------------ See the 'Profiling' chapter of the users' manual for details on interpreting output. @@ -2548,35 +2619,35 @@ --- Event Stage 0: Main Stage -BuildTwoSided 4 1.0 1.5998e-0282.9 0.00e+00 0.0 1.5e+02 4.0e+00 4.0e+00 0 0 21 0 6 0 0 21 0 6 0 -BuildTwoSidedF 1 1.0 1.5833e-0256.6 0.00e+00 0.0 7.2e+01 1.5e+04 1.0e+00 0 0 10 28 1 0 0 10 28 2 0 -MatMult 8 1.0 1.2211e-02 1.2 2.28e+06 1.1 3.0e+02 3.7e+03 0.0e+00 0 57 43 29 0 0 57 43 29 0 1453 -MatConvert 1 1.0 4.5783e-02 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 0 0 0 0 6 0 0 0 0 6 0 -MatAssemblyBegin 2 1.0 2.4596e-02 2.4 0.00e+00 0.0 7.2e+01 1.5e+04 1.0e+00 0 0 10 28 1 0 0 10 28 2 0 -MatAssemblyEnd 2 1.0 5.8618e-02 1.2 7.78e+03 2.0 7.6e+01 9.2e+02 9.0e+00 0 0 11 2 13 0 0 11 2 15 1 -MatGetRowIJ 2 1.0 2.8400e-06 1.5 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatZeroEntries 1 1.0 3.5934e-04 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatView 1 1.0 2.9910e-03 6.3 0.00e+00 0.0 0.0e+00 0.0e+00 1.0e+00 0 0 0 0 1 0 0 0 0 2 0 -VecTDot 16 1.0 3.2147e-03 3.1 3.27e+05 1.1 0.0e+00 0.0e+00 1.6e+01 0 8 0 0 23 0 8 0 0 26 791 -VecNorm 10 1.0 7.5492e-03 4.2 2.05e+05 1.1 0.0e+00 0.0e+00 1.0e+01 0 5 0 0 14 0 5 0 0 16 211 -VecCopy 2 1.0 9.8680e-05 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecSet 12 1.0 1.5492e-04 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecAXPY 16 1.0 1.2517e-03 1.9 3.27e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 8 0 0 0 0 8 0 0 0 2033 -VecAYPX 7 1.0 5.2374e-04 1.9 1.43e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 4 0 0 0 0 4 0 0 0 2125 -VecScatterBegin 11 1.0 7.3174e-04 1.4 0.00e+00 0.0 4.1e+02 3.1e+03 0.0e+00 0 0 59 33 0 0 0 59 33 0 0 -VecScatterEnd 11 1.0 4.9280e-0220.3 1.16e+03 2.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFSetGraph 3 1.0 2.5940e-05 1.5 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFSetUp 3 1.0 4.7760e-04 1.1 0.00e+00 0.0 2.2e+02 5.5e+02 3.0e+00 0 0 31 3 4 0 0 31 3 5 0 -SFBcastOpBegin 10 1.0 6.0808e-04 1.4 0.00e+00 0.0 3.8e+02 3.2e+03 0.0e+00 0 0 53 32 0 0 0 53 32 0 0 -SFBcastOpEnd 10 1.0 2.3606e-03 2.8 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFReduceBegin 1 1.0 4.6440e-05 1.9 0.00e+00 0.0 3.6e+01 1.4e+03 0.0e+00 0 0 5 1 0 0 0 5 1 0 0 -SFReduceEnd 1 1.0 4.6867e-02904.4 1.16e+03 2.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFPack 11 1.0 2.0250e-04 1.6 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFUnpack 11 1.0 4.6600e-05 1.3 1.16e+03 2.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 138 -KSPSetUp 1 1.0 1.1264e-04 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -KSPSolve 1 1.0 1.4792e+00 1.0 3.26e+06 1.1 3.0e+02 3.7e+03 2.9e+01 12 81 43 29 42 12 81 43 29 47 17 -PCSetUp 1 1.0 7.5817e-01 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 6 0 0 0 6 6 0 0 0 6 0 -PCApply 9 1.0 7.0518e-01 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 6 0 0 0 0 6 0 0 0 0 0 +BuildTwoSided 4 1.0 4.8661e-01 3.0 0.00e+00 0.0 1.8e+02 4.0e+00 4.0e+00 0 0 22 0 6 0 0 22 0 7 0 +BuildTwoSidedF 1 1.0 3.7940e-0113.1 0.00e+00 0.0 8.8e+01 1.3e+04 1.0e+00 0 0 11 30 2 0 0 11 30 2 0 +MatMult 7 1.0 1.9352e-01 1.4 1.97e+06 1.0 3.1e+02 3.3e+03 0.0e+00 0 55 39 27 0 0 55 39 27 0 80 +MatConvert 1 1.0 3.8647e-01 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 0 0 0 0 6 0 0 0 0 7 0 +MatAssemblyBegin 2 1.0 3.8959e-01 6.7 0.00e+00 0.0 8.8e+01 1.3e+04 1.0e+00 0 0 11 30 2 0 0 11 30 2 0 +MatAssemblyEnd 2 1.0 4.4664e-01 1.2 7.42e+03 1.7 8.8e+01 8.3e+02 9.0e+00 1 0 11 2 14 1 0 11 2 15 0 +MatGetRowIJ 2 1.0 4.8600e-06 1.6 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatZeroEntries 1 1.0 1.4972e-04 2.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatView 1 1.0 7.7162e-021543.2 0.00e+00 0.0 0.0e+00 0.0e+00 1.0e+00 0 0 0 0 2 0 0 0 0 2 0 +VecTDot 14 1.0 4.0240e-01 1.2 2.83e+05 1.1 0.0e+00 0.0e+00 1.4e+01 0 8 0 0 21 0 8 0 0 24 6 +VecNorm 9 1.0 2.7137e-01 1.4 1.82e+05 1.1 0.0e+00 0.0e+00 9.0e+00 0 5 0 0 14 0 5 0 0 15 5 +VecCopy 2 1.0 6.5160e-05 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecSet 11 1.0 8.9180e-05 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecAXPY 14 1.0 7.9638e-04 1.4 2.83e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 8 0 0 0 0 8 0 0 0 2795 +VecAYPX 6 1.0 3.2116e-04 1.3 1.21e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 3 0 0 0 0 3 0 0 0 2971 +VecScatterBegin 10 1.0 1.2762e-0215.9 0.00e+00 0.0 4.4e+02 2.7e+03 0.0e+00 0 0 56 31 0 0 0 56 31 0 0 +VecScatterEnd 10 1.0 2.9601e-01 1.7 1.10e+03 1.7 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFSetGraph 3 1.0 2.8300e-05 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFSetUp 3 1.0 1.9959e-01 1.3 0.00e+00 0.0 2.6e+02 4.8e+02 3.0e+00 0 0 33 3 5 0 0 33 3 5 0 +SFBcastOpBegin 9 1.0 8.5346e-04 1.5 0.00e+00 0.0 4.0e+02 2.8e+03 0.0e+00 0 0 50 29 0 0 0 50 29 0 0 +SFBcastOpEnd 9 1.0 2.5093e-01 1.6 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFReduceBegin 1 1.0 1.2093e-02296.7 0.00e+00 0.0 4.4e+01 1.2e+03 0.0e+00 0 0 6 1 0 0 0 6 1 0 0 +SFReduceEnd 1 1.0 7.1522e-02 4.5 1.10e+03 1.7 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFPack 10 1.0 1.8962e-04 1.6 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFUnpack 10 1.0 6.9800e-05 1.3 1.10e+03 1.7 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 96 +KSPSetUp 1 1.0 1.1132e-04 1.4 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +KSPSolve 1 1.0 3.3560e+01 1.0 2.82e+06 1.0 3.1e+02 3.3e+03 2.6e+01 46 79 39 27 39 46 79 39 27 44 1 +PCSetUp 1 1.0 1.9110e+01 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 26 0 0 0 6 26 0 0 0 7 0 +PCApply 8 1.0 1.3734e+01 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 19 0 0 0 0 19 0 0 0 0 0 ------------------------------------------------------------------------------------------------------------------------ Memory usage is given in bytes: @@ -2586,19 +2657,19 @@ --- Event Stage 0: Main Stage - Matrix 4 4 2070636 0. - Index Set 6 6 25936 0. - IS L to G Mapping 4 4 179208 0. + Matrix 4 4 2119088 0. + Index Set 6 6 17368 0. + IS L to G Mapping 4 4 175988 0. Vec Scatter 3 3 2448 0. - Vector 14 14 384704 0. + Vector 14 14 374624 0. Star Forest Graph 3 3 3456 0. Krylov Solver 1 1 1488 0. Preconditioner 1 1 1456 0. Viewer 2 1 848 0. ======================================================================================================================== -Average time to get PetscTime(): 8.2e-08 -Average time for MPI_Barrier(): 2.824e-06 -Average time for zero size MPI_Send(): 4.2475e-06 +Average time to get PetscTime(): 9e-08 +Average time for MPI_Barrier(): 0.0320015 +Average time for zero size MPI_Send(): 0.0119993 #PETSc Option Table entries: --ndofs 10000 --problem_type poisson @@ -2709,60 +2780,60 @@ total number of mallocs used during MatSetValues calls=0 not using I-node (on process 0) routines -[MPI_AVG] Summary of timings | reps wall avg wall tot ------------------------------------------------------------------------------------------- -Build BoxMesh | 1 1.401191 1.401191 -Build dofmap data | 2 0.060647 0.121295 -Build sparsity | 1 0.020087 0.020087 -Compute SCOTCH graph re-ordering | 2 0.005176 0.010352 -Compute connectivity 2-3 | 1 0.005329 0.005329 -Compute dof reordering map | 2 0.033311 0.066622 -Compute entities of dim = 1 | 1 0.522295 0.522295 -Compute entities of dim = 2 | 1 0.417221 0.417221 -Compute graph partition (SCOTCH) | 1 1.053180 1.053180 -Compute local part of mesh dual graph | 1 0.096823 0.096823 -Compute local-to-local map | 1 0.004771 0.004771 -Compute non-local part of mesh dual graph | 1 0.080230 0.080230 -Compute-local-to-global links for global/local adjacency list | 1 0.002065 0.002065 -Distribute in graph creation AdjacencyList | 1 0.020228 0.020228 -Extract partition boundaries from SCOTCH graph | 1 0.004020 0.004020 -Fetch float data from remote processes | 1 0.002401 0.002401 -Get SCOTCH graph data | 1 0.000015 0.000015 -Init dofmap from element dofmap | 2 0.019372 0.038744 -PETSc Krylov solver | 1 3.948727 3.948727 -SCOTCH: call SCOTCH_dgraphBuild | 1 0.000619 0.000619 -SCOTCH: call SCOTCH_dgraphHalo | 1 0.002112 0.002112 -SCOTCH: call SCOTCH_dgraphPart | 1 1.039783 1.039783 -SCOTCH: call SCOTCH_graphBuild | 2 0.000035 0.000069 -SCOTCH: call SCOTCH_graphOrder | 2 0.004861 0.009722 -SparsityPattern::assemble | 1 0.056030 0.056030 -TOPOLOGY: Create sets | 1 0.031173 0.031173 -ZZZ Assemble | 1 0.623640 0.623640 -ZZZ Assemble matrix | 1 0.107593 0.107593 -ZZZ Assemble vector | 1 0.027861 0.027861 -ZZZ Create Mesh | 1 1.402034 1.402034 -ZZZ Create mesh entity permutations | 1 0.982015 0.982015 -ZZZ FunctionSpace | 1 0.062753 0.062753 -ZZZ Solve | 1 3.949259 3.949259 -*** Number of Krylov iterations: 7 -*** Solution norm: 14541 +[MPI_AVG] Summary of timings | reps wall avg wall tot +-------------------------------------------------------------------------------------------- +Build BoxMesh | 1 29.833387 29.833387 +Build dofmap data | 2 0.742409 1.484818 +Build sparsity | 1 0.284206 0.284206 +Compute SCOTCH graph re-ordering | 2 0.021235 0.042471 +Compute connectivity 2-3 | 1 0.016978 0.016978 +Compute dof reordering map | 2 0.139454 0.278908 +Compute entities of dim = 1 | 1 2.750982 2.750982 +Compute entities of dim = 2 | 1 2.500194 2.500194 +Compute graph partition (SCOTCH) | 1 26.664673 26.664673 +Compute local part of mesh dual graph | 1 0.306722 0.306722 +Compute local-to-local map | 1 0.014390 0.014390 +Compute non-local part of mesh dual graph | 1 0.202300 0.202300 +Compute-local-to-global links for global/local adjacency list | 1 0.001704 0.001704 +Distribute in graph creation AdjacencyList | 1 0.093075 0.093075 +Extract partition boundaries from SCOTCH graph | 1 0.008629 0.008629 +Fetch float data from remote processes | 1 0.088771 0.088771 +Get SCOTCH graph data | 1 0.000021 0.000021 +Init dofmap from element dofmap | 2 0.080447 0.160893 +PETSc Krylov solver | 1 33.895442 33.895442 +SCOTCH: call SCOTCH_dgraphBuild | 1 0.047251 0.047251 +SCOTCH: call SCOTCH_dgraphHalo | 1 0.052573 0.052573 +SCOTCH: call SCOTCH_dgraphPart | 1 26.531832 26.531832 +SCOTCH: call SCOTCH_graphBuild | 2 0.000789 0.001578 +SCOTCH: call SCOTCH_graphOrder | 2 0.019384 0.038768 +SparsityPattern::assemble | 1 0.677555 0.677555 +TOPOLOGY: Create sets | 1 0.212206 0.212206 +ZZZ Assemble | 1 3.949711 3.949711 +ZZZ Assemble matrix | 1 0.647301 0.647301 +ZZZ Assemble vector | 1 0.108553 0.108553 +ZZZ Create Mesh | 1 29.834261 29.834261 +ZZZ Create mesh entity permutations | 1 5.426393 5.426393 +ZZZ FunctionSpace | 1 0.731737 0.731737 +ZZZ Solve | 1 34.100214 34.100214 +*** Number of Krylov iterations: 8 +*** Solution norm: 14540.9 ************************************************************************************************************************ *** WIDEN YOUR WINDOW TO 120 CHARACTERS. Use 'enscript -r -fCourier9' to print this document *** ************************************************************************************************************************ ---------------------------------------------- PETSc Performance Summary: ---------------------------------------------- -/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/dolfinx-scaling-test on a named codethink14-arm64 with 8 processors, by pbuilder1 Sat Jul 24 07:06:43 2021 +/build/fenicsx-performance-tests-0.0~git20210119.80e82ac/obj-aarch64-linux-gnu/dolfinx-scaling-test on a named i-capture-the-hostname with 8 processors, by pbuilder2 Sat Aug 27 15:41:43 2022 Using Petsc Release Version 3.14.5, Mar 03, 2021 Max Max/Min Avg Total -Time (sec): 7.120e+00 1.001 7.113e+00 +Time (sec): 7.435e+01 1.000 7.434e+01 Objects: 3.800e+01 1.000 3.800e+01 -Flop: 3.603e+06 1.049 3.514e+06 2.811e+07 -Flop/sec: 5.061e+05 1.048 4.940e+05 3.952e+06 -MPI Messages: 1.080e+02 2.000 7.650e+01 6.120e+02 -MPI Message Lengths: 5.969e+05 1.481 6.149e+03 3.763e+06 -MPI Reductions: 6.600e+01 1.000 +Flop: 4.008e+06 1.067 3.912e+06 3.130e+07 +Flop/sec: 5.392e+04 1.068 5.263e+04 4.210e+05 +MPI Messages: 1.330e+02 2.333 8.550e+01 6.840e+02 +MPI Message Lengths: 6.132e+05 1.474 5.552e+03 3.798e+06 +MPI Reductions: 6.900e+01 1.000 Flop counting convention: 1 flop = 1 real number operation of type (multiply/divide/add/subtract) e.g., VecAXPY() for real vectors of length N --> 2N flop @@ -2770,7 +2841,7 @@ Summary of Stages: ----- Time ------ ----- Flop ------ --- Messages --- -- Message Lengths -- -- Reductions -- Avg %Total Avg %Total Count %Total Avg %Total Count %Total - 0: Main Stage: 7.1135e+00 100.0% 2.8114e+07 100.0% 6.120e+02 100.0% 6.149e+03 100.0% 5.900e+01 89.4% + 0: Main Stage: 7.4338e+01 100.0% 3.1296e+07 100.0% 6.840e+02 100.0% 5.552e+03 100.0% 6.200e+01 89.9% ------------------------------------------------------------------------------------------------------------------------ See the 'Profiling' chapter of the users' manual for details on interpreting output. @@ -2794,35 +2865,35 @@ --- Event Stage 0: Main Stage -BuildTwoSided 4 1.0 5.9761e-0319.7 0.00e+00 0.0 1.4e+02 4.0e+00 4.0e+00 0 0 22 0 6 0 0 22 0 7 0 -BuildTwoSidedF 1 1.0 5.7838e-0358.9 0.00e+00 0.0 6.8e+01 1.6e+04 1.0e+00 0 0 11 29 2 0 0 11 29 2 0 -MatMult 7 1.0 4.1394e-02 2.2 1.99e+06 1.0 2.4e+02 4.2e+03 0.0e+00 0 55 39 27 0 0 55 39 27 0 375 -MatConvert 1 1.0 2.2239e-02 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 0 0 0 0 6 0 0 0 0 7 0 -MatAssemblyBegin 2 1.0 1.3310e-02 2.4 0.00e+00 0.0 6.8e+01 1.6e+04 1.0e+00 0 0 11 29 2 0 0 11 29 2 0 -MatAssemblyEnd 2 1.0 1.8731e-02 1.1 7.58e+03 1.8 6.8e+01 1.1e+03 9.0e+00 0 0 11 2 14 0 0 11 2 15 2 -MatGetRowIJ 2 1.0 3.3600e-06 1.5 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatZeroEntries 1 1.0 4.5150e-04 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -MatView 1 1.0 1.3800e-0253.2 0.00e+00 0.0 0.0e+00 0.0e+00 1.0e+00 0 0 0 0 2 0 0 0 0 2 0 -VecTDot 14 1.0 9.8285e-02 1.3 2.85e+05 1.1 0.0e+00 0.0e+00 1.4e+01 1 8 0 0 21 1 8 0 0 24 23 -VecNorm 9 1.0 1.3891e-01 2.3 1.83e+05 1.1 0.0e+00 0.0e+00 9.0e+00 1 5 0 0 14 1 5 0 0 15 10 -VecCopy 2 1.0 9.4661e-05 1.3 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecSet 11 1.0 1.1318e-04 1.2 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -VecAXPY 14 1.0 7.1832e-04 1.3 2.85e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 8 0 0 0 0 8 0 0 0 3099 -VecAYPX 6 1.0 2.8950e-04 1.2 1.22e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 3 0 0 0 0 3 0 0 0 3296 -VecScatterBegin 10 1.0 6.9800e-04 1.3 0.00e+00 0.0 3.4e+02 3.4e+03 0.0e+00 0 0 56 31 0 0 0 56 31 0 0 -VecScatterEnd 10 1.0 4.0653e-02 1.9 1.12e+03 1.8 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFSetGraph 3 1.0 2.7000e-05 1.5 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFSetUp 3 1.0 5.5216e-04 1.2 0.00e+00 0.0 2.0e+02 6.1e+02 3.0e+00 0 0 33 3 5 0 0 33 3 5 0 -SFBcastOpBegin 9 1.0 5.7720e-04 1.3 0.00e+00 0.0 3.1e+02 3.6e+03 0.0e+00 0 0 50 29 0 0 0 50 29 0 0 -SFBcastOpEnd 9 1.0 4.0546e-02 2.6 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFReduceBegin 1 1.0 4.7980e-05 1.9 0.00e+00 0.0 3.4e+01 1.5e+03 0.0e+00 0 0 6 1 0 0 0 6 1 0 0 -SFReduceEnd 1 1.0 6.1726e-03137.2 1.12e+03 1.8 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 1 -SFPack 10 1.0 1.9700e-04 1.7 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -SFUnpack 10 1.0 4.7680e-05 1.5 1.12e+03 1.8 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 136 -KSPSetUp 1 1.0 1.1706e-04 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 -KSPSolve 1 1.0 3.9404e+00 1.0 2.84e+06 1.0 2.4e+02 4.2e+03 2.6e+01 55 79 39 27 39 55 79 39 27 44 6 -PCSetUp 1 1.0 6.9669e-01 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 10 0 0 0 6 10 0 0 0 7 0 -PCApply 8 1.0 3.0612e+00 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 43 0 0 0 0 43 0 0 0 0 0 +BuildTwoSided 4 1.0 3.2846e-01 2.2 0.00e+00 0.0 1.4e+02 4.0e+00 4.0e+00 0 0 21 0 6 0 0 21 0 6 0 +BuildTwoSidedF 1 1.0 2.0137e-0111.4 0.00e+00 0.0 7.2e+01 1.5e+04 1.0e+00 0 0 11 28 1 0 0 11 28 2 0 +MatMult 8 1.0 1.6926e-01 1.5 2.27e+06 1.1 2.9e+02 3.8e+03 0.0e+00 0 57 42 29 0 0 57 42 29 0 105 +MatConvert 1 1.0 4.6779e-01 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 1 0 0 0 6 1 0 0 0 6 0 +MatAssemblyBegin 2 1.0 2.2662e-01 4.2 0.00e+00 0.0 7.2e+01 1.5e+04 1.0e+00 0 0 11 28 1 0 0 11 28 2 0 +MatAssemblyEnd 2 1.0 4.5675e-01 1.1 7.75e+03 1.8 7.2e+01 9.5e+02 9.0e+00 1 0 11 2 13 1 0 11 2 15 0 +MatGetRowIJ 2 1.0 5.0600e-06 1.4 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatZeroEntries 1 1.0 1.3048e-04 1.7 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +MatView 1 1.0 3.2009e-02 2.7 0.00e+00 0.0 0.0e+00 0.0e+00 1.0e+00 0 0 0 0 1 0 0 0 0 2 0 +VecTDot 16 1.0 3.4876e-01 1.5 3.28e+05 1.1 0.0e+00 0.0e+00 1.6e+01 0 8 0 0 23 0 8 0 0 26 7 +VecNorm 10 1.0 2.9700e-01 2.5 2.05e+05 1.1 0.0e+00 0.0e+00 1.0e+01 0 5 0 0 14 0 5 0 0 16 5 +VecCopy 2 1.0 6.7820e-05 1.7 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecSet 12 1.0 8.7300e-05 1.1 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +VecAXPY 16 1.0 8.8398e-04 1.4 3.28e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 8 0 0 0 0 8 0 0 0 2878 +VecAYPX 7 1.0 4.2066e-04 1.6 1.43e+05 1.1 0.0e+00 0.0e+00 0.0e+00 0 4 0 0 0 0 4 0 0 0 2646 +VecScatterBegin 11 1.0 1.0953e-03 1.8 0.00e+00 0.0 4.0e+02 3.1e+03 0.0e+00 0 0 58 33 0 0 0 58 33 0 0 +VecScatterEnd 11 1.0 2.5244e-01 1.7 1.15e+03 1.8 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFSetGraph 3 1.0 3.0100e-05 1.5 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFSetUp 3 1.0 2.1548e-01 1.2 0.00e+00 0.0 2.2e+02 5.5e+02 3.0e+00 0 0 32 3 4 0 0 32 3 5 0 +SFBcastOpBegin 10 1.0 9.2992e-04 1.8 0.00e+00 0.0 3.6e+02 3.3e+03 0.0e+00 0 0 53 31 0 0 0 53 31 0 0 +SFBcastOpEnd 10 1.0 2.4002e-01 1.8 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFReduceBegin 1 1.0 6.7320e-05 2.3 0.00e+00 0.0 3.6e+01 1.4e+03 0.0e+00 0 0 5 1 0 0 0 5 1 0 0 +SFReduceEnd 1 1.0 3.4085e-02 2.8 1.15e+03 1.8 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFPack 11 1.0 2.1014e-04 1.8 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +SFUnpack 11 1.0 6.2620e-05 1.2 1.15e+03 1.8 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 100 +KSPSetUp 1 1.0 1.1250e-04 1.4 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 0 0 0 0 0 0 0 0 0 0 0 +KSPSolve 1 1.0 3.3864e+01 1.0 3.25e+06 1.1 2.9e+02 3.8e+03 2.9e+01 46 81 42 29 42 46 81 42 29 47 1 +PCSetUp 1 1.0 2.0112e+01 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 4.0e+00 27 0 0 0 6 27 0 0 0 6 0 +PCApply 9 1.0 1.3217e+01 1.0 0.00e+00 0.0 0.0e+00 0.0e+00 0.0e+00 18 0 0 0 0 18 0 0 0 0 0 ------------------------------------------------------------------------------------------------------------------------ Memory usage is given in bytes: @@ -2832,19 +2903,19 @@ --- Event Stage 0: Main Stage - Matrix 4 4 2117912 0. - Index Set 6 6 17856 0. - IS L to G Mapping 4 4 176696 0. + Matrix 4 4 2115620 0. + Index Set 6 6 18764 0. + IS L to G Mapping 4 4 176904 0. Vec Scatter 3 3 2448 0. - Vector 14 14 376352 0. + Vector 14 14 377080 0. Star Forest Graph 3 3 3456 0. Krylov Solver 1 1 1488 0. Preconditioner 1 1 1456 0. Viewer 2 1 848 0. ======================================================================================================================== -Average time to get PetscTime(): 8.2e-08 -Average time for MPI_Barrier(): 5.028e-06 -Average time for zero size MPI_Send(): 5.135e-06 +Average time to get PetscTime(): 8.4e-08 +Average time for MPI_Barrier(): 0.0415532 +Average time for zero size MPI_Send(): 0.00744254 #PETSc Option Table entries: --ndofs 80000 --problem_type poisson @@ -2937,9 +3008,9 @@ dh_gencontrol -O--buildsystem=cmake -O--sourcedirectory=src dh_md5sums -O--buildsystem=cmake -O--sourcedirectory=src dh_builddeb -O--buildsystem=cmake -O--sourcedirectory=src +dpkg-deb: building package 'fenicsx-performance-tests-source' in '../fenicsx-performance-tests-source_0.0~git20210119.80e82ac-1_all.deb'. dpkg-deb: building package 'fenicsx-performance-tests' in '../fenicsx-performance-tests_0.0~git20210119.80e82ac-1_arm64.deb'. dpkg-deb: building package 'fenicsx-performance-tests-dbgsym' in '../fenicsx-performance-tests-dbgsym_0.0~git20210119.80e82ac-1_arm64.deb'. -dpkg-deb: building package 'fenicsx-performance-tests-source' in '../fenicsx-performance-tests-source_0.0~git20210119.80e82ac-1_all.deb'. dpkg-genbuildinfo --build=binary dpkg-genchanges --build=binary >../fenicsx-performance-tests_0.0~git20210119.80e82ac-1_arm64.changes dpkg-genchanges: info: binary-only upload (no source code included) @@ -2947,12 +3018,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: including full source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/22285/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/22285/tmp/hooks/B01_cleanup finished I: unmounting dev/ptmx filesystem I: unmounting dev/pts filesystem I: unmounting dev/shm filesystem I: unmounting proc filesystem I: unmounting sys filesystem I: cleaning the build env -I: removing directory /srv/workspace/pbuilder/28942 and its subdirectories -I: Current time: Sat Jul 24 07:07:03 -12 2021 -I: pbuilder-time-stamp: 1627153623 +I: removing directory /srv/workspace/pbuilder/22285 and its subdirectories +I: Current time: Sat Aug 27 15:43:15 +14 2022 +I: pbuilder-time-stamp: 1661564595