[neon-notifications] Build failed in Jenkins: mgmt_digital-ocean #2757

Tue Apr 2 11:38:56 BST 2024

See <https://build.neon.kde.org/job/mgmt_digital-ocean/2757/display/redirect>

Changes:


------------------------------------------
Started by user Jonathan Riddell
Running as SYSTEM
[EnvInject] - Loading node environment variables.
Building on the built-in node in workspace <https://build.neon.kde.org/job/mgmt_digital-ocean/ws/>
[mgmt_digital-ocean] $ /bin/sh -xe /tmp/jenkins8966347149500103294.sh
+ /home/neonjenkins/tooling/mgmt/digital_ocean.rb
[0;32mI, [2024-04-02T10:37:55.579731 #1687771]  INFO -- : Creating new droplet.
[0;0m[0;32mI, [2024-04-02T10:38:03.151849 #1687771]  INFO -- : Waiting for droplet to start
[0;0m[0;32mI, [2024-04-02T10:38:19.389019 #1687771]  INFO -- : Waiting for droplet to start
[0;0m[0;32mI, [2024-04-02T10:38:36.414924 #1687771]  INFO -- : Waiting for droplet to start
[0;0m[0;32mI, [2024-04-02T10:38:36.913033 #1687771]  INFO -- : waiting for SSH to start ["207.154.218.252", "root"]
[0;0m[0;32mI, [2024-04-02T10:38:44.934988 #1687771]  INFO -- : waiting for SSH to start ["207.154.218.252", "root"]
[0;0m[0;32mI, [2024-04-02T10:38:52.950216 #1687771]  INFO -- : waiting for SSH to start ["207.154.218.252", "root"]
[0;0m[0;32mI, [2024-04-02T10:38:54.265033 #1687771]  INFO -- : /home/neonjenkins/tooling/mgmt/digital_ocean/deploy.sh => /root/deploy.sh
[0;0m[0;32mI, [2024-04-02T10:38:54.294118 #1687771]  INFO -- : /home/neonjenkins/tooling/mgmt/digital_ocean/deploy_tooling.sh => /root/deploy_tooling.sh
[0;0mError on retry_it(unknown) :: Connection refused - connect(2) for 207.154.218.252:22
Error on retry_it(unknown) :: Connection refused - connect(2) for 207.154.218.252:22
ssh: connect to host 207.154.218.252 port 22: Connection refused
Apr 02 10:38:48 jenkins-slave-deploy systemd[1]: pollinate.service: Deactivated successfully.
Apr 02 10:38:48 jenkins-slave-deploy systemd[1]: Finished Pollinate to seed the pseudo random number generator.
Apr 02 10:38:48 jenkins-slave-deploy systemd[1]: Starting OpenBSD Secure Shell server...
Apr 02 10:38:48 jenkins-slave-deploy sshd[804]: Server listening on 0.0.0.0 port 22.
Apr 02 10:38:48 jenkins-slave-deploy sshd[804]: Server listening on :: port 22.
Apr 02 10:38:48 jenkins-slave-deploy systemd[1]: Started OpenBSD Secure Shell server.
Apr 02 10:38:49 jenkins-slave-deploy snapd[723]: overlord.go:268: Acquiring state lock file
Apr 02 10:38:49 jenkins-slave-deploy snapd[723]: overlord.go:273: Acquired state lock file
Apr 02 10:38:49 jenkins-slave-deploy snapd[723]: patch.go:64: Patching system state level 6 to sublevel 1...
Apr 02 10:38:49 jenkins-slave-deploy snapd[723]: patch.go:64: Patching system state level 6 to sublevel 2...
Apr 02 10:38:49 jenkins-slave-deploy snapd[723]: patch.go:64: Patching system state level 6 to sublevel 3...
Apr 02 10:38:49 jenkins-slave-deploy snapd[723]: daemon.go:247: started snapd/2.58.2 (series 16; classic) ubuntu/22.04 (amd64) linux/5.15.0-67-generic.
Apr 02 10:38:49 jenkins-slave-deploy kernel: loop3: detected capacity change from 0 to 8
Apr 02 10:38:49 jenkins-slave-deploy systemd[1]: tmp-syscheck\x2dmountpoint\x2d476976852.mount: Deactivated successfully.
Apr 02 10:38:49 jenkins-slave-deploy snapd[723]: daemon.go:340: adjusting startup timeout by 45s (pessimistic estimate of 30s plus 5s per snap)
Apr 02 10:38:49 jenkins-slave-deploy snapd[723]: backends.go:58: AppArmor status: apparmor is enabled and all features are available
Apr 02 10:38:49 jenkins-slave-deploy systemd[1]: Started Snap Daemon.
Apr 02 10:38:49 jenkins-slave-deploy systemd[1]: Starting Wait until snapd is fully seeded...
Apr 02 10:38:49 jenkins-slave-deploy audit[864]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap-update-ns.lxd" pid=864 comm="apparmor_parser"
Apr 02 10:38:49 jenkins-slave-deploy kernel: audit: type=1400 audit(1712054329.495:31): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap-update-ns.lxd" pid=864 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy audit[865]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.activate" pid=865 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy kernel: audit: type=1400 audit(1712054330.016:32): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.activate" pid=865 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy audit[871]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.benchmark" pid=871 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy kernel: audit: type=1400 audit(1712054330.303:33): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.benchmark" pid=871 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy audit[863]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="/snap/snapd/18357/usr/lib/snapd/snap-confine" pid=863 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy audit[863]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="/snap/snapd/18357/usr/lib/snapd/snap-confine//mount-namespace-capture-helper" pid=863 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy kernel: audit: type=1400 audit(1712054330.521:34): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="/snap/snapd/18357/usr/lib/snapd/snap-confine" pid=863 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy kernel: audit: type=1400 audit(1712054330.521:35): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="/snap/snapd/18357/usr/lib/snapd/snap-confine//mount-namespace-capture-helper" pid=863 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy audit[873]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.buginfo" pid=873 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy kernel: audit: type=1400 audit(1712054330.581:36): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.buginfo" pid=873 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy audit[874]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.check-kernel" pid=874 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy kernel: audit: type=1400 audit(1712054330.827:37): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.check-kernel" pid=874 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy audit[875]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.daemon" pid=875 comm="apparmor_parser"
Apr 02 10:38:50 jenkins-slave-deploy kernel: audit: type=1400 audit(1712054330.912:38): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.daemon" pid=875 comm="apparmor_parser"
Apr 02 10:38:51 jenkins-slave-deploy audit[876]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.hook.configure" pid=876 comm="apparmor_parser"
Apr 02 10:38:51 jenkins-slave-deploy kernel: audit: type=1400 audit(1712054331.086:39): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.hook.configure" pid=876 comm="apparmor_parser"
Apr 02 10:38:51 jenkins-slave-deploy audit[877]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.hook.install" pid=877 comm="apparmor_parser"
Apr 02 10:38:51 jenkins-slave-deploy kernel: audit: type=1400 audit(1712054331.182:40): apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.hook.install" pid=877 comm="apparmor_parser"
Apr 02 10:38:51 jenkins-slave-deploy audit[878]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.hook.remove" pid=878 comm="apparmor_parser"
Apr 02 10:38:51 jenkins-slave-deploy audit[879]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.lxc" pid=879 comm="apparmor_parser"
Apr 02 10:38:51 jenkins-slave-deploy audit[880]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.lxc-to-lxd" pid=880 comm="apparmor_parser"
Apr 02 10:38:51 jenkins-slave-deploy audit[881]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.lxd" pid=881 comm="apparmor_parser"
Apr 02 10:38:51 jenkins-slave-deploy audit[882]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.migrate" pid=882 comm="apparmor_parser"
Apr 02 10:38:51 jenkins-slave-deploy audit[883]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="snap.lxd.user-daemon" pid=883 comm="apparmor_parser"
Apr 02 10:38:52 jenkins-slave-deploy audit[884]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="/usr/lib/snapd/snap-confine" pid=884 comm="apparmor_parser"
Apr 02 10:38:52 jenkins-slave-deploy audit[884]: AVC apparmor="STATUS" operation="profile_replace" info="same as current profile, skipping" profile="unconfined" name="/usr/lib/snapd/snap-confine//mount-namespace-capture-helper" pid=884 comm="apparmor_parser"
Apr 02 10:38:52 jenkins-slave-deploy systemd[1]: Started snap.lxd.hook.install.6b4e7b80-802e-43ef-92ac-1ee3945b240e.scope.
Apr 02 10:38:52 jenkins-slave-deploy systemd[1]: tmp-snap.rootfs_jDwp4M.mount: Deactivated successfully.
Apr 02 10:38:52 jenkins-slave-deploy systemd[1]: snap.lxd.hook.install.6b4e7b80-802e-43ef-92ac-1ee3945b240e.scope: Deactivated successfully.
Apr 02 10:38:52 jenkins-slave-deploy systemd[1]: Reloading.
Apr 02 10:38:52 jenkins-slave-deploy systemd[1]: Listening on Socket unix for snap application lxd.user-daemon.
Apr 02 10:38:52 jenkins-slave-deploy systemd[1]: Listening on Socket unix for snap application lxd.daemon.
Apr 02 10:38:52 jenkins-slave-deploy systemd[1]: Starting Service for snap application lxd.activate...
Apr 02 10:38:52 jenkins-slave-deploy lxd.activate[941]: => Starting LXD activation
Apr 02 10:38:52 jenkins-slave-deploy lxd.activate[941]: ==> Creating missing snap configuration
Apr 02 10:38:53 jenkins-slave-deploy sshd[940]: Accepted publickey for root from 138.201.132.177 port 43624 ssh2: RSA SHA256:XnNbGFp5llM4N/Hc1aD4VA9d8tc8IawL9bnSXRmFsAE
Apr 02 10:38:53 jenkins-slave-deploy sshd[940]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
Apr 02 10:38:53 jenkins-slave-deploy systemd[1]: Created slice User Slice of UID 0.
Apr 02 10:38:53 jenkins-slave-deploy systemd[1]: Starting User Runtime Directory /run/user/0...
Apr 02 10:38:53 jenkins-slave-deploy systemd-logind[724]: New session 1 of user root.
Apr 02 10:38:53 jenkins-slave-deploy systemd[1]: Finished User Runtime Directory /run/user/0.
Apr 02 10:38:53 jenkins-slave-deploy systemd[1]: Starting User Manager for UID 0...
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)
Apr 02 10:38:53 jenkins-slave-deploy systemd[1]: dmesg.service: Deactivated successfully.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Queued start job for default target Main User Target.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Created slice User Application Slice.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Reached target Paths.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Reached target Timers.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Starting D-Bus User Message Bus Socket...
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Listening on GnuPG network certificate management daemon.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Listening on GnuPG cryptographic agent and passphrase cache.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Listening on debconf communication socket.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Listening on REST API socket for snapd user session agent.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Listening on D-Bus User Message Bus Socket.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Reached target Sockets.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Reached target Basic System.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Reached target Main User Target.
Apr 02 10:38:53 jenkins-slave-deploy systemd[983]: Startup finished in 112ms.
Apr 02 10:38:53 jenkins-slave-deploy systemd[1]: Started User Manager for UID 0.
Apr 02 10:38:53 jenkins-slave-deploy systemd[1]: Started Session 1 of User root.
Apr 02 10:38:53 jenkins-slave-deploy sshd[976]: Accepted publickey for root from 138.201.132.177 port 43630 ssh2: RSA SHA256:XnNbGFp5llM4N/Hc1aD4VA9d8tc8IawL9bnSXRmFsAE
Apr 02 10:38:53 jenkins-slave-deploy sshd[976]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
Apr 02 10:38:53 jenkins-slave-deploy lxd.activate[941]: ==> Loading snap configuration
Apr 02 10:38:53 jenkins-slave-deploy lxd.activate[941]: ==> Checking for socket activation support
Apr 02 10:38:53 jenkins-slave-deploy systemd-logind[724]: New session 3 of user root.
Apr 02 10:38:53 jenkins-slave-deploy systemd[1]: Started Session 3 of User root.
Apr 02 10:38:53 jenkins-slave-deploy lxd.activate[941]: ==> Creating "lxd" user
Apr 02 10:38:53 jenkins-slave-deploy useradd[1194]: new user: name=lxd, UID=999, GID=100, home=/var/snap/lxd/common/lxd, shell=/bin/false, from=none
Apr 02 10:38:53 jenkins-slave-deploy lxd.activate[941]: ==> Setting LXD socket ownership
Apr 02 10:38:53 jenkins-slave-deploy lxd.activate[941]: ==> Setting LXD user socket ownership
Apr 02 10:38:53 jenkins-slave-deploy lxd.activate[941]: ==> LXD never started on this system, no need to start it now
Apr 02 10:38:53 jenkins-slave-deploy systemd[1]: snap.lxd.activate.service: Deactivated successfully.
Apr 02 10:38:53 jenkins-slave-deploy systemd[1]: Finished Service for snap application lxd.activate.
Apr 02 10:38:53 jenkins-slave-deploy systemd[1]: Started snap.lxd.hook.configure.ca21f71c-2b94-4fd3-9e3d-d4cd683d146d.scope.
Apr 02 10:38:54 jenkins-slave-deploy systemd[1]: snap.lxd.hook.configure.ca21f71c-2b94-4fd3-9e3d-d4cd683d146d.scope: Deactivated successfully.
Apr 02 10:38:54 jenkins-slave-deploy dbus-daemon[710]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.14' (uid=0 pid=723 comm="/usr/lib/snapd/snapd " label="unconfined")
Apr 02 10:38:54 jenkins-slave-deploy systemd[1]: Starting Time & Date Service...
Apr 02 10:38:54 jenkins-slave-deploy dbus-daemon[710]: [system] Successfully activated service 'org.freedesktop.timedate1'
Apr 02 10:38:54 jenkins-slave-deploy systemd[1]: Started Time & Date Service.
Apr 02 10:38:54 jenkins-slave-deploy sshd[940]: pam_unix(sshd:session): session closed for user root
Apr 02 10:38:54 jenkins-slave-deploy systemd-logind[724]: Session 1 logged out. Waiting for processes to exit.
Apr 02 10:38:54 jenkins-slave-deploy sshd[976]: pam_unix(sshd:session): session closed for user root
Apr 02 10:38:54 jenkins-slave-deploy systemd[1]: session-3.scope: Deactivated successfully.
Apr 02 10:38:54 jenkins-slave-deploy systemd-logind[724]: Session 3 logged out. Waiting for processes to exit.
Apr 02 10:38:54 jenkins-slave-deploy systemd-logind[724]: Removed session 3.
Apr 02 10:38:54 jenkins-slave-deploy systemd[1]: Finished Wait until snapd is fully seeded.
Apr 02 10:38:54 jenkins-slave-deploy systemd[1]: Starting Apply the settings specified in cloud-config...
Apr 02 10:38:54 jenkins-slave-deploy systemd[1]: Condition check resulted in Auto import assertions from block devices being skipped.
Apr 02 10:38:54 jenkins-slave-deploy systemd-udevd[618]: Network interface NamePolicy= disabled on kernel command line, ignoring.
Apr 02 10:38:54 jenkins-slave-deploy cloud-init[1484]: Cloud-init v. 22.4.2-0ubuntu0~22.04.1 running 'modules:config' at Tue, 02 Apr 2024 10:38:54 +0000. Up 27.13 seconds.
Apr 02 10:38:55 jenkins-slave-deploy systemd[1]: session-1.scope: Deactivated successfully.
Apr 02 10:38:55 jenkins-slave-deploy systemd[1]: session-1.scope: Consumed 1.093s CPU time.
Apr 02 10:38:55 jenkins-slave-deploy systemd-logind[724]: Removed session 1.
Apr 02 10:38:55 jenkins-slave-deploy sshd[804]: Received signal 15; terminating.
Apr 02 10:38:55 jenkins-slave-deploy systemd[1]: Stopping OpenBSD Secure Shell server...
Apr 02 10:38:55 jenkins-slave-deploy systemd[1]: ssh.service: Deactivated successfully.
Apr 02 10:38:55 jenkins-slave-deploy systemd[1]: Stopped OpenBSD Secure Shell server.
Apr 02 10:38:55 jenkins-slave-deploy systemd[1]: Starting OpenBSD Secure Shell server...
Apr 02 10:38:55 jenkins-slave-deploy sshd[1489]: Server listening on 0.0.0.0 port 22.
Apr 02 10:38:55 jenkins-slave-deploy sshd[1489]: Server listening on :: port 22.
Apr 02 10:38:55 jenkins-slave-deploy systemd[1]: Started OpenBSD Secure Shell server.
Apr 02 10:38:55 jenkins-slave-deploy sshd[1498]: Accepted publickey for root from 138.201.132.177 port 43652 ssh2: RSA SHA256:XnNbGFp5llM4N/Hc1aD4VA9d8tc8IawL9bnSXRmFsAE
Apr 02 10:38:55 jenkins-slave-deploy sshd[1498]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)
Apr 02 10:38:55 jenkins-slave-deploy systemd-logind[724]: New session 4 of user root.
Apr 02 10:38:55 jenkins-slave-deploy systemd[1]: Started Session 4 of User root.
[1;33mW, [2024-04-02T10:38:55.760346 #1687771]  WARN -- : deleting droplet
[0;0m:delete
[]
{:id=>410441486}
/home/neonjenkins/tooling/mgmt/digital_ocean.rb:103:in `<main>': unhandled exception
Build step 'Execute shell' marked build as failure