app-admin:github-backup-utils-2.15.1:20190116-233943.log

app-admin:github-backup-utils-2.15.1:20190116-233943.log (text/plain), 96.06 KB, created by Toralf Förster on 2019-01-17 18:22:46 UTC

 * Package:    app-admin/github-backup-utils-2.15.1
 * Repository: gentoo
 * Maintainer: [e-mail] [e-mail]
 * USE:        abi_x86_64 amd64 elibc_glibc kernel_linux test userland_GNU
 * FEATURES:   network-sandbox preserve-libs sandbox test userpriv usersandbox
>>> Unpacking source...
>>> Unpacking github-backup-utils-2.15.1.tar.gz to /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work
>>> Source unpacked in /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work
>>> Preparing source in /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1 ...
>>> Source prepared.
>>> Configuring source in /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1 ...
>>> Source configured.
>>> Compiling source in /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1 ...
>>> Source compiled.
>>> Test phase: app-admin/github-backup-utils-2.15.1
make -j1 test 
This is github/backup-utils
rsync  version 3.1.3  protocol version 31

==> Running testsuite with GHE_TEST_REMOTE_VERSION=2.13.0
test: shellcheck: reports no errors or warnings ...                     OK (0s)
test: ghe-ssh-config returns config for multiple nodes ...              OK (0s)
test: shellopts: set -e set on all scripts ...                          OK (0s)
test: ghe-ssh simple command works ...                                  OK (0s)
test: ghe-ssh-config multiplexing disabled ...                          OK (0s)
test: ghe-ssh complex command works ...                                 OK (1s)
test: ghe-ssh-config with extra SSH opts ...                            OK (1s)
test: ghe-ssh when complex command given to simple form ...             OK (0s)
test: ghe-restore-snapshot-path reports an error when current symlink doesn't exist ... OK (0s)
test: ghe-restore-snapshot-path reports an error when specified snapshot doesn't exist ... OK (0s)
test: ghe-prune-snapshots using default GHE_NUM_SNAPSHOTS ...           OK (1s)
test: ghe-prune-snapshots non-numeric GHE_NUM_SNAPSHOTS ...             OK (0s)
test: ghe-detect-leaked-ssh-keys check -h displays help message ...     OK (0s)
test: ghe-prune-snapshots with no expired snapshots ...                 OK (0s)
test: ghe-detect-leaked-ssh-keys clean snapshot test, no messages ...   OK (0s)
test: ghe-prune-snapshots with expired snapshots ...                    OK (0s)
test: ghe-detect-leaked-ssh-keys leaked keys in current backup ...      OK (0s)
test: ghe-prune-snapshots incomplete snapshot pruning ...               OK (1s)
test: ghe-detect-leaked-ssh-keys leaked keys in old snapshot ...        OK (1s)
test: ghe-cluster-nodes should return both uuids for git-server ...     OK (1s)
test: ghe-host-check ...                                                OK (2s)
test: ghe-cluster-nodes should return one uuid for a single node ...    OK (0s)
test: ghe-backup-config GHE_DATA_DIR defined ...                        OK (0s)
test: ghe-backup-config GHE_CREATE_DATA_DIR disabled ...                OK (0s)
test: ghe-backup-config run on GHE appliance ...                        OK (0s)
test: ghe-backup-config ssh_host_part ...                               OK (0s)
test: ghe-backup-config ssh_port_part ...                               OK (0s)
test: ghe-backup-config ghe_parse_remote_version v2.x series ...        OK (0s)
test: ghe-backup-config verbose log redirects to file ...               OK (0s)
Docker is not installed or running on this host
test: ghe-host-check with host arg ...                                  OK (2s)
test: ghe-host-check honours --version flag ...                         OK (0s)
test: ghe-host-check honours --help and -h flags ...                    OK (0s)
test: ghe-host-check detects unsupported GitHub Enterprise versions ... OK (5s)
test: ghe-host-check detects high availability replica ...              OK (2s)
test: ghe-host-check blocks restore to old release ...                  OK (0s)
test: ghe-restore into configured vm ...                                OK (15s)
test: ghe-backup first snapshot ...                                     OK (14s)
test: ghe-restore logs the benchmark ...                                OK (11s)
test: ghe-restore aborts without user verification ...                  OK (1s)
test: ghe-backup subsequent snapshot ...                                OK (14s)
test: ghe-restore accepts user verification ...                         OK (12s)
test: ghe-backup logs the benchmark ...                                 OK (13s)
test: ghe-restore -c into unconfigured vm ...                           OK (10s)
test: ghe-backup with relative data dir path ...                        OK (14s)
test: ghe-backup fails fast when old style run in progress ...          OK (1s)
test: ghe-restore into unconfigured vm ...                              OK (12s)
test: ghe-backup cleans up stale in-progress file ...                   OK (13s)
test: ghe-restore with host arg ...                                     OK (12s)
test: ghe-restore no host arg or configured restore host ...            OK (0s)
test: ghe-restore with no pages backup ...                              OK (11s)
test: ghe-backup without management console password ...                OK (13s)
test: ghe-restore cluster backup to non-cluster appliance ...           OK (1s)
test: ghe-restore no leaked ssh host keys detected ...                  OK (1s)
test: ghe-restore with current backup leaked key detection ... ...              FAILED (1s)
sed: couldn't write 83 items to stdout: Broken pipe
    ++ date +%s
    + before_time=1547682074
    + set -e
    + cat
    + tar -cf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/data/current/ssh-host-keys.tar --directory=/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/data ssh_host_dsa_key.pub
    + export FINGERPRINT_BLACKLIST=98:d8:99:d3:be:c0:55:05:db:b0:53:2f:1f:ad:b3:60
    + FINGERPRINT_BLACKLIST=98:d8:99:d3:be:c0:55:05:db:b0:53:2f:1f:ad:b3:60
    ++ ghe-restore -v -f localhost
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-60ea0191"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes localhost -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/configured'\'' ]'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-60ea0191"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes localhost -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/cluster'\'' ]'
    Error: Snapshot from a GitHub Enterprise cluster cannot be restored to a standalone appliance. Aborting.
    + output='Checking for leaked keys in the backup snapshot that is being restored ...
    * Leaked key found in current backup snapshot.
    * Snapshot file: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/data/1/ssh-host-keys.tar
    * Key file: ssh_host_dsa_key.pub
    * Key: 98:d8:99:d3:be:c0:55:05:db:b0:53:2f:1f:ad:b3:60
    
    * The current backup contains leaked SSH host keys.
    * Current backup directory: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/data/1
    * We strongly recommend rolling your SSH host keys and making a new backup.
    * Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance.
    * (An upgrade may be required)
    
    * One or more older backup snapshots contain leaked SSH host keys.
    * No immediate action is needed but when you use one of these older snapshots for a restore, 
    * please make sure to roll the SSH host keys after restore.
    * Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance.
    * (An upgrade may be required)
    
    Connect localhost:22 OK (v2.13.0)'
    + true
    + echo 'fake ghe-export-ssh-host-keys data'
    + grep -q 'Leaked key found in current backup snapshot'
    + echo Checking for leaked keys in the backup snapshot that is being restored ... 0 1 info Leaked key found in current backup snapshot. 0 1 info Snapshot file: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/data/1/ssh-host-keys.tar 0 1 info Key file: ssh_host_dsa_key.pub 0 1 info Key: 98:d8:99:d3:be:c0:55:05:db:b0:53:2f:1f:ad:b3:60 0 1 info The current backup contains leaked SSH host keys. 0 1 info Current backup directory: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/data/1 0 1 info We strongly recommend rolling your SSH host keys and making a new backup. 0 1 info Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance. 0 1 info '(An' upgrade may be 'required)' 0 1 info One or more older backup snapshots contain leaked SSH host keys. 0 1 info No immediate action is needed but when you use one of these older snapshots for a restore, 0 1 info please make sure to roll the SSH host keys after restore. 0 1 info Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance. 0 1 info '(An' upgrade may be 'required)' Connect localhost:22 OK '(v2.13.0)'
    + grep -q 'The snapshot that is being restored contains a leaked SSH host key.'
    + echo Checking for leaked keys in the backup snapshot that is being restored ... 0 1 info Leaked key found in current backup snapshot. 0 1 info Snapshot file: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/data/1/ssh-host-keys.tar 0 1 info Key file: ssh_host_dsa_key.pub 0 1 info Key: 98:d8:99:d3:be:c0:55:05:db:b0:53:2f:1f:ad:b3:60 0 1 info The current backup contains leaked SSH host keys. 0 1 info Current backup directory: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/data/1 0 1 info We strongly recommend rolling your SSH host keys and making a new backup. 0 1 info Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance. 0 1 info '(An' upgrade may be 'required)' 0 1 info One or more older backup snapshots contain leaked SSH host keys. 0 1 info No immediate action is needed but when you use one of these older snapshots for a restore, 0 1 info please make sure to roll the SSH host keys after restore. 0 1 info Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance. 0 1 info '(An' upgrade may be 'required)' Connect localhost:22 OK '(v2.13.0)'
    test failed. last command exited with 1
    ++ date +%s
    + after_time=1547682075
    + elapsed_time=1
test: ghe-restore fails when restore to an active HA pair ...           OK (1s)
test: ghe-restore honours --version flag ...                            OK (0s)
test: ghe-restore honours --help and -h flags ...                       OK (0s)
test: ghe-restore exits early on unsupported version ...                OK (1s)
test: ghe-restore cluster ... ...                                               FAILED (7s)
    ++ date +%s
    + before_time=1547682077
    + set -e
    + rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote
    + setup_remote_metadata
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/common
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github
    + setup_remote_cluster
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/cluster
    + echo 'fake cluster config'
    + echo cluster
    + setup_maintenance_mode configured
    + configured=configured
    + '[' -n configured ']'
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/configured
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/github/current/public/system
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/github/current/public/system/maintenance.html
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/repositories
    + GHE_RESTORE_HOST=127.0.0.1
    + export GHE_RESTORE_HOST
    + '[' -x /usr/bin/parallel.moreutils ']'
    + ghe-restore -v -f
    + cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/restore-out
    Checking for leaked keys in the backup snapshot that is being restored ...
    * No leaked keys found
    Connect 127.0.0.1:22 OK (v2.13.0)
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/configured'\'' ]'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/cluster'\'' ]'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/repl-state'\'' ]'
    Starting restore of 127.0.0.1:22 with backup-utils v2.15.1 from snapshot 1
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- logger -t backup-utils
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    fake-uuid
    fake-uuid1
    fake-uuid2
    
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- test -e /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/github/current/public/system/maintenance.html
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo dd of=/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/common/backup-utils-version >/dev/null 2>&1'
    Stopping cron and github-timerd ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'ghe-cluster-each -- sudo service cron stop'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'ghe-cluster-each -- sudo service github-timerd stop'
    Restoring MySQL database ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo mkdir -p '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/tmp'\'''
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo dd of=/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/tmp/mysql.sql.gz >/dev/null 2>&1'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    ghe-import-mysql 'fake ghe-export-mysql data' OK
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/tmp/mysql.sql.gz'
    Restoring Redis database ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- ghe-import-redis
    ghe-import-redis 'fake ghe-export-redis data' OK
    Restoring Git repositories ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- mktemp -d -t backup-utils-restore-XXXXXX
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- test -f /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/cluster
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- ghe-cluster-each -r git -u
    * Adding network_path 1/nw/23/bb/4c/2345 to the list of networks to send
    * Adding network_path 0/nw/01/aa/3f/1234 to the list of networks to send
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- sponge /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-JTvvwq/remote_tmp_list
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-JTvvwq/remote_routes_list
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-JTvvwq/remote_routes_list
    * Transferring repository networks to git-server-fake-uuid ...
    sending incremental file list
    0/
    0/nw/
    0/nw/01/
    0/nw/01/aa/
    0/nw/01/aa/3f/
    0/nw/01/aa/3f/1234/
    0/nw/01/aa/3f/1234/1234.git/
    0/nw/01/aa/3f/1234/1234.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1234.git/HEAD
    0/nw/01/aa/3f/1234/1234.git/config
    0/nw/01/aa/3f/1234/1234.git/description
    0/nw/01/aa/3f/1234/1234.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/hooks
    0/nw/01/aa/3f/1234/1234.git/index
    0/nw/01/aa/3f/1234/1234.git/info/
    0/nw/01/aa/3f/1234/1234.git/info/exclude
    0/nw/01/aa/3f/1234/1234.git/logs/
    0/nw/01/aa/3f/1234/1234.git/logs/HEAD
    0/nw/01/aa/3f/1234/1234.git/logs/refs/
    0/nw/01/aa/3f/1234/1234.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1234.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1234.git/objects/
    0/nw/01/aa/3f/1234/1234.git/objects/13/
    0/nw/01/aa/3f/1234/1234.git/objects/13/ea7f6d5f49cac7316baa0a79671d3cd021348b
    0/nw/01/aa/3f/1234/1234.git/objects/4b/
    0/nw/01/aa/3f/1234/1234.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1234.git/objects/info/
    0/nw/01/aa/3f/1234/1234.git/objects/pack/
    0/nw/01/aa/3f/1234/1234.git/refs/
    0/nw/01/aa/3f/1234/1234.git/refs/heads/
    0/nw/01/aa/3f/1234/1234.git/refs/heads/master
    0/nw/01/aa/3f/1234/1234.git/refs/tags/
    0/nw/01/aa/3f/1234/1234.wiki.git/
    0/nw/01/aa/3f/1234/1234.wiki.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1234.wiki.git/HEAD
    0/nw/01/aa/3f/1234/1234.wiki.git/config
    0/nw/01/aa/3f/1234/1234.wiki.git/description
    0/nw/01/aa/3f/1234/1234.wiki.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/hooks
    0/nw/01/aa/3f/1234/1234.wiki.git/index
    0/nw/01/aa/3f/1234/1234.wiki.git/info/
    0/nw/01/aa/3f/1234/1234.wiki.git/info/exclude
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/HEAD
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/13/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/13/ea7f6d5f49cac7316baa0a79671d3cd021348b
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/4b/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/info/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/pack/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/heads/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/heads/master
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/tags/
    0/nw/01/aa/3f/1234/1235.git/
    0/nw/01/aa/3f/1234/1235.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1235.git/HEAD
    0/nw/01/aa/3f/1234/1235.git/config
    0/nw/01/aa/3f/1234/1235.git/description
    0/nw/01/aa/3f/1234/1235.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/hooks
    0/nw/01/aa/3f/1234/1235.git/index
    0/nw/01/aa/3f/1234/1235.git/svn.history.msgpack
    0/nw/01/aa/3f/1234/1235.git/info/
    0/nw/01/aa/3f/1234/1235.git/info/exclude
    0/nw/01/aa/3f/1234/1235.git/logs/
    0/nw/01/aa/3f/1234/1235.git/logs/HEAD
    0/nw/01/aa/3f/1234/1235.git/logs/refs/
    0/nw/01/aa/3f/1234/1235.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1235.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1235.git/objects/
    0/nw/01/aa/3f/1234/1235.git/objects/13/
    0/nw/01/aa/3f/1234/1235.git/objects/13/ea7f6d5f49cac7316baa0a79671d3cd021348b
    0/nw/01/aa/3f/1234/1235.git/objects/4b/
    0/nw/01/aa/3f/1234/1235.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1235.git/objects/info/
    0/nw/01/aa/3f/1234/1235.git/objects/pack/
    0/nw/01/aa/3f/1234/1235.git/refs/
    0/nw/01/aa/3f/1234/1235.git/refs/heads/
    0/nw/01/aa/3f/1234/1235.git/refs/heads/master
    0/nw/01/aa/3f/1234/1235.git/refs/tags/
    0/nw/01/aa/3f/1234/1235.git/svn_data/
    0/nw/01/aa/3f/1234/1235.git/svn_data/property_history.msgpack
    
    sent 7,106 bytes  received 874 bytes  15,960.00 bytes/sec
    total size is 3,172  speedup is 0.40
    * Transferring repository networks to git-server-fake-uuid1 ...
    sending incremental file list
    1/
    1/nw/
    1/nw/23/
    1/nw/23/bb/
    1/nw/23/bb/4c/
    1/nw/23/bb/4c/2345/
    1/nw/23/bb/4c/2345/broken.git/
    1/nw/23/bb/4c/2345/broken.git/COMMIT_EDITMSG
    1/nw/23/bb/4c/2345/broken.git/HEAD
    1/nw/23/bb/4c/2345/broken.git/config
    1/nw/23/bb/4c/2345/broken.git/description
    1/nw/23/bb/4c/2345/broken.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/hooks
    1/nw/23/bb/4c/2345/broken.git/index
    1/nw/23/bb/4c/2345/broken.git/info/
    1/nw/23/bb/4c/2345/broken.git/info/exclude
    1/nw/23/bb/4c/2345/broken.git/logs/
    1/nw/23/bb/4c/2345/broken.git/logs/HEAD
    1/nw/23/bb/4c/2345/broken.git/logs/refs/
    1/nw/23/bb/4c/2345/broken.git/logs/refs/heads/
    1/nw/23/bb/4c/2345/broken.git/logs/refs/heads/master
    1/nw/23/bb/4c/2345/broken.git/objects/
    1/nw/23/bb/4c/2345/broken.git/objects/13/
    1/nw/23/bb/4c/2345/broken.git/objects/13/ea7f6d5f49cac7316baa0a79671d3cd021348b
    1/nw/23/bb/4c/2345/broken.git/objects/4b/
    1/nw/23/bb/4c/2345/broken.git/objects/info/
    1/nw/23/bb/4c/2345/broken.git/objects/pack/
    1/nw/23/bb/4c/2345/broken.git/refs/
    1/nw/23/bb/4c/2345/broken.git/refs/heads/
    1/nw/23/bb/4c/2345/broken.git/refs/heads/master
    1/nw/23/bb/4c/2345/broken.git/refs/tags/
    
    sent 4,876 bytes  received 331 bytes  10,414.00 bytes/sec
    total size is 4,198  speedup is 0.81
    * Transferring repository networks to git-server-fake-uuid2 ...
    sending incremental file list
    
    sent 896 bytes  received 31 bytes  1,854.00 bytes/sec
    total size is 1,026  speedup is 1.11
    Finalizing routes
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- sponge /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-JTvvwq/remote_to_restore
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    /bin/bash: line 3: parallel: command not found
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-JTvvwq
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    fake-uuid
    fake-uuid1
    fake-uuid2
    
    + : ghe-restore should have exited successfully
    + false
    test failed. last command exited with 1
    ++ date +%s
    + after_time=1547682084
    + elapsed_time=7
sed: couldn't write 267 items to stdout: Broken pipe
test: ghe-backup empty hookshot directory ...                           OK (13s)
test: ghe-restore missing directories or files from source snapshot displays warning ... ... FAILED (7s)
sed: couldn't write 298 items to stdout: Broken pipe
    ++ date +%s
    + before_time=1547682084
    + set -e
    + rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote
    + setup_remote_metadata
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/common
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github
    + setup_remote_cluster
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/cluster
    + echo 'fake cluster config'
    + echo cluster
    + setup_maintenance_mode configured
    + configured=configured
    + '[' -n configured ']'
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/configured
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/github/current/public/system
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/github/current/public/system/maintenance.html
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/repositories
    + GHE_RESTORE_HOST=127.0.0.1
    + export GHE_RESTORE_HOST
    + '[' -x /usr/bin/parallel.moreutils ']'
    + export GHE_DGIT_CLUSTER_RESTORE_FINALIZE_WARNING=1
    + GHE_DGIT_CLUSTER_RESTORE_FINALIZE_WARNING=1
    + export GHE_GIST_CLUSTER_RESTORE_FINALIZE_WARNING=1
    + GHE_GIST_CLUSTER_RESTORE_FINALIZE_WARNING=1
    + ghe-restore -v -f
    + cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/restore-out
    Checking for leaked keys in the backup snapshot that is being restored ...
    * No leaked keys found
    Connect 127.0.0.1:22 OK (v2.13.0)
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/configured'\'' ]'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/cluster'\'' ]'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/repl-state'\'' ]'
    Starting restore of 127.0.0.1:22 with backup-utils v2.15.1 from snapshot 1
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- logger -t backup-utils
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    fake-uuid
    fake-uuid1
    fake-uuid2
    
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- test -e /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/github/current/public/system/maintenance.html
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo dd of=/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/common/backup-utils-version >/dev/null 2>&1'
    Stopping cron and github-timerd ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'ghe-cluster-each -- sudo service cron stop'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'ghe-cluster-each -- sudo service github-timerd stop'
    Restoring MySQL database ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo mkdir -p '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/tmp'\'''
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo dd of=/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/tmp/mysql.sql.gz >/dev/null 2>&1'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    ghe-import-mysql 'fake ghe-export-mysql data' OK
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/data/user/tmp/mysql.sql.gz'
    Restoring Redis database ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- ghe-import-redis
    ghe-import-redis 'fake ghe-export-redis data' OK
    Restoring Git repositories ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- mktemp -d -t backup-utils-restore-XXXXXX
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- test -f /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/remote/etc/github/cluster
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- ghe-cluster-each -r git -u
    * Adding network_path 1/nw/23/bb/4c/2345 to the list of networks to send
    * Adding network_path 0/nw/01/aa/3f/1234 to the list of networks to send
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- sponge /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-s9UaHh/remote_tmp_list
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-s9UaHh/remote_routes_list
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-s9UaHh/remote_routes_list
    * Transferring repository networks to git-server-fake-uuid ...
    sending incremental file list
    0/
    0/nw/
    0/nw/01/
    0/nw/01/aa/
    0/nw/01/aa/3f/
    0/nw/01/aa/3f/1234/
    0/nw/01/aa/3f/1234/1234.git/
    0/nw/01/aa/3f/1234/1234.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1234.git/HEAD
    0/nw/01/aa/3f/1234/1234.git/config
    0/nw/01/aa/3f/1234/1234.git/description
    0/nw/01/aa/3f/1234/1234.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/hooks
    0/nw/01/aa/3f/1234/1234.git/index
    0/nw/01/aa/3f/1234/1234.git/info/
    0/nw/01/aa/3f/1234/1234.git/info/exclude
    0/nw/01/aa/3f/1234/1234.git/logs/
    0/nw/01/aa/3f/1234/1234.git/logs/HEAD
    0/nw/01/aa/3f/1234/1234.git/logs/refs/
    0/nw/01/aa/3f/1234/1234.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1234.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1234.git/objects/
    0/nw/01/aa/3f/1234/1234.git/objects/13/
    0/nw/01/aa/3f/1234/1234.git/objects/13/ea7f6d5f49cac7316baa0a79671d3cd021348b
    0/nw/01/aa/3f/1234/1234.git/objects/4b/
    0/nw/01/aa/3f/1234/1234.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1234.git/objects/info/
    0/nw/01/aa/3f/1234/1234.git/objects/pack/
    0/nw/01/aa/3f/1234/1234.git/refs/
    0/nw/01/aa/3f/1234/1234.git/refs/heads/
    0/nw/01/aa/3f/1234/1234.git/refs/heads/master
    0/nw/01/aa/3f/1234/1234.git/refs/tags/
    0/nw/01/aa/3f/1234/1234.wiki.git/
    0/nw/01/aa/3f/1234/1234.wiki.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1234.wiki.git/HEAD
    0/nw/01/aa/3f/1234/1234.wiki.git/config
    0/nw/01/aa/3f/1234/1234.wiki.git/description
    0/nw/01/aa/3f/1234/1234.wiki.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/hooks
    0/nw/01/aa/3f/1234/1234.wiki.git/index
    0/nw/01/aa/3f/1234/1234.wiki.git/info/
    0/nw/01/aa/3f/1234/1234.wiki.git/info/exclude
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/HEAD
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/13/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/13/ea7f6d5f49cac7316baa0a79671d3cd021348b
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/4b/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/info/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/pack/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/heads/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/heads/master
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/tags/
    0/nw/01/aa/3f/1234/1235.git/
    0/nw/01/aa/3f/1234/1235.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1235.git/HEAD
    0/nw/01/aa/3f/1234/1235.git/config
    0/nw/01/aa/3f/1234/1235.git/description
    0/nw/01/aa/3f/1234/1235.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/hooks
    0/nw/01/aa/3f/1234/1235.git/index
    0/nw/01/aa/3f/1234/1235.git/svn.history.msgpack
    0/nw/01/aa/3f/1234/1235.git/info/
    0/nw/01/aa/3f/1234/1235.git/info/exclude
    0/nw/01/aa/3f/1234/1235.git/logs/
    0/nw/01/aa/3f/1234/1235.git/logs/HEAD
    0/nw/01/aa/3f/1234/1235.git/logs/refs/
    0/nw/01/aa/3f/1234/1235.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1235.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1235.git/objects/
    0/nw/01/aa/3f/1234/1235.git/objects/13/
    0/nw/01/aa/3f/1234/1235.git/objects/13/ea7f6d5f49cac7316baa0a79671d3cd021348b
    0/nw/01/aa/3f/1234/1235.git/objects/4b/
    0/nw/01/aa/3f/1234/1235.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1235.git/objects/info/
    0/nw/01/aa/3f/1234/1235.git/objects/pack/
    0/nw/01/aa/3f/1234/1235.git/refs/
    0/nw/01/aa/3f/1234/1235.git/refs/heads/
    0/nw/01/aa/3f/1234/1235.git/refs/heads/master
    0/nw/01/aa/3f/1234/1235.git/refs/tags/
    0/nw/01/aa/3f/1234/1235.git/svn_data/
    0/nw/01/aa/3f/1234/1235.git/svn_data/property_history.msgpack
    
    sent 7,106 bytes  received 874 bytes  15,960.00 bytes/sec
    total size is 3,172  speedup is 0.40
    * Transferring repository networks to git-server-fake-uuid1 ...
    sending incremental file list
    1/
    1/nw/
    1/nw/23/
    1/nw/23/bb/
    1/nw/23/bb/4c/
    1/nw/23/bb/4c/2345/
    1/nw/23/bb/4c/2345/broken.git/
    1/nw/23/bb/4c/2345/broken.git/COMMIT_EDITMSG
    1/nw/23/bb/4c/2345/broken.git/HEAD
    1/nw/23/bb/4c/2345/broken.git/config
    1/nw/23/bb/4c/2345/broken.git/description
    1/nw/23/bb/4c/2345/broken.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-47/hooks
    1/nw/23/bb/4c/2345/broken.git/index
    1/nw/23/bb/4c/2345/broken.git/info/
    1/nw/23/bb/4c/2345/broken.git/info/exclude
    1/nw/23/bb/4c/2345/broken.git/logs/
    1/nw/23/bb/4c/2345/broken.git/logs/HEAD
    1/nw/23/bb/4c/2345/broken.git/logs/refs/
    1/nw/23/bb/4c/2345/broken.git/logs/refs/heads/
    1/nw/23/bb/4c/2345/broken.git/logs/refs/heads/master
    1/nw/23/bb/4c/2345/broken.git/objects/
    1/nw/23/bb/4c/2345/broken.git/objects/13/
    1/nw/23/bb/4c/2345/broken.git/objects/13/ea7f6d5f49cac7316baa0a79671d3cd021348b
    1/nw/23/bb/4c/2345/broken.git/objects/4b/
    1/nw/23/bb/4c/2345/broken.git/objects/info/
    1/nw/23/bb/4c/2345/broken.git/objects/pack/
    1/nw/23/bb/4c/2345/broken.git/refs/
    1/nw/23/bb/4c/2345/broken.git/refs/heads/
    1/nw/23/bb/4c/2345/broken.git/refs/heads/master
    1/nw/23/bb/4c/2345/broken.git/refs/tags/
    
    sent 4,876 bytes  received 331 bytes  10,414.00 bytes/sec
    total size is 4,198  speedup is 0.81
    * Transferring repository networks to git-server-fake-uuid2 ...
    sending incremental file list
    
    sent 896 bytes  received 31 bytes  1,854.00 bytes/sec
    total size is 1,026  speedup is 1.11
    Finalizing routes
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- sponge /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-s9UaHh/remote_to_restore
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    /bin/bash: line 3: parallel: command not found
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-s9UaHh
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    fake-uuid
    fake-uuid1
    fake-uuid2
    
    + : ghe-restore should have exited successfully
    + false
    test failed. last command exited with 1
    ++ date +%s
    + after_time=1547682091
    + elapsed_time=7
test: ghe-backup empty git-hooks directory ...                          OK (11s)
test: ghe-backup fsck ...                                               OK (36s)
test: ghe-backup stores version when not run from a clone ...           OK (0s)
test: ghe-backup with leaked SSH host key detection for current backup ... OK (9s)
test: ghe-backup with no leaked keys ...                                OK (10s)
test: ghe-backup honours --version flag ...                             OK (0s)
test: ghe-backup honours --help and -h flags ...                        OK (0s)
test: ghe-backup exits early on unsupported version ...                 OK (0s)
test: ghe-backup-strategy returns rsync for HA backup ...               OK (1s)
test: ghe-backup cluster ...                                            OK (11s)
test: ghe-backup not missing directories or files on source appliance ... OK (12s)
test: ghe-backup missing directories or files on source appliance ...   OK (10s)

==> Running testsuite with GHE_TEST_REMOTE_VERSION=2.15.0
test: shellcheck: reports no errors or warnings ...                     OK (0s)
test: shellopts: set -e set on all scripts ...                          OK (0s)
test: ghe-ssh-config returns config for multiple nodes ...              OK (0s)
test: ghe-ssh simple command works ...                                  OK (0s)
test: ghe-ssh-config multiplexing disabled ...                          OK (0s)
test: ghe-ssh complex command works ...                                 OK (0s)
test: ghe-ssh-config with extra SSH opts ...                            OK (1s)
test: ghe-prune-snapshots using default GHE_NUM_SNAPSHOTS ...           OK (1s)
test: ghe-ssh when complex command given to simple form ...             OK (1s)
test: ghe-prune-snapshots non-numeric GHE_NUM_SNAPSHOTS ...             OK (0s)
test: ghe-restore-snapshot-path reports an error when current symlink doesn't exist ... OK (0s)
test: ghe-restore-snapshot-path reports an error when specified snapshot doesn't exist ... OK (0s)
test: ghe-prune-snapshots with no expired snapshots ...                 OK (0s)
test: ghe-detect-leaked-ssh-keys check -h displays help message ...     OK (0s)
test: ghe-detect-leaked-ssh-keys clean snapshot test, no messages ...   OK (0s)
test: ghe-prune-snapshots with expired snapshots ...                    OK (1s)
test: ghe-detect-leaked-ssh-keys leaked keys in current backup ...      OK (1s)
test: ghe-prune-snapshots incomplete snapshot pruning ...               OK (0s)
test: ghe-detect-leaked-ssh-keys leaked keys in old snapshot ...        OK (0s)
test: ghe-cluster-nodes should return both uuids for git-server ...     OK (1s)
test: ghe-host-check ...                                                OK (2s)
test: ghe-cluster-nodes should return one uuid for a single node ...    OK (1s)
test: ghe-backup-config GHE_DATA_DIR defined ...                        OK (0s)
test: ghe-backup-config GHE_CREATE_DATA_DIR disabled ...                OK (0s)
test: ghe-backup-config run on GHE appliance ...                        OK (1s)
test: ghe-backup-config ssh_host_part ...                               OK (0s)
test: ghe-backup-config ssh_port_part ...                               OK (0s)
test: ghe-backup-config ghe_parse_remote_version v2.x series ...        OK (0s)
test: ghe-backup-config verbose log redirects to file ...               OK (0s)
Docker is not installed or running on this host
test: ghe-host-check with host arg ...                                  OK (2s)
test: ghe-host-check honours --version flag ...                         OK (0s)
test: ghe-host-check honours --help and -h flags ...                    OK (0s)
test: ghe-host-check detects unsupported GitHub Enterprise versions ... OK (5s)
test: ghe-host-check detects high availability replica ...              OK (2s)
test: ghe-host-check blocks restore to old release ...                  OK (0s)
test: ghe-restore into configured vm ...                                OK (15s)
test: ghe-backup first snapshot ...                                     OK (16s)
test: ghe-restore logs the benchmark ...                                OK (11s)
test: ghe-restore aborts without user verification ...                  OK (1s)
test: ghe-backup subsequent snapshot ...                                OK (13s)
test: ghe-restore accepts user verification ...                         OK (11s)
test: ghe-backup logs the benchmark ...                                 OK (14s)
test: ghe-restore -c into unconfigured vm ...                           OK (12s)
test: ghe-backup with relative data dir path ...                        OK (14s)
test: ghe-backup fails fast when old style run in progress ...          OK (1s)
test: ghe-restore into unconfigured vm ...                              OK (11s)
test: ghe-restore with host arg ...                                     OK (12s)
test: ghe-backup cleans up stale in-progress file ...                   OK (13s)
test: ghe-restore no host arg or configured restore host ...            OK (0s)
test: ghe-restore with no pages backup ...                              OK (11s)
test: ghe-restore cluster backup to non-cluster appliance ...           OK (1s)
test: ghe-backup without management console password ...                OK (12s)
test: ghe-restore no leaked ssh host keys detected ...                  OK (1s)
test: ghe-restore with current backup leaked key detection ... ...              FAILED (1s)
    ++ date +%s
    + before_time=1547682273
    + set -e
    + cat
    + tar -cf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/data/current/ssh-host-keys.tar --directory=/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/data ssh_host_dsa_key.pub
    + export FINGERPRINT_BLACKLIST=98:d8:99:d3:be:c0:55:05:db:b0:53:2f:1f:ad:b3:60
    + FINGERPRINT_BLACKLIST=98:d8:99:d3:be:c0:55:05:db:b0:53:2f:1f:ad:b3:60
    ++ ghe-restore -v -f localhost
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-60ea0191"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes localhost -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/configured'\'' ]'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-60ea0191"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes localhost -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/cluster'\'' ]'
    Error: Snapshot from a GitHub Enterprise cluster cannot be restored to a standalone appliance. Aborting.
    + output='Checking for leaked keys in the backup snapshot that is being restored ...
    * Leaked key found in current backup snapshot.
    * Snapshot file: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/data/1/ssh-host-keys.tar
    * Key file: ssh_host_dsa_key.pub
    * Key: 98:d8:99:d3:be:c0:55:05:db:b0:53:2f:1f:ad:b3:60
    
    * The current backup contains leaked SSH host keys.
    * Current backup directory: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/data/1
    * We strongly recommend rolling your SSH host keys and making a new backup.
    * Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance.
    * (An upgrade may be required)
    
    * One or more older backup snapshots contain leaked SSH host keys.
    * No immediate action is needed but when you use one of these older snapshots for a restore, 
    * please make sure to roll the SSH host keys after restore.
    * Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance.
    * (An upgrade may be required)
    
    Connect localhost:22 OK (v2.15.0)'
    + true
    + echo 'fake ghe-export-ssh-host-keys data'
    + echo Checking for leaked keys in the backup snapshot that is being restored ... 0 1 info Leaked key found in current backup snapshot. 0 1 info Snapshot file: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/data/1/ssh-host-keys.tar 0 1 info Key file: ssh_host_dsa_key.pub 0 1 info Key: 98:d8:99:d3:be:c0:55:05:db:b0:53:2f:1f:ad:b3:60 0 1 info The current backup contains leaked SSH host keys. 0 1 info Current backup directory: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/data/1 0 1 info We strongly recommend rolling your SSH host keys and making a new backup. 0 1 info Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance. 0 1 info '(An' upgrade may be 'required)' 0 1 info One or more older backup snapshots contain leaked SSH host keys. 0 1 info No immediate action is needed but when you use one of these older snapshots for a restore, 0 1 info please make sure to roll the SSH host keys after restore. 0 1 info Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance. 0 1 info '(An' upgrade may be 'required)' Connect localhost:22 OK '(v2.15.0)'
    + grep -q 'Leaked key found in current backup snapshot'
    + grep -q 'The snapshot that is being restored contains a leaked SSH host key.'
    + echo Checking for leaked keys in the backup snapshot that is being restored ... 0 1 info Leaked key found in current backup snapshot. 0 1 info Snapshot file: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/data/1/ssh-host-keys.tar 0 1 info Key file: ssh_host_dsa_key.pub 0 1 info Key: 98:d8:99:d3:be:c0:55:05:db:b0:53:2f:1f:ad:b3:60 0 1 info The current backup contains leaked SSH host keys. 0 1 info Current backup directory: /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/data/1 0 1 info We strongly recommend rolling your SSH host keys and making a new backup. 0 1 info Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance. 0 1 info '(An' upgrade may be 'required)' 0 1 info One or more older backup snapshots contain leaked SSH host keys. 0 1 info No immediate action is needed but when you use one of these older snapshots for a restore, 0 1 info please make sure to roll the SSH host keys after restore. 0 1 info Roll the keys either manually or with ghe-ssh-roll-host-keys on the appliance. 0 1 info '(An' upgrade may be 'required)' Connect localhost:22 OK '(v2.15.0)'
    test failed. last command exited with 1
    ++ date +%s
    + after_time=1547682274
    + elapsed_time=1
sed: couldn't write 83 items to stdout: Broken pipe
test: ghe-restore fails when restore to an active HA pair ...           OK (1s)
test: ghe-restore honours --version flag ...                            OK (0s)
test: ghe-restore honours --help and -h flags ...                       OK (1s)
test: ghe-restore exits early on unsupported version ...                OK (0s)
test: ghe-restore cluster ... ...                                               FAILED (7s)
    ++ date +%s
    + before_time=1547682277
    + set -e
    + rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote
    + setup_remote_metadata
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/common
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github
    + setup_remote_cluster
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/cluster
    + echo 'fake cluster config'
    + echo cluster
    + setup_maintenance_mode configured
    + configured=configured
    + '[' -n configured ']'
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/configured
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/github/current/public/system
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/github/current/public/system/maintenance.html
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/repositories
    + GHE_RESTORE_HOST=127.0.0.1
    + export GHE_RESTORE_HOST
    + '[' -x /usr/bin/parallel.moreutils ']'
    + ghe-restore -v -f
    + cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/restore-out
    Checking for leaked keys in the backup snapshot that is being restored ...
    * No leaked keys found
    Connect 127.0.0.1:22 OK (v2.15.0)
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/configured'\'' ]'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/cluster'\'' ]'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/repl-state'\'' ]'
    Starting restore of 127.0.0.1:22 with backup-utils v2.15.1 from snapshot 1
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- logger -t backup-utils
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    fake-uuid
    fake-uuid1
    fake-uuid2
    
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- test -e /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/github/current/public/system/maintenance.html
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo dd of=/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/common/backup-utils-version >/dev/null 2>&1'
    Stopping cron and github-timerd ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'ghe-cluster-each -- sudo service cron stop'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'ghe-cluster-each -- sudo service github-timerd stop'
    Restoring MySQL database ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo mkdir -p '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/tmp'\'''
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo dd of=/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/tmp/mysql.sql.gz >/dev/null 2>&1'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    ghe-import-mysql 'fake ghe-export-mysql data' OK
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/tmp/mysql.sql.gz'
    Restoring Redis database ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- ghe-import-redis
    ghe-import-redis 'fake ghe-export-redis data' OK
    Restoring Git repositories ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- mktemp -d -t backup-utils-restore-XXXXXX
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- test -f /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/cluster
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- ghe-cluster-each -r git -u
    * Adding network_path 1/nw/23/bb/4c/2345 to the list of networks to send
    * Adding network_path 0/nw/01/aa/3f/1234 to the list of networks to send
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- sponge /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-PszFPo/remote_tmp_list
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-PszFPo/remote_routes_list
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-PszFPo/remote_routes_list
    * Transferring repository networks to git-server-fake-uuid ...
    sending incremental file list
    0/
    0/nw/
    0/nw/01/
    0/nw/01/aa/
    0/nw/01/aa/3f/
    0/nw/01/aa/3f/1234/
    0/nw/01/aa/3f/1234/1234.git/
    0/nw/01/aa/3f/1234/1234.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1234.git/HEAD
    0/nw/01/aa/3f/1234/1234.git/config
    0/nw/01/aa/3f/1234/1234.git/description
    0/nw/01/aa/3f/1234/1234.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/hooks
    0/nw/01/aa/3f/1234/1234.git/index
    0/nw/01/aa/3f/1234/1234.git/info/
    0/nw/01/aa/3f/1234/1234.git/info/exclude
    0/nw/01/aa/3f/1234/1234.git/logs/
    0/nw/01/aa/3f/1234/1234.git/logs/HEAD
    0/nw/01/aa/3f/1234/1234.git/logs/refs/
    0/nw/01/aa/3f/1234/1234.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1234.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1234.git/objects/
    0/nw/01/aa/3f/1234/1234.git/objects/24/
    0/nw/01/aa/3f/1234/1234.git/objects/24/7baa174e2f22369b0662080be8a8382f0ee111
    0/nw/01/aa/3f/1234/1234.git/objects/4b/
    0/nw/01/aa/3f/1234/1234.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1234.git/objects/info/
    0/nw/01/aa/3f/1234/1234.git/objects/pack/
    0/nw/01/aa/3f/1234/1234.git/refs/
    0/nw/01/aa/3f/1234/1234.git/refs/heads/
    0/nw/01/aa/3f/1234/1234.git/refs/heads/master
    0/nw/01/aa/3f/1234/1234.git/refs/tags/
    0/nw/01/aa/3f/1234/1234.wiki.git/
    0/nw/01/aa/3f/1234/1234.wiki.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1234.wiki.git/HEAD
    0/nw/01/aa/3f/1234/1234.wiki.git/config
    0/nw/01/aa/3f/1234/1234.wiki.git/description
    0/nw/01/aa/3f/1234/1234.wiki.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/hooks
    0/nw/01/aa/3f/1234/1234.wiki.git/index
    0/nw/01/aa/3f/1234/1234.wiki.git/info/
    0/nw/01/aa/3f/1234/1234.wiki.git/info/exclude
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/HEAD
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/24/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/24/7baa174e2f22369b0662080be8a8382f0ee111
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/4b/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/info/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/pack/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/heads/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/heads/master
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/tags/
    0/nw/01/aa/3f/1234/1235.git/
    0/nw/01/aa/3f/1234/1235.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1235.git/HEAD
    0/nw/01/aa/3f/1234/1235.git/config
    0/nw/01/aa/3f/1234/1235.git/description
    0/nw/01/aa/3f/1234/1235.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/hooks
    0/nw/01/aa/3f/1234/1235.git/index
    0/nw/01/aa/3f/1234/1235.git/svn.history.msgpack
    0/nw/01/aa/3f/1234/1235.git/info/
    0/nw/01/aa/3f/1234/1235.git/info/exclude
    0/nw/01/aa/3f/1234/1235.git/logs/
    0/nw/01/aa/3f/1234/1235.git/logs/HEAD
    0/nw/01/aa/3f/1234/1235.git/logs/refs/
    0/nw/01/aa/3f/1234/1235.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1235.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1235.git/objects/
    0/nw/01/aa/3f/1234/1235.git/objects/24/
    0/nw/01/aa/3f/1234/1235.git/objects/24/7baa174e2f22369b0662080be8a8382f0ee111
    0/nw/01/aa/3f/1234/1235.git/objects/4b/
    0/nw/01/aa/3f/1234/1235.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1235.git/objects/info/
    0/nw/01/aa/3f/1234/1235.git/objects/pack/
    0/nw/01/aa/3f/1234/1235.git/refs/
    0/nw/01/aa/3f/1234/1235.git/refs/heads/
    0/nw/01/aa/3f/1234/1235.git/refs/heads/master
    0/nw/01/aa/3f/1234/1235.git/refs/tags/
    0/nw/01/aa/3f/1234/1235.git/svn_data/
    0/nw/01/aa/3f/1234/1235.git/svn_data/property_history.msgpack
    
    sent 7,041 bytes  received 874 bytes  15,830.00 bytes/sec
    total size is 3,181  speedup is 0.40
    * Transferring repository networks to git-server-fake-uuid1 ...
    sending incremental file list
    1/
    1/nw/
    1/nw/23/
    1/nw/23/bb/
    1/nw/23/bb/4c/
    1/nw/23/bb/4c/2345/
    1/nw/23/bb/4c/2345/broken.git/
    1/nw/23/bb/4c/2345/broken.git/COMMIT_EDITMSG
    1/nw/23/bb/4c/2345/broken.git/HEAD
    1/nw/23/bb/4c/2345/broken.git/config
    1/nw/23/bb/4c/2345/broken.git/description
    1/nw/23/bb/4c/2345/broken.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/hooks
    1/nw/23/bb/4c/2345/broken.git/index
    1/nw/23/bb/4c/2345/broken.git/info/
    1/nw/23/bb/4c/2345/broken.git/info/exclude
    1/nw/23/bb/4c/2345/broken.git/logs/
    1/nw/23/bb/4c/2345/broken.git/logs/HEAD
    1/nw/23/bb/4c/2345/broken.git/logs/refs/
    1/nw/23/bb/4c/2345/broken.git/logs/refs/heads/
    1/nw/23/bb/4c/2345/broken.git/logs/refs/heads/master
    1/nw/23/bb/4c/2345/broken.git/objects/
    1/nw/23/bb/4c/2345/broken.git/objects/24/
    1/nw/23/bb/4c/2345/broken.git/objects/24/7baa174e2f22369b0662080be8a8382f0ee111
    1/nw/23/bb/4c/2345/broken.git/objects/4b/
    1/nw/23/bb/4c/2345/broken.git/objects/info/
    1/nw/23/bb/4c/2345/broken.git/objects/pack/
    1/nw/23/bb/4c/2345/broken.git/refs/
    1/nw/23/bb/4c/2345/broken.git/refs/heads/
    1/nw/23/bb/4c/2345/broken.git/refs/heads/master
    1/nw/23/bb/4c/2345/broken.git/refs/tags/
    
    sent 4,809 bytes  received 331 bytes  10,280.00 bytes/sec
    total size is 4,210  speedup is 0.82
sed: couldn't write 267 items to stdout: Broken pipe
    * Transferring repository networks to git-server-fake-uuid2 ...
    sending incremental file list
    
    sent 890 bytes  received 31 bytes  614.00 bytes/sec
    total size is 1,029  speedup is 1.12
    Finalizing routes
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- sponge /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-PszFPo/remote_to_restore
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    /bin/bash: line 3: parallel: command not found
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-PszFPo
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    fake-uuid
    fake-uuid1
    fake-uuid2
    
    + : ghe-restore should have exited successfully
    + false
    test failed. last command exited with 1
    ++ date +%s
    + after_time=1547682284
    + elapsed_time=7
test: ghe-backup empty hookshot directory ...                           OK (14s)
test: ghe-restore missing directories or files from source snapshot displays warning ... ... FAILED (6s)
sed: couldn't write 280 items to stdout: Broken pipe
    ++ date +%s
    + before_time=1547682284
    + set -e
    + rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote
    + setup_remote_metadata
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/common
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github
    + setup_remote_cluster
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/cluster
    + echo 'fake cluster config'
    + echo cluster
    + setup_maintenance_mode configured
    + configured=configured
    + '[' -n configured ']'
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/configured
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/github/current/public/system
    + touch /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/github/current/public/system/maintenance.html
    + mkdir -p /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/repositories
    + GHE_RESTORE_HOST=127.0.0.1
    + export GHE_RESTORE_HOST
    + '[' -x /usr/bin/parallel.moreutils ']'
    + export GHE_DGIT_CLUSTER_RESTORE_FINALIZE_WARNING=1
    + GHE_DGIT_CLUSTER_RESTORE_FINALIZE_WARNING=1
    + export GHE_GIST_CLUSTER_RESTORE_FINALIZE_WARNING=1
    + GHE_GIST_CLUSTER_RESTORE_FINALIZE_WARNING=1
    + ghe-restore -v -f
    + cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/restore-out
    Checking for leaked keys in the backup snapshot that is being restored ...
    * No leaked keys found
    Connect 127.0.0.1:22 OK (v2.15.0)
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/configured'\'' ]'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/cluster'\'' ]'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- '[ -f '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/repl-state'\'' ]'
    Starting restore of 127.0.0.1:22 with backup-utils v2.15.1 from snapshot 1
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- logger -t backup-utils
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    fake-uuid
    fake-uuid1
    fake-uuid2
    
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- test -e /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/github/current/public/system/maintenance.html
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo dd of=/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/common/backup-utils-version >/dev/null 2>&1'
    Stopping cron and github-timerd ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'ghe-cluster-each -- sudo service cron stop'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'ghe-cluster-each -- sudo service github-timerd stop'
    Restoring MySQL database ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo mkdir -p '\''/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/tmp'\'''
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo dd of=/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/tmp/mysql.sql.gz >/dev/null 2>&1'
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    ghe-import-mysql 'fake ghe-export-mysql data' OK
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- 'sudo rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/data/user/tmp/mysql.sql.gz'
    Restoring Redis database ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- ghe-import-redis
    ghe-import-redis 'fake ghe-export-redis data' OK
    Restoring Git repositories ...
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- mktemp -d -t backup-utils-restore-XXXXXX
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- test -f /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/remote/etc/github/cluster
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- ghe-cluster-each -r git -u
    * Adding network_path 1/nw/23/bb/4c/2345 to the list of networks to send
    * Adding network_path 0/nw/01/aa/3f/1234 to the list of networks to send
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- sponge /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-WfnUKS/remote_tmp_list
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-WfnUKS/remote_routes_list
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- cat /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-WfnUKS/remote_routes_list
    * Transferring repository networks to git-server-fake-uuid ...
    sending incremental file list
    0/
    0/nw/
    0/nw/01/
    0/nw/01/aa/
    0/nw/01/aa/3f/
    0/nw/01/aa/3f/1234/
    0/nw/01/aa/3f/1234/1234.git/
    0/nw/01/aa/3f/1234/1234.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1234.git/HEAD
    0/nw/01/aa/3f/1234/1234.git/config
    0/nw/01/aa/3f/1234/1234.git/description
    0/nw/01/aa/3f/1234/1234.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/hooks
    0/nw/01/aa/3f/1234/1234.git/index
    0/nw/01/aa/3f/1234/1234.git/info/
    0/nw/01/aa/3f/1234/1234.git/info/exclude
    0/nw/01/aa/3f/1234/1234.git/logs/
    0/nw/01/aa/3f/1234/1234.git/logs/HEAD
    0/nw/01/aa/3f/1234/1234.git/logs/refs/
    0/nw/01/aa/3f/1234/1234.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1234.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1234.git/objects/
    0/nw/01/aa/3f/1234/1234.git/objects/24/
    0/nw/01/aa/3f/1234/1234.git/objects/24/7baa174e2f22369b0662080be8a8382f0ee111
    0/nw/01/aa/3f/1234/1234.git/objects/4b/
    0/nw/01/aa/3f/1234/1234.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1234.git/objects/info/
    0/nw/01/aa/3f/1234/1234.git/objects/pack/
    0/nw/01/aa/3f/1234/1234.git/refs/
    0/nw/01/aa/3f/1234/1234.git/refs/heads/
    0/nw/01/aa/3f/1234/1234.git/refs/heads/master
    0/nw/01/aa/3f/1234/1234.git/refs/tags/
    0/nw/01/aa/3f/1234/1234.wiki.git/
    0/nw/01/aa/3f/1234/1234.wiki.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1234.wiki.git/HEAD
    0/nw/01/aa/3f/1234/1234.wiki.git/config
    0/nw/01/aa/3f/1234/1234.wiki.git/description
    0/nw/01/aa/3f/1234/1234.wiki.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/hooks
    0/nw/01/aa/3f/1234/1234.wiki.git/index
    0/nw/01/aa/3f/1234/1234.wiki.git/info/
    0/nw/01/aa/3f/1234/1234.wiki.git/info/exclude
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/HEAD
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1234.wiki.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/24/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/24/7baa174e2f22369b0662080be8a8382f0ee111
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/4b/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/info/
    0/nw/01/aa/3f/1234/1234.wiki.git/objects/pack/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/heads/
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/heads/master
    0/nw/01/aa/3f/1234/1234.wiki.git/refs/tags/
    0/nw/01/aa/3f/1234/1235.git/
    0/nw/01/aa/3f/1234/1235.git/COMMIT_EDITMSG
    0/nw/01/aa/3f/1234/1235.git/HEAD
    0/nw/01/aa/3f/1234/1235.git/config
    0/nw/01/aa/3f/1234/1235.git/description
    0/nw/01/aa/3f/1234/1235.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/hooks
    0/nw/01/aa/3f/1234/1235.git/index
    0/nw/01/aa/3f/1234/1235.git/svn.history.msgpack
    0/nw/01/aa/3f/1234/1235.git/info/
    0/nw/01/aa/3f/1234/1235.git/info/exclude
    0/nw/01/aa/3f/1234/1235.git/logs/
    0/nw/01/aa/3f/1234/1235.git/logs/HEAD
    0/nw/01/aa/3f/1234/1235.git/logs/refs/
    0/nw/01/aa/3f/1234/1235.git/logs/refs/heads/
    0/nw/01/aa/3f/1234/1235.git/logs/refs/heads/master
    0/nw/01/aa/3f/1234/1235.git/objects/
    0/nw/01/aa/3f/1234/1235.git/objects/24/
    0/nw/01/aa/3f/1234/1235.git/objects/24/7baa174e2f22369b0662080be8a8382f0ee111
    0/nw/01/aa/3f/1234/1235.git/objects/4b/
    0/nw/01/aa/3f/1234/1235.git/objects/4b/825dc642cb6eb9a060e54bf8d69288fbee4904
    0/nw/01/aa/3f/1234/1235.git/objects/info/
    0/nw/01/aa/3f/1234/1235.git/objects/pack/
    0/nw/01/aa/3f/1234/1235.git/refs/
    0/nw/01/aa/3f/1234/1235.git/refs/heads/
    0/nw/01/aa/3f/1234/1235.git/refs/heads/master
    0/nw/01/aa/3f/1234/1235.git/refs/tags/
    0/nw/01/aa/3f/1234/1235.git/svn_data/
    0/nw/01/aa/3f/1234/1235.git/svn_data/property_history.msgpack
    
    sent 7,041 bytes  received 874 bytes  15,830.00 bytes/sec
    total size is 3,181  speedup is 0.40
    * Transferring repository networks to git-server-fake-uuid1 ...
    sending incremental file list
    1/
    1/nw/
    1/nw/23/
    1/nw/23/bb/
    1/nw/23/bb/4c/
    1/nw/23/bb/4c/2345/
    1/nw/23/bb/4c/2345/broken.git/
    1/nw/23/bb/4c/2345/broken.git/COMMIT_EDITMSG
    1/nw/23/bb/4c/2345/broken.git/HEAD
    1/nw/23/bb/4c/2345/broken.git/config
    1/nw/23/bb/4c/2345/broken.git/description
    1/nw/23/bb/4c/2345/broken.git/hooks -> /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/test-ghe-restore.sh-12554/hooks
    1/nw/23/bb/4c/2345/broken.git/index
    1/nw/23/bb/4c/2345/broken.git/info/
    1/nw/23/bb/4c/2345/broken.git/info/exclude
    1/nw/23/bb/4c/2345/broken.git/logs/
    1/nw/23/bb/4c/2345/broken.git/logs/HEAD
    1/nw/23/bb/4c/2345/broken.git/logs/refs/
    1/nw/23/bb/4c/2345/broken.git/logs/refs/heads/
    1/nw/23/bb/4c/2345/broken.git/logs/refs/heads/master
    1/nw/23/bb/4c/2345/broken.git/objects/
    1/nw/23/bb/4c/2345/broken.git/objects/24/
    1/nw/23/bb/4c/2345/broken.git/objects/24/7baa174e2f22369b0662080be8a8382f0ee111
    1/nw/23/bb/4c/2345/broken.git/objects/4b/
    1/nw/23/bb/4c/2345/broken.git/objects/info/
    1/nw/23/bb/4c/2345/broken.git/objects/pack/
    1/nw/23/bb/4c/2345/broken.git/refs/
    1/nw/23/bb/4c/2345/broken.git/refs/heads/
    1/nw/23/bb/4c/2345/broken.git/refs/heads/master
    1/nw/23/bb/4c/2345/broken.git/refs/tags/
    
    sent 4,809 bytes  received 331 bytes  10,280.00 bytes/sec
    total size is 4,210  speedup is 0.82
    * Transferring repository networks to git-server-fake-uuid2 ...
    sending incremental file list
    
    sent 890 bytes  received 31 bytes  614.00 bytes/sec
    total size is 1,029  speedup is 1.12
    Finalizing routes
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- sponge /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-WfnUKS/remote_to_restore
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    /bin/bash: line 3: parallel: command not found
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- rm -rf /var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/backup-utils-restore-WfnUKS
    + exec ssh -o ControlMaster=auto -o 'ControlPath="/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1/test/tmp/.ghe-sshmux-544c4229"' -o ControlPersist=10m -o ServerAliveInterval=10 -l admin -p 22 -o BatchMode=yes 127.0.0.1 -- /bin/bash
    fake-uuid
    fake-uuid1
    fake-uuid2
    
    + : ghe-restore should have exited successfully
    + false
    test failed. last command exited with 1
    ++ date +%s
    + after_time=1547682290
    + elapsed_time=6
test: ghe-backup empty git-hooks directory ...                          OK (10s)
test: ghe-backup fsck ...                                               OK (38s)
test: ghe-backup stores version when not run from a clone ...           OK (0s)
test: ghe-backup with leaked SSH host key detection for current backup ... OK (10s)
test: ghe-backup with no leaked keys ...                                OK (10s)
test: ghe-backup honours --version flag ...                             OK (0s)
test: ghe-backup honours --help and -h flags ...                        OK (0s)
test: ghe-backup exits early on unsupported version ...                 OK (0s)
test: ghe-backup-strategy returns rsync for HA backup ...               OK (1s)
test: ghe-backup cluster ...                                            OK (11s)
test: ghe-backup not missing directories or files on source appliance ... OK (11s)
test: ghe-backup missing directories or files on source appliance ...   OK (11s)

make: *** [Makefile:4: test] Error 1
 * ERROR: app-admin/github-backup-utils-2.15.1::gentoo failed (test phase):
 *   emake failed
 * 
 * If you need support, post the output of `emerge --info '=app-admin/github-backup-utils-2.15.1::gentoo'`,
 * the complete build log and the output of `emerge -pqv '=app-admin/github-backup-utils-2.15.1::gentoo'`.
 * The complete build log is located at '/var/log/portage/app-admin:github-backup-utils-2.15.1:20190116-233943.log'.
 * For convenience, a symlink to the build log is located at '/var/tmp/portage/app-admin/github-backup-utils-2.15.1/temp/build.log'.
 * The ebuild environment file is located at '/var/tmp/portage/app-admin/github-backup-utils-2.15.1/temp/environment'.
 * Working directory: '/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1'
 * S: '/var/tmp/portage/app-admin/github-backup-utils-2.15.1/work/backup-utils-2.15.1'