[2022-11-24T20:39:57.185Z] [ debug] ## Starting deploy pkg operation
[2022-11-24T20:39:57.185Z] [ debug] Deploying /var/run/bb9a2054/imcf-PXHaLk
[2022-11-24T20:39:57.185Z] [ info] Initializing deployment module.
[2022-11-24T20:39:57.185Z] [ info] Cleaning old state files.
[2022-11-24T20:39:57.185Z] [ info] EXIT STATE 'INPROGRESS'.
[2022-11-24T20:39:57.185Z] [ debug] Setting deploy error: 'Error removing lock '/var/log/.vmware-deploy.INPROGRESS'.(No such file or directory)'.
[2022-11-24T20:39:57.185Z] [ info] EXIT STATE 'Done'.
[2022-11-24T20:39:57.185Z] [ debug] Setting deploy error: 'Error removing lock '/var/log/.vmware-deploy.Done'.(No such file or directory)'.
[2022-11-24T20:39:57.185Z] [ info] EXIT STATE 'ERRORED'.
[2022-11-24T20:39:57.185Z] [ debug] Setting deploy error: 'Error removing lock '/var/log/.vmware-deploy.ERRORED'.(No such file or directory)'.
[2022-11-24T20:39:57.185Z] [ debug] Setting deploy error: 'Success.'.
[2022-11-24T20:39:57.185Z] [ info] Deploying cabinet file '/var/run/bb9a2054/imcf-PXHaLk'.
[2022-11-24T20:39:57.185Z] [ info] Transitioning from state '(null)' to state 'INPROGRESS'.
[2022-11-24T20:39:57.185Z] [ info] ENTER STATE 'INPROGRESS'.
[2022-11-24T20:39:57.187Z] [ info] Reading cabinet file '/var/run/bb9a2054/imcf-PXHaLk' and will extract it to '/var/run/.vmware-imgcust-d8t26Fm'.
[2022-11-24T20:39:57.187Z] [ info] Flags in the header: 0.
[2022-11-24T20:39:57.187Z] [ info] Original deployment command: '/usr/bin/perl -I/tmp/.vmware/linux/deploy/scripts /tmp/.vmware/linux/deploy/scripts/Customize.pl /tmp/.vmware/linux/deploy/cust.cfg'.
[2022-11-24T20:39:57.187Z] [ info] Actual deployment command: '/usr/bin/perl -I/var/run/.vmware-imgcust-d8t26Fm/scripts /var/run/.vmware-imgcust-d8t26Fm/scripts/Customize.pl /var/run/.vmware-imgcust-d8t26Fm/cust.cfg'.
[2022-11-24T20:39:57.187Z] [ info] Extracting package files.
[2022-11-24T20:39:57.202Z] [ debug] Command to exec : '/usr/bin/cloud-init'.
[2022-11-24T20:39:57.202Z] [ info] sizeof ProcessInternal is 56
[2022-11-24T20:39:57.202Z] [ info] Returning, pending output from stdout
[2022-11-24T20:39:57.202Z] [ info] Returning, pending output from stderr
[2022-11-24T20:39:59.305Z] [ info] Saving output from stdout
[2022-11-24T20:39:59.405Z] [ info] Process exited normally after 2 seconds, returned 0
[2022-11-24T20:39:59.405Z] [ info] No more output from stdout
[2022-11-24T20:39:59.405Z] [ info] No more output from stderr
[2022-11-24T20:39:59.405Z] [ info] Customization command output:
'/usr/bin/cloud-init 22.3.4-0ubuntu1~22.04.1
'.
[2022-11-24T20:39:59.405Z] [ info] cloud-init is installed.
[2022-11-24T20:39:59.405Z] [ info] Checking if cloud.cfg exists and if cloud-init is enabled.
[2022-11-24T20:39:59.406Z] [ info] UseCloudInitWorkflow return: 4
[2022-11-24T20:39:59.406Z] [ info] Executing traditional GOSC workflow.
[2022-11-24T20:39:59.406Z] [ debug] Command to exec : '/usr/bin/perl'.
[2022-11-24T20:39:59.406Z] [ info] sizeof ProcessInternal is 56
[2022-11-24T20:39:59.406Z] [ info] Returning, pending output from stdout
[2022-11-24T20:39:59.406Z] [ info] Returning, pending output from stderr
[2022-11-24T20:40:03.313Z] [ info] Saving output from stdout
[2022-11-24T20:40:03.313Z] [ info] Saving output from stdout
[2022-11-24T20:40:03.313Z] [ info] Saving output from stdout
[2022-11-24T20:40:03.313Z] [ info] Saving output from stdout
[2022-11-24T20:40:03.313Z] [ info] Saving output from stdout
[2022-11-24T20:40:03.313Z] [ info] Saving output from stdout
[2022-11-24T20:40:03.313Z] [ info] Saving output from stdout
[2022-11-24T20:40:03.314Z] [ info] Saving output from stdout
[2022-11-24T20:40:03.314Z] [ info] Saving output from stdout
[2022-11-24T20:40:04.315Z] [ info] Saving output from stdout
[2022-11-24T20:40:05.317Z] [ info] Saving output from stdout
[2022-11-24T20:40:06.319Z] [ info] Saving output from stdout
[2022-11-24T20:40:07.322Z] [ info] Saving output from stdout
[2022-11-24T20:40:08.323Z] [ info] Saving output from stdout
[2022-11-24T20:40:09.325Z] [ info] Saving output from stdout
[2022-11-24T20:40:10.437Z] [ info] Saving output from stdout
[2022-11-24T20:40:11.439Z] [ info] Saving output from stdout
[2022-11-24T20:40:12.441Z] [ info] Saving output from stdout
[2022-11-24T20:40:13.443Z] [ info] Saving output from stdout
[2022-11-24T20:40:13.543Z] [ info] Saving output from stdout
[2022-11-24T20:40:14.444Z] [ info] Saving output from stdout
[2022-11-24T20:40:14.945Z] [ info] Saving output from stdout
[2022-11-24T20:40:14.945Z] [ info] Saving output from stdout
[2022-11-24T20:40:15.546Z] [ info] Saving output from stdout
[2022-11-24T20:40:15.647Z] [ info] Saving output from stdout
[2022-11-24T20:40:17.550Z] [ info] Process exited normally after 18 seconds, returned 0
[2022-11-24T20:40:17.550Z] [ info] Saving output from stdout
[2022-11-24T20:40:17.550Z] [ info] Saving output from stdout
[2022-11-24T20:40:17.550Z] [ info] Saving output from stdout
[2022-11-24T20:40:17.550Z] [ info] Saving output from stdout
[2022-11-24T20:40:17.550Z] [ info] No more output from stdout
[2022-11-24T20:40:17.550Z] [ info] No more output from stderr
[2022-11-24T20:40:17.550Z] [ info] Customization command output:
=================== Perl script log start =================
2022-11-24T20:40:03 DEBUG: Creating directory /var/lock/vmware
2022-11-24T20:40:03 DEBUG: Opening /var/lock/vmware/gosc in O_CREAT|O_EXCL|O_WRONLY mode
2022-11-24T20:40:03 INFO: Opening file name /var/run/.vmware-imgcust-d8t26Fm/cust.cfg.
2022-11-24T20:40:03 DEBUG: Processing line: '[NETWORK]'
2022-11-24T20:40:03 DEBUG: FOUND CATEGORY = NETWORK
2022-11-24T20:40:03 DEBUG: Processing line: 'NETWORKING = yes'
2022-11-24T20:40:03 DEBUG: ADDED KEY-VAL :: 'NETWORK|NETWORKING' = 'yes'
2022-11-24T20:40:03 DEBUG: Processing line: 'BOOTPROTO = dhcp'
2022-11-24T20:40:03 DEBUG: ADDED KEY-VAL :: 'NETWORK|BOOTPROTO' = 'dhcp'
2022-11-24T20:40:03 DEBUG: Processing line: 'HOSTNAME = web1'
2022-11-24T20:40:03 DEBUG: ADDED KEY-VAL :: 'NETWORK|HOSTNAME' = 'web1'
2022-11-24T20:40:03 DEBUG: Processing line: 'DOMAINNAME = *geknipt domein*.nl'
2022-11-24T20:40:03 DEBUG: ADDED KEY-VAL :: 'NETWORK|DOMAINNAME' = '*geknipt domein*.nl'
2022-11-24T20:40:03 DEBUG: Processing line: ''
2022-11-24T20:40:03 DEBUG: Empty line. Ignored.
2022-11-24T20:40:03 DEBUG: Processing line: '[NIC-CONFIG]'
2022-11-24T20:40:03 DEBUG: FOUND CATEGORY = NIC-CONFIG
2022-11-24T20:40:03 DEBUG: Processing line: 'NICS = NIC1'
2022-11-24T20:40:03 DEBUG: ADDED KEY-VAL :: 'NIC-CONFIG|NICS' = 'NIC1'
2022-11-24T20:40:03 DEBUG: Processing line: ''
2022-11-24T20:40:03 DEBUG: Empty line. Ignored.
2022-11-24T20:40:03 DEBUG: Processing line: '[NIC1]'
2022-11-24T20:40:03 DEBUG: FOUND CATEGORY = NIC1
2022-11-24T20:40:03 DEBUG: Processing line: 'MACADDR = 00:50:56:ba:4c:92'
2022-11-24T20:40:03 DEBUG: ADDED KEY-VAL :: 'NIC1|MACADDR' = '00:50:56:ba:4c:92'
2022-11-24T20:40:03 DEBUG: Processing line: 'ONBOOT = yes'
2022-11-24T20:40:03 DEBUG: ADDED KEY-VAL :: 'NIC1|ONBOOT' = 'yes'
2022-11-24T20:40:03 DEBUG: Processing line: 'IPv4_MODE = BACKWARDS_COMPATIBLE'
2022-11-24T20:40:03 DEBUG: ADDED KEY-VAL :: 'NIC1|IPv4_MODE' = 'BACKWARDS_COMPATIBLE'
2022-11-24T20:40:03 DEBUG: Processing line: 'BOOTPROTO = dhcp'
2022-11-24T20:40:03 DEBUG: ADDED KEY-VAL :: 'NIC1|BOOTPROTO' = 'dhcp'
2022-11-24T20:40:03 DEBUG: Processing line: ''
2022-11-24T20:40:03 DEBUG: Empty line. Ignored.
2022-11-24T20:40:03 DEBUG: Processing line: ''
2022-11-24T20:40:03 DEBUG: Empty line. Ignored.
2022-11-24T20:40:03 DEBUG: Processing line: '[DNS]'
2022-11-24T20:40:03 DEBUG: FOUND CATEGORY = DNS
2022-11-24T20:40:03 DEBUG: Processing line: 'DNSFROMDHCP=yes'
2022-11-24T20:40:03 DEBUG: ADDED KEY-VAL :: 'DNS|DNSFROMDHCP' = 'yes'
2022-11-24T20:40:03 DEBUG: Processing line: ''
2022-11-24T20:40:03 DEBUG: Empty line. Ignored.
2022-11-24T20:40:03 DEBUG: Processing line: ''
2022-11-24T20:40:03 DEBUG: Empty line. Ignored.
2022-11-24T20:40:03 DEBUG: Processing line: ''
2022-11-24T20:40:03 DEBUG: Empty line. Ignored.
2022-11-24T20:40:03 DEBUG: Processing line: '[DATETIME]'
2022-11-24T20:40:03 DEBUG: FOUND CATEGORY = DATETIME
2022-11-24T20:40:03 DEBUG: Processing line: 'UTC = yes'
2022-11-24T20:40:03 DEBUG: ADDED KEY-VAL :: 'DATETIME|UTC' = 'yes'
2022-11-24T20:40:03 DEBUG: Opening file /var/run/.vmware-imgcust-d8t26Fm/buildInfo.txt.
2022-11-24T20:40:03 INFO: SYSIMAGE_VERSION = 11.4.0.25296
2022-11-24T20:40:03 INFO: BUILDNUMBER = build-19901193
2022-11-24T20:40:03 DEBUG: Reading issue file ...
2022-11-24T20:40:03 DEBUG: Command: 'cat /etc/issue'
2022-11-24T20:40:03 DEBUG: Exit Code: 0
2022-11-24T20:40:03 DEBUG: Result: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 DEBUG: Reading /etc/os-release file ...
2022-11-24T20:40:03 DEBUG: opening file /etc/os-release.
2022-11-24T20:40:03 DEBUG: Match found : Line = PRETTY_NAME="Ubuntu 22.04.1 LTS"
2022-11-24T20:40:03 DEBUG: Actual String : "Ubuntu 22.04.1 LTS"
2022-11-24T20:40:03 DEBUG: Reading issue file ...
2022-11-24T20:40:03 DEBUG: Command: 'cat /etc/issue'
2022-11-24T20:40:03 DEBUG: Exit Code: 0
2022-11-24T20:40:03 DEBUG: Result: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 DEBUG: file content: 'Ubuntu 22.04.1 LTS \n \l
'
2022-11-24T20:40:03 DEBUG: Reading /etc/os-release file ...
2022-11-24T20:40:03 DEBUG: opening file /etc/os-release.
2022-11-24T20:40:03 DEBUG: Match found : Line = VERSION_ID="22.04"
2022-11-24T20:40:03 DEBUG: Actual String : "22.04"
2022-11-24T20:40:03 DEBUG: ID: "22.04"
2022-11-24T20:40:03 DEBUG: opening file /etc/os-release.
2022-11-24T20:40:03 DEBUG: Match found : Line = VERSION_ID="22.04"
2022-11-24T20:40:03 DEBUG: Actual String : "22.04"
2022-11-24T20:40:03 DEBUG: Version: "22.04"
2022-11-24T20:40:03 WARNING: Amazon Linux flavor not detected
2022-11-24T20:40:03 DEBUG: Reading issue file ...
2022-11-24T20:40:03 DEBUG: Command: 'cat /etc/issue'
2022-11-24T20:40:03 DEBUG: Exit Code: 0
2022-11-24T20:40:03 DEBUG: Result: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 DEBUG: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 WARNING: RedHat release file not available. Ignoring it.
2022-11-24T20:40:03 WARNING: Redhat flavor not detected
2022-11-24T20:40:03 DEBUG: Reading issue file ...
2022-11-24T20:40:03 DEBUG: Command: 'cat /etc/issue'
2022-11-24T20:40:03 DEBUG: Exit Code: 0
2022-11-24T20:40:03 DEBUG: Result: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 DEBUG: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 WARNING: RedHat release file not available. Ignoring it.
2022-11-24T20:40:03 WARNING: Redhat flavor not detected
2022-11-24T20:40:03 DEBUG: Reading issue file ...
2022-11-24T20:40:03 DEBUG: Command: 'cat /etc/issue'
2022-11-24T20:40:03 DEBUG: Exit Code: 0
2022-11-24T20:40:03 DEBUG: Result: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 DEBUG: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 WARNING: RedHat release file not available. Ignoring it.
2022-11-24T20:40:03 WARNING: Redhat flavor not detected
2022-11-24T20:40:03 DEBUG: Command: 'cat /etc/lsb-release'
2022-11-24T20:40:03 DEBUG: Exit Code: 0
2022-11-24T20:40:03 DEBUG: Result: DISTRIB_ID=Ubuntu
DISTRIB_RELEASE=22.04
DISTRIB_CODENAME=jammy
DISTRIB_DESCRIPTION="Ubuntu 22.04.1 LTS"
2022-11-24T20:40:03 DEBUG: Reading issue file ...
2022-11-24T20:40:03 DEBUG: Command: 'cat /etc/issue'
2022-11-24T20:40:03 DEBUG: Exit Code: 0
2022-11-24T20:40:03 DEBUG: Result: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 DEBUG: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 INFO: Detected distribution: Ubuntu 22.04
2022-11-24T20:40:03 DEBUG: Reading issue file ...
2022-11-24T20:40:03 DEBUG: Command: 'cat /etc/issue'
2022-11-24T20:40:03 DEBUG: Exit Code: 0
2022-11-24T20:40:03 DEBUG: Result: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 DEBUG: Ubuntu 22.04.1 LTS \n \l
2022-11-24T20:40:03 INFO: Detected distribution flavour: Ubuntu 22.04
2022-11-24T20:40:03 INFO: Customization instance Ubuntu1910Customization loaded.
2022-11-24T20:40:03 INFO: Customization started
2022-11-24T20:40:03 DEBUG: Command: 'perl --version'
2022-11-24T20:40:03 DEBUG: Exit Code: 0
2022-11-24T20:40:03 DEBUG: Result:
This is perl 5, version 34, subversion 0 (v5.34.0) built for x86_64-linux-gnu-thread-multi
(with 57 registered patches, see perl -V for more detail)
Copyright 1987-2021, Larry Wall
Perl may be copied only under the terms of either the Artistic License or the
GNU General Public License, which may be found in the Perl 5 source kit.
Complete documentation for Perl, including FAQ lists, should be found on
this system using "man perl" or "perldoc perl". If you have access to the
Internet, point your browser at
http://www.perl.org/, the Perl Home Page.
2022-11-24T20:40:03 DEBUG: Command: 'hostname 2>/dev/null'
2022-11-24T20:40:03 DEBUG: Exit Code: 0
2022-11-24T20:40:03 DEBUG: Result: web2
2022-11-24T20:40:03 DEBUG: TimedCommand: 'hostname -f 2>/dev/null' with timeout of 5 sec
2022-11-24T20:40:03 DEBUG: Fetching result from /tmp/timed_out_tmp_file_823
2022-11-24T20:40:03 DEBUG: TimedResult: web2
2022-11-24T20:40:03 DEBUG: opening file /etc/hostname.
2022-11-24T20:40:03 DEBUG: Match found : Line = web2
2022-11-24T20:40:03 DEBUG: Actual String : web2
2022-11-24T20:40:03 INFO: OLD HOST NAME = web2
2022-11-24T20:40:03 INFO: Marker file exists or is undefined, pre-customization is not needed
2022-11-24T20:40:03 INFO: Customizing Network settings ...
2022-11-24T20:40:03 INFO: Erasing DHCP leases
2022-11-24T20:40:03 DEBUG: Command: 'pkill dhclient'
2022-11-24T20:40:03 DEBUG: Exit Code: 1
2022-11-24T20:40:03 DEBUG: Result:
2022-11-24T20:40:03 DEBUG: Command: 'rm -rf /var/lib/dhcp/*'
2022-11-24T20:40:03 DEBUG: Exit Code: 0
2022-11-24T20:40:03 DEBUG: Result:
2022-11-24T20:40:03 DEBUG: Check if command [hostnamectl] is available
2022-11-24T20:40:03 INFO: Check if hostnamectl is available
2022-11-24T20:40:03 DEBUG: Command: 'hostnamectl status 2>/tmp/guest.customization.stderr'
2022-11-24T20:40:03 DEBUG: Exit Code: 1
2022-11-24T20:40:03 DEBUG: Result:
2022-11-24T20:40:03 DEBUG: Stderr: Failed to connect to bus: No such file or directory
2022-11-24T20:40:04 INFO: Check if hostnamectl is available
2022-11-24T20:40:04 DEBUG: Command: 'hostnamectl status 2>/tmp/guest.customization.stderr'
2022-11-24T20:40:04 DEBUG: Exit Code: 1
2022-11-24T20:40:04 DEBUG: Result:
2022-11-24T20:40:04 DEBUG: Stderr: Failed to connect to bus: No such file or directory
2022-11-24T20:40:05 INFO: Check if hostnamectl is available
2022-11-24T20:40:05 DEBUG: Command: 'hostnamectl status 2>/tmp/guest.customization.stderr'
2022-11-24T20:40:05 DEBUG: Exit Code: 1
2022-11-24T20:40:05 DEBUG: Result:
2022-11-24T20:40:05 DEBUG: Stderr: Failed to connect to bus: No such file or directory
2022-11-24T20:40:06 INFO: Check if hostnamectl is available
2022-11-24T20:40:06 DEBUG: Command: 'hostnamectl status 2>/tmp/guest.customization.stderr'
2022-11-24T20:40:06 DEBUG: Exit Code: 1
2022-11-24T20:40:06 DEBUG: Result:
2022-11-24T20:40:06 DEBUG: Stderr: Failed to connect to bus: No such file or directory
2022-11-24T20:40:07 INFO: Check if hostnamectl is available
2022-11-24T20:40:07 DEBUG: Command: 'hostnamectl status 2>/tmp/guest.customization.stderr'
2022-11-24T20:40:07 DEBUG: Exit Code: 1
2022-11-24T20:40:07 DEBUG: Result:
2022-11-24T20:40:07 DEBUG: Stderr: Failed to connect to bus: No such file or directory
2022-11-24T20:40:08 INFO: Check if hostnamectl is available
2022-11-24T20:40:08 DEBUG: Command: 'hostnamectl status 2>/tmp/guest.customization.stderr'
2022-11-24T20:40:08 DEBUG: Exit Code: 1
2022-11-24T20:40:08 DEBUG: Result:
2022-11-24T20:40:08 DEBUG: Stderr: Failed to connect to bus: No such file or directory
2022-11-24T20:40:09 INFO: Check if hostnamectl is available
2022-11-24T20:40:09 DEBUG: Command: 'hostnamectl status 2>/tmp/guest.customization.stderr'
2022-11-24T20:40:09 DEBUG: Exit Code: 1
2022-11-24T20:40:09 DEBUG: Result:
2022-11-24T20:40:09 DEBUG: Stderr: Failed to connect to bus: No such file or directory
2022-11-24T20:40:10 INFO: Check if hostnamectl is available
2022-11-24T20:40:10 DEBUG: Command: 'hostnamectl status 2>/tmp/guest.customization.stderr'
2022-11-24T20:40:10 DEBUG: Exit Code: 1
2022-11-24T20:40:10 DEBUG: Result:
2022-11-24T20:40:10 DEBUG: Stderr: Failed to connect to bus: No such file or directory
2022-11-24T20:40:11 INFO: Check if hostnamectl is available
2022-11-24T20:40:11 DEBUG: Command: 'hostnamectl status 2>/tmp/guest.customization.stderr'
2022-11-24T20:40:11 DEBUG: Exit Code: 1
2022-11-24T20:40:11 DEBUG: Result:
2022-11-24T20:40:11 DEBUG: Stderr: Failed to connect to bus: No such file or directory
2022-11-24T20:40:12 INFO: Check if hostnamectl is available
2022-11-24T20:40:12 DEBUG: Command: 'hostnamectl status 2>/tmp/guest.customization.stderr'
2022-11-24T20:40:12 DEBUG: Exit Code: 1
2022-11-24T20:40:12 DEBUG: Result:
2022-11-24T20:40:12 DEBUG: Stderr: Failed to connect to bus: No such file or directory
2022-11-24T20:40:13 DEBUG: Host name is web1
2022-11-24T20:40:13 DEBUG: opening file for writing (/etc/hostname).
2022-11-24T20:40:13 DEBUG: Command: 'chmod 644 /etc/hostname'
2022-11-24T20:40:13 DEBUG: Exit Code: 0
2022-11-24T20:40:13 DEBUG: Result:
2022-11-24T20:40:13 INFO: Customizing NICS ...
2022-11-24T20:40:13 DEBUG: Command: '/bin/cp -f /etc/netplan/00-installer-config.yaml /etc/netplan/00-installer-config.yaml.BeforeVMwareCustomization'
2022-11-24T20:40:13 DEBUG: Exit Code: 0
2022-11-24T20:40:13 DEBUG: Result:
2022-11-24T20:40:13 INFO: Customizing NICS. { NIC1 }
2022-11-24T20:40:13 INFO: Customizing NIC NIC1
2022-11-24T20:40:13 DEBUG: Get interface name for MAC 00:50:56:ba:4c:92, via [ip addr show]
2022-11-24T20:40:13 DEBUG: Command: 'whereis ip'
2022-11-24T20:40:14 DEBUG: Exit Code: 0
2022-11-24T20:40:14 DEBUG: Result: ip: /usr/bin/ip /usr/sbin/ip /usr/share/man/man8/ip.8.gz /usr/share/man/man7/ip.7.gz
2022-11-24T20:40:14 DEBUG: Command: '/usr/bin/ip addr show 2>&1'
2022-11-24T20:40:14 DEBUG: Exit Code: 0
2022-11-24T20:40:14 DEBUG: Result: 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default qlen 1000
link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
inet 127.0.0.1/8 scope host lo
valid_lft forever preferred_lft forever
inet6 ::1/128 scope host
valid_lft forever preferred_lft forever
2: ens160: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc mq state DOWN group default qlen 1000
link/ether 00:50:56:ba:4c:92 brd ff:ff:ff:ff:ff:ff
altname enp3s0
2022-11-24T20:40:14 INFO: NIC suffix = ens160
2022-11-24T20:40:14 DEBUG: Checking if ens160 has static ip set in /etc/netplan/00-installer-config.yaml
2022-11-24T20:40:14 DEBUG: opening file /etc/netplan/00-installer-config.yaml.
2022-11-24T20:40:14 DEBUG: opening file for writing (/etc/netplan/00-installer-config.yaml).
2022-11-24T20:40:14 INFO: Get netplan version installed...
2022-11-24T20:40:14 DEBUG: Command: 'dpkg-query --show --showformat '${Version}' netplan.io'
2022-11-24T20:40:15 DEBUG: Exit Code: 0
2022-11-24T20:40:15 DEBUG: Result: 0.105-0ubuntu2~22.04.1
2022-11-24T20:40:15 INFO: Checking if netplan>0.95...
2022-11-24T20:40:15 DEBUG: Command: 'dpkg --compare-versions 0.105-0ubuntu2~22.04.1 ge 0.96'
2022-11-24T20:40:15 DEBUG: Exit Code: 0
2022-11-24T20:40:15 DEBUG: Result:
2022-11-24T20:40:15 DEBUG: netplan.io support DNSFROMDHCP, setting dns ipv4 override...
2022-11-24T20:40:15 DEBUG: netplan.io support DNSFROMDHCP, setting dns ipv6 override...
2022-11-24T20:40:15 INFO: Query config for ^(NIC1\|IPv6ADDR\|)
2022-11-24T20:40:15 INFO: Query config for ^(NIC1\|IPv6NETMASK\|)
2022-11-24T20:40:15 INFO: Query config for ^NIC1(\|IPv6GATEWAY\|)
2022-11-24T20:40:15 INFO: Query config for ^(DNS\|SUFFIX\|)
2022-11-24T20:40:15 INFO: Query config for ^(DNS\|NAMESERVER\|)
2022-11-24T20:40:15 DEBUG: opening file for writing (/etc/netplan/99-netcfg-vmware.yaml).
2022-11-24T20:40:15 DEBUG: Command: 'chmod 644 /etc/netplan/99-netcfg-vmware.yaml'
2022-11-24T20:40:15 DEBUG: Exit Code: 0
2022-11-24T20:40:15 DEBUG: Result:
2022-11-24T20:40:15 INFO: Apply Netplan Settings
2022-11-24T20:40:15 DEBUG: Command: '/usr/sbin/netplan apply 2>&1'
2022-11-24T20:40:17 DEBUG: Exit Code: 0
2022-11-24T20:40:17 DEBUG: Result: active
Failed to connect system bus: No such file or directory
Falling back to a hard restart of systemd-networkd.service
2022-11-24T20:40:17 INFO: Customizing Hosts file ...
2022-11-24T20:40:17 DEBUG: Old hostname=[web2]
2022-11-24T20:40:17 DEBUG: Old FQDN=[web2]
2022-11-24T20:40:17 DEBUG: New hostname=[web1]
2022-11-24T20:40:17 DEBUG: Building FQDN. HostnameFQDN: web1, Domainname: *geknipt domein*.nl
2022-11-24T20:40:17 DEBUG: New FQDN=[web1.*geknipt domein*.nl]
2022-11-24T20:40:17 DEBUG: opening file /etc/hosts.
2022-11-24T20:40:17 DEBUG: Line (inp): 127.0.0.1 localhost
2022-11-24T20:40:17 DEBUG: Line (inp): 127.0.1.1 web2
2022-11-24T20:40:17 DEBUG: Replacing [web2]
2022-11-24T20:40:17 DEBUG: Replacing [web2]
2022-11-24T20:40:17 DEBUG: Adding [web1.*domein geknipt*]
2022-11-24T20:40:17 DEBUG: Removing duplicating FQDNs
2022-11-24T20:40:17 DEBUG: Line (inp):
2022-11-24T20:40:17 DEBUG: Line (inp): # The following lines are desirable for IPv6 capable hosts
2022-11-24T20:40:17 DEBUG: Line (inp): ::1 ip6-localhost ip6-loopback
2022-11-24T20:40:17 DEBUG: Line (inp): fe00::0 ip6-localnet
2022-11-24T20:40:17 DEBUG: Line (inp): ff00::0 ip6-mcastprefix
2022-11-24T20:40:17 DEBUG: Line (inp): ff02::1 ip6-allnodes
2022-11-24T20:40:17 DEBUG: Line (inp): ff02::2 ip6-allrouters
2022-11-24T20:40:17 DEBUG: Line (out): 127.0.0.1 localhost
2022-11-24T20:40:17 DEBUG: Line (out): 127.0.1.1 web1.*domein geknipt* web1
2022-11-24T20:40:17 DEBUG: Line (out):
2022-11-24T20:40:17 DEBUG: Line (out): # The following lines are desirable for IPv6 capable hosts
2022-11-24T20:40:17 DEBUG: Line (out): ::1 ip6-localhost ip6-loopback
2022-11-24T20:40:17 DEBUG: Line (out): fe00::0 ip6-localnet
2022-11-24T20:40:17 DEBUG: Line (out): ff00::0 ip6-mcastprefix
2022-11-24T20:40:17 DEBUG: Line (out): ff02::1 ip6-allnodes
2022-11-24T20:40:17 DEBUG: Line (out): ff02::2 ip6-allrouters
2022-11-24T20:40:17 DEBUG: opening file for writing (/etc/hosts).
2022-11-24T20:40:17 DEBUG: Command: 'chmod 644 /etc/hosts'
2022-11-24T20:40:17 DEBUG: Exit Code: 0
2022-11-24T20:40:17 DEBUG: Result:
2022-11-24T20:40:17 INFO: Customizing DNS ...
2022-11-24T20:40:17 DEBUG: opening file /etc/nsswitch.conf.
2022-11-24T20:40:17 DEBUG: opening file for writing (/etc/nsswitch.conf).
2022-11-24T20:40:17 DEBUG: Command: 'chmod 644 /etc/nsswitch.conf'
2022-11-24T20:40:17 DEBUG: Exit Code: 0
2022-11-24T20:40:17 DEBUG: Result:
2022-11-24T20:40:17 INFO: Leave /etc/resolv.conf unchanged.
2022-11-24T20:40:17 INFO: Query config for ^(DNS\|SUFFIX\|)
2022-11-24T20:40:17 DEBUG: opening file for writing (/etc/dhcp/dhclient.conf).
2022-11-24T20:40:17 DEBUG: Command: 'chmod 644 /etc/dhcp/dhclient.conf'
2022-11-24T20:40:17 DEBUG: Exit Code: 0
2022-11-24T20:40:17 DEBUG: Result:
2022-11-24T20:40:17 DEBUG: opening file for writing (/etc/dhcp/dhclient.conf).
2022-11-24T20:40:17 DEBUG: Command: 'chmod 644 /etc/dhcp/dhclient.conf'
2022-11-24T20:40:17 DEBUG: Exit Code: 0
2022-11-24T20:40:17 DEBUG: Result:
2022-11-24T20:40:17 INFO: Customizing Date&Time ...
2022-11-24T20:40:17 DEBUG: Command: 'whereis hwclock'
2022-11-24T20:40:17 DEBUG: Exit Code: 0
2022-11-24T20:40:17 DEBUG: Result: hwclock: /usr/sbin/hwclock /usr/share/man/man8/hwclock.8.gz /usr/share/man/man5/hwclock.5.gz
2022-11-24T20:40:17 DEBUG: Command: '/usr/sbin/hwclock --systohc --utc'
2022-11-24T20:40:17 DEBUG: Exit Code: 0
2022-11-24T20:40:17 DEBUG: Result:
2022-11-24T20:40:17 INFO: Marker file exists or is undefined, password settings are not needed
2022-11-24T20:40:17 INFO: Marker file exists or is undefined, post-customization is not needed
2022-11-24T20:40:17 INFO: Marker creation is not needed
2022-11-24T20:40:17 INFO: Customization completed.
2022-11-24T20:40:17 DEBUG: Removing lock file /var/lock/vmware/gosc.
=================== Perl script log end =================
[2022-11-24T20:40:22.550Z] [ info] Wait before set enable-nics stats in vmx.
[2022-11-24T20:40:22.550Z] [ debug] Trying to connect network interfaces, attempt 1.
[2022-11-24T20:40:22.551Z] [ debug] Got VMX response 'queryNicsSupported'.
[2022-11-24T20:40:22.552Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:23.553Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:24.554Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:25.555Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:26.556Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:27.556Z] [ debug] Trying to connect network interfaces, attempt 2.
[2022-11-24T20:40:27.557Z] [ debug] Got VMX response 'queryNicsSupported'.
[2022-11-24T20:40:27.558Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:28.559Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:29.560Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:30.561Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:31.565Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:32.565Z] [ debug] Trying to connect network interfaces, attempt 3.
[2022-11-24T20:40:32.566Z] [ debug] Got VMX response 'queryNicsSupported'.
[2022-11-24T20:40:32.566Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:33.568Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:34.569Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:35.570Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:36.571Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:37.572Z] [ debug] Trying to connect network interfaces, attempt 4.
[2022-11-24T20:40:37.573Z] [ debug] Got VMX response 'queryNicsSupported'.
[2022-11-24T20:40:37.573Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:38.574Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:39.575Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:40.576Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:41.578Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:42.578Z] [ debug] Trying to connect network interfaces, attempt 5.
[2022-11-24T20:40:42.579Z] [ debug] Got VMX response 'queryNicsSupported'.
[2022-11-24T20:40:42.579Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:43.580Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:44.582Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:45.583Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:46.584Z] [ debug] Got VMX response 'disconnected'.
[2022-11-24T20:40:47.584Z] [ error] Can't connect network interfaces after 5 attempts, giving up.
[2022-11-24T20:40:47.585Z] [ info] Transitioning from state 'INPROGRESS' to state 'Done'.
[2022-11-24T20:40:47.585Z] [ info] ENTER STATE 'Done'.
[2022-11-24T20:40:47.585Z] [ info] EXIT STATE 'INPROGRESS'.
[2022-11-24T20:40:47.585Z] [ info] Deployment succeeded.
[2022-11-24T20:40:47.585Z] [ info] Launching cleanup.
[2022-11-24T20:40:47.585Z] [ debug] Command to exec : '/bin/rm'.
[2022-11-24T20:40:47.585Z] [ info] sizeof ProcessInternal is 56
[2022-11-24T20:40:47.586Z] [ info] Returning, pending output from stdout
[2022-11-24T20:40:47.586Z] [ info] Returning, pending output from stderr
[2022-11-24T20:40:47.686Z] [ info] Process exited normally after 0 seconds, returned 0
[2022-11-24T20:40:47.686Z] [ info] No more output from stdout
[2022-11-24T20:40:47.686Z] [ info] No more output from stderr
[2022-11-24T20:40:47.686Z] [ info] Customization command output:
''.
[2022-11-24T20:40:47.686Z] [ info] sSkipReboot: 'false', forceSkipReboot 'false'.
[2022-11-24T20:40:47.687Z] [ debug] Ran DeployPkg_DeployPackageFromFile successfully
[2022-11-24T20:40:47.687Z] [ debug] ## Closing log
[2022-11-24T20:40:47.687Z] [ debug] Command to exec : '/bin/readlink'.
[2022-11-24T20:40:47.687Z] [ info] sizeof ProcessInternal is 56
[2022-11-24T20:40:47.687Z] [ info] Returning, pending output from stdout
[2022-11-24T20:40:47.688Z] [ info] Returning, pending output from stderr
[2022-11-24T20:40:47.788Z] [ info] Process exited normally after 0 seconds, returned 0
[2022-11-24T20:40:47.788Z] [ info] Saving output from stdout
[2022-11-24T20:40:47.788Z] [ info] No more output from stdout
[2022-11-24T20:40:47.788Z] [ info] No more output from stderr
[2022-11-24T20:40:47.788Z] [ info] Customization command output:
'/bin/systemctl
'.
[2022-11-24T20:40:47.788Z] [ debug] /sbin/telinit is a soft link to systemctl
[2022-11-24T20:40:47.788Z] [ info] Trigger reboot.
[2022-11-24T20:40:47.788Z] [ debug] Command to exec : '/sbin/telinit'.
[2022-11-24T20:40:47.788Z] [ info] sizeof ProcessInternal is 56
[2022-11-24T20:40:47.788Z] [ info] Returning, pending output from stdout
[2022-11-24T20:40:47.788Z] [ info] Returning, pending output from stderr
[2022-11-24T20:40:47.893Z] [ info] Process exited normally after 0 seconds, returned 0
[2022-11-24T20:40:47.893Z] [ info] No more output from stdout
[2022-11-24T20:40:47.893Z] [ info] No more output from stderr
[2022-11-24T20:40:47.893Z] [ info] Customization command output:
''.
[2022-11-24T20:40:48.894Z] [ info] Rebooting.
[2022-11-24T20:40:48.894Z] [ debug] Command to exec : '/sbin/telinit'.
[2022-11-24T20:40:48.894Z] [ info] sizeof ProcessInternal is 56
[2022-11-24T20:40:48.894Z] [ info] Returning, pending output from stdout
[2022-11-24T20:40:48.894Z] [ info] Returning, pending output from stderr
[2022-11-24T20:40:48.994Z] [ info] Process exited normally after 0 seconds, returned 0
[2022-11-24T20:40:48.994Z] [ info] No more output from stdout
[2022-11-24T20:40:48.994Z] [ info] No more output from stderr
[2022-11-24T20:40:48.994Z] [ info] Customization command output:
''.
[2022-11-24T20:40:49.801Z] [ info] Rebooting.
[2022-11-24T20:40:49.801Z] [ debug] Command to exec : '/sbin/telinit'.
[2022-11-24T20:40:49.801Z] [ info] sizeof ProcessInternal is 56
[2022-11-24T20:40:49.802Z] [ info] Returning, pending output from stdout
[2022-11-24T20:40:49.802Z] [ info] Returning, pending output from stderr
[2022-11-24T20:40:49.902Z] [ info] Process exited normally after 0 seconds, returned 1
[2022-11-24T20:40:49.902Z] [ info] No more output from stdout
[2022-11-24T20:40:49.902Z] [ info] Saving output from stderr
[2022-11-24T20:40:49.902Z] [ info] No more output from stderr
[2022-11-24T20:40:49.902Z] [ info] Customization command output:
''.
[2022-11-24T20:40:49.902Z] [ info] Telinit command failed with exitcode: 1, stderr: 'Failed to connect to bus: Connection refused
Failed to open initctl fifo: No such device or address
Failed to talk to init daemon.
'.
[2022-11-24T20:40:50.902Z] [ info] Reboot has been triggered.
[2022-11-24T20:40:50.902Z] [ debug] Ran DeployPkg_DeployPackageFromFile successfully
[2022-11-24T20:40:50.902Z] [ debug] ## Closing log